Build: https://builds.apache.org/job/Lucene-Solr-Tests-7.x/572/
3 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.ZkControllerTest
Error Message:
ObjectTracker found 1 object(s) that were not released!!! [Overseer]
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException:
org.apache.solr.cloud.Overseer at
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.cloud.Overseer.start(Overseer.java:545) at
org.apache.solr.cloud.OverseerElectionContext.runLeaderProcess(ElectionContext.java:851)
at
org.apache.solr.cloud.LeaderElector.runIamLeaderProcess(LeaderElector.java:170)
at
org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:135)
at org.apache.solr.cloud.LeaderElector.joinElection(LeaderElector.java:307) at
org.apache.solr.cloud.LeaderElector.retryElection(LeaderElector.java:393) at
org.apache.solr.cloud.ZkController.rejoinOverseerElection(ZkController.java:2081)
at
org.apache.solr.cloud.Overseer$ClusterStateUpdater.checkIfIamStillLeader(Overseer.java:331)
at java.lang.Thread.run(Thread.java:748)
Stack Trace:
java.lang.AssertionError: ObjectTracker found 1 object(s) that were not
released!!! [Overseer]
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException:
org.apache.solr.cloud.Overseer
at
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.cloud.Overseer.start(Overseer.java:545)
at
org.apache.solr.cloud.OverseerElectionContext.runLeaderProcess(ElectionContext.java:851)
at
org.apache.solr.cloud.LeaderElector.runIamLeaderProcess(LeaderElector.java:170)
at
org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:135)
at
org.apache.solr.cloud.LeaderElector.joinElection(LeaderElector.java:307)
at
org.apache.solr.cloud.LeaderElector.retryElection(LeaderElector.java:393)
at
org.apache.solr.cloud.ZkController.rejoinOverseerElection(ZkController.java:2081)
at
org.apache.solr.cloud.Overseer$ClusterStateUpdater.checkIfIamStillLeader(Overseer.java:331)
at java.lang.Thread.run(Thread.java:748)
at __randomizedtesting.SeedInfo.seed([A4B187167D18FE3A]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertNull(Assert.java:551)
at
org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:303)
at sun.reflect.GeneratedMethodAccessor77.invoke(Unknown Source)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:897)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.ZkControllerTest
Error Message:
1 thread leaked from SUITE scope at org.apache.solr.cloud.ZkControllerTest:
1) Thread[id=16415,
name=OverseerAutoScalingTriggerThread-72482525492084738-127.0.0.1:8983_solr-n_0000000001,
state=RUNNABLE, group=Overseer autoscaling triggers] at
sun.reflect.Reflection.getCallerClass(Native Method) at
sun.reflect.GeneratedMethodAccessor1.invoke(Unknown Source) at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498) at
org.apache.logging.log4j.util.StackLocator.getCallerClass(StackLocator.java:110)
at
org.apache.logging.log4j.util.StackLocator.getCurrentStackTrace(StackLocator.java:169)
at
org.apache.logging.log4j.util.StackLocatorUtil.getCurrentStackTrace(StackLocatorUtil.java:67)
at
org.apache.logging.log4j.core.impl.ThrowableProxy.<init>(ThrowableProxy.java:137)
at
org.apache.logging.log4j.core.impl.ThrowableProxy.<init>(ThrowableProxy.java:122)
at
org.apache.logging.log4j.core.impl.Log4jLogEvent.getThrownProxy(Log4jLogEvent.java:605)
at
org.apache.logging.log4j.core.pattern.ExtendedThrowablePatternConverter.format(ExtendedThrowablePatternConverter.java:64)
at
org.apache.logging.log4j.core.pattern.PatternFormatter.format(PatternFormatter.java:38)
at
org.apache.logging.log4j.core.layout.PatternLayout$PatternSerializer.toSerializable(PatternLayout.java:334)
at
org.apache.logging.log4j.core.layout.PatternLayout.toText(PatternLayout.java:233)
at
org.apache.logging.log4j.core.layout.PatternLayout.encode(PatternLayout.java:218)
at
org.apache.logging.log4j.core.layout.PatternLayout.encode(PatternLayout.java:58)
at
org.apache.logging.log4j.core.appender.AbstractOutputStreamAppender.directEncodeEvent(AbstractOutputStreamAppender.java:177)
at
org.apache.logging.log4j.core.appender.AbstractOutputStreamAppender.tryAppend(AbstractOutputStreamAppender.java:170)
at
org.apache.logging.log4j.core.appender.AbstractOutputStreamAppender.append(AbstractOutputStreamAppender.java:161)
at
org.apache.logging.log4j.core.config.AppenderControl.tryCallAppender(AppenderControl.java:156)
at
org.apache.logging.log4j.core.config.AppenderControl.callAppender0(AppenderControl.java:129)
at
org.apache.logging.log4j.core.config.AppenderControl.callAppenderPreventRecursion(AppenderControl.java:120)
at
org.apache.logging.log4j.core.config.AppenderControl.callAppender(AppenderControl.java:84)
at
org.apache.logging.log4j.core.config.LoggerConfig.callAppenders(LoggerConfig.java:448)
at
org.apache.logging.log4j.core.config.LoggerConfig.processLogEvent(LoggerConfig.java:433)
at
org.apache.logging.log4j.core.config.LoggerConfig.log(LoggerConfig.java:417)
at
org.apache.logging.log4j.core.config.LoggerConfig.logParent(LoggerConfig.java:439)
at
org.apache.logging.log4j.core.config.LoggerConfig.processLogEvent(LoggerConfig.java:434)
at
org.apache.logging.log4j.core.config.LoggerConfig.log(LoggerConfig.java:417)
at
org.apache.logging.log4j.core.config.LoggerConfig.logParent(LoggerConfig.java:439)
at
org.apache.logging.log4j.core.config.LoggerConfig.processLogEvent(LoggerConfig.java:434)
at
org.apache.logging.log4j.core.config.LoggerConfig.log(LoggerConfig.java:417)
at
org.apache.logging.log4j.core.config.LoggerConfig.log(LoggerConfig.java:403)
at
org.apache.logging.log4j.core.config.DefaultReliabilityStrategy.log(DefaultReliabilityStrategy.java:49)
at org.apache.logging.log4j.core.Logger.logMessage(Logger.java:146)
at
org.apache.logging.log4j.spi.AbstractLogger.tryLogMessage(AbstractLogger.java:2170)
at
org.apache.logging.log4j.spi.AbstractLogger.logMessageTrackRecursion(AbstractLogger.java:2125)
at
org.apache.logging.log4j.spi.AbstractLogger.logMessageSafely(AbstractLogger.java:2108)
at
org.apache.logging.log4j.spi.AbstractLogger.logMessage(AbstractLogger.java:2002)
at
org.apache.logging.log4j.spi.AbstractLogger.logIfEnabled(AbstractLogger.java:1974)
at org.apache.logging.slf4j.Log4jLogger.error(Log4jLogger.java:319)
at
org.apache.solr.cloud.autoscaling.OverseerTriggerThread.run(OverseerTriggerThread.java:146)
at java.lang.Thread.run(Thread.java:748)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE
scope at org.apache.solr.cloud.ZkControllerTest:
1) Thread[id=16415,
name=OverseerAutoScalingTriggerThread-72482525492084738-127.0.0.1:8983_solr-n_0000000001,
state=RUNNABLE, group=Overseer autoscaling triggers]
at sun.reflect.Reflection.getCallerClass(Native Method)
at sun.reflect.GeneratedMethodAccessor1.invoke(Unknown Source)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
org.apache.logging.log4j.util.StackLocator.getCallerClass(StackLocator.java:110)
at
org.apache.logging.log4j.util.StackLocator.getCurrentStackTrace(StackLocator.java:169)
at
org.apache.logging.log4j.util.StackLocatorUtil.getCurrentStackTrace(StackLocatorUtil.java:67)
at
org.apache.logging.log4j.core.impl.ThrowableProxy.<init>(ThrowableProxy.java:137)
at
org.apache.logging.log4j.core.impl.ThrowableProxy.<init>(ThrowableProxy.java:122)
at
org.apache.logging.log4j.core.impl.Log4jLogEvent.getThrownProxy(Log4jLogEvent.java:605)
at
org.apache.logging.log4j.core.pattern.ExtendedThrowablePatternConverter.format(ExtendedThrowablePatternConverter.java:64)
at
org.apache.logging.log4j.core.pattern.PatternFormatter.format(PatternFormatter.java:38)
at
org.apache.logging.log4j.core.layout.PatternLayout$PatternSerializer.toSerializable(PatternLayout.java:334)
at
org.apache.logging.log4j.core.layout.PatternLayout.toText(PatternLayout.java:233)
at
org.apache.logging.log4j.core.layout.PatternLayout.encode(PatternLayout.java:218)
at
org.apache.logging.log4j.core.layout.PatternLayout.encode(PatternLayout.java:58)
at
org.apache.logging.log4j.core.appender.AbstractOutputStreamAppender.directEncodeEvent(AbstractOutputStreamAppender.java:177)
at
org.apache.logging.log4j.core.appender.AbstractOutputStreamAppender.tryAppend(AbstractOutputStreamAppender.java:170)
at
org.apache.logging.log4j.core.appender.AbstractOutputStreamAppender.append(AbstractOutputStreamAppender.java:161)
at
org.apache.logging.log4j.core.config.AppenderControl.tryCallAppender(AppenderControl.java:156)
at
org.apache.logging.log4j.core.config.AppenderControl.callAppender0(AppenderControl.java:129)
at
org.apache.logging.log4j.core.config.AppenderControl.callAppenderPreventRecursion(AppenderControl.java:120)
at
org.apache.logging.log4j.core.config.AppenderControl.callAppender(AppenderControl.java:84)
at
org.apache.logging.log4j.core.config.LoggerConfig.callAppenders(LoggerConfig.java:448)
at
org.apache.logging.log4j.core.config.LoggerConfig.processLogEvent(LoggerConfig.java:433)
at
org.apache.logging.log4j.core.config.LoggerConfig.log(LoggerConfig.java:417)
at
org.apache.logging.log4j.core.config.LoggerConfig.logParent(LoggerConfig.java:439)
at
org.apache.logging.log4j.core.config.LoggerConfig.processLogEvent(LoggerConfig.java:434)
at
org.apache.logging.log4j.core.config.LoggerConfig.log(LoggerConfig.java:417)
at
org.apache.logging.log4j.core.config.LoggerConfig.logParent(LoggerConfig.java:439)
at
org.apache.logging.log4j.core.config.LoggerConfig.processLogEvent(LoggerConfig.java:434)
at
org.apache.logging.log4j.core.config.LoggerConfig.log(LoggerConfig.java:417)
at
org.apache.logging.log4j.core.config.LoggerConfig.log(LoggerConfig.java:403)
at
org.apache.logging.log4j.core.config.DefaultReliabilityStrategy.log(DefaultReliabilityStrategy.java:49)
at org.apache.logging.log4j.core.Logger.logMessage(Logger.java:146)
at
org.apache.logging.log4j.spi.AbstractLogger.tryLogMessage(AbstractLogger.java:2170)
at
org.apache.logging.log4j.spi.AbstractLogger.logMessageTrackRecursion(AbstractLogger.java:2125)
at
org.apache.logging.log4j.spi.AbstractLogger.logMessageSafely(AbstractLogger.java:2108)
at
org.apache.logging.log4j.spi.AbstractLogger.logMessage(AbstractLogger.java:2002)
at
org.apache.logging.log4j.spi.AbstractLogger.logIfEnabled(AbstractLogger.java:1974)
at org.apache.logging.slf4j.Log4jLogger.error(Log4jLogger.java:319)
at
org.apache.solr.cloud.autoscaling.OverseerTriggerThread.run(OverseerTriggerThread.java:146)
at java.lang.Thread.run(Thread.java:748)
at __randomizedtesting.SeedInfo.seed([A4B187167D18FE3A]:0)
FAILED:
org.apache.solr.cloud.api.collections.CustomCollectionTest.testCustomCollectionsAPI
Error Message:
Error from server at http://127.0.0.1:37243/solr: KeeperErrorCode = Session
expired for /configs/conf
Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error
from server at http://127.0.0.1:37243/solr: KeeperErrorCode = Session expired
for /configs/conf
at
__randomizedtesting.SeedInfo.seed([A4B187167D18FE3A:CE50097D40824842]:0)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:643)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:483)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:413)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1106)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:886)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:819)
at
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194)
at
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:211)
at
org.apache.solr.cloud.api.collections.CustomCollectionTest.testCustomCollectionsAPI(CustomCollectionTest.java:67)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 12596 lines...]
[junit4] Suite: org.apache.solr.cloud.api.collections.CustomCollectionTest
[junit4] 2> 641805 INFO
(SUITE-CustomCollectionTest-seed#[A4B187167D18FE3A]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J2/temp/solr.cloud.api.collections.CustomCollectionTest_A4B187167D18FE3A-001/init-core-data-001
[junit4] 2> 641818 WARN
(SUITE-CustomCollectionTest-seed#[A4B187167D18FE3A]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
[junit4] 2> 641818 INFO
(SUITE-CustomCollectionTest-seed#[A4B187167D18FE3A]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 641820 INFO
(SUITE-CustomCollectionTest-seed#[A4B187167D18FE3A]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 641820 INFO
(SUITE-CustomCollectionTest-seed#[A4B187167D18FE3A]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J2/temp/solr.cloud.api.collections.CustomCollectionTest_A4B187167D18FE3A-001/tempDir-001
[junit4] 2> 641820 INFO
(SUITE-CustomCollectionTest-seed#[A4B187167D18FE3A]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 641838 INFO (Thread-822) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 641838 INFO (Thread-822) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 641846 ERROR (Thread-822) [ ] o.a.z.s.ZooKeeperServer
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action
on ERROR or SHUTDOWN server state changes
[junit4] 2> 641938 INFO
(SUITE-CustomCollectionTest-seed#[A4B187167D18FE3A]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:35704
[junit4] 2> 641941 INFO (zkConnectionManagerCallback-464-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 641944 INFO (jetty-launcher-461-thread-1) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 29-11-21T22:27:37+01:00,
git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 641945 INFO (jetty-launcher-461-thread-3) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 29-11-21T22:27:37+01:00,
git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 641946 INFO (jetty-launcher-461-thread-4) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 29-11-21T22:27:37+01:00,
git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 641947 INFO (jetty-launcher-461-thread-3) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 641947 INFO (jetty-launcher-461-thread-3) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 641947 INFO (jetty-launcher-461-thread-3) [ ]
o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 641947 INFO (jetty-launcher-461-thread-3) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@7bf1de63{/solr,null,AVAILABLE}
[junit4] 2> 641947 INFO (jetty-launcher-461-thread-3) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@6f2821e3{HTTP/1.1,[http/1.1]}{127.0.0.1:40075}
[junit4] 2> 641947 INFO (jetty-launcher-461-thread-3) [ ]
o.e.j.s.Server Started @642078ms
[junit4] 2> 641948 INFO (jetty-launcher-461-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=40075}
[junit4] 2> 641948 ERROR (jetty-launcher-461-thread-3) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 641948 INFO (jetty-launcher-461-thread-3) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 641948 INFO (jetty-launcher-461-thread-3) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.4.0
[junit4] 2> 641948 INFO (jetty-launcher-461-thread-3) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 641948 INFO (jetty-launcher-461-thread-3) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 641948 INFO (jetty-launcher-461-thread-3) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-04-19T13:25:36.493Z
[junit4] 2> 641969 INFO (zkConnectionManagerCallback-466-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 641969 INFO (jetty-launcher-461-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 641969 INFO (jetty-launcher-461-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 641969 INFO (jetty-launcher-461-thread-1) [ ]
o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 641969 INFO (jetty-launcher-461-thread-3) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 641970 INFO (jetty-launcher-461-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@18dea457{/solr,null,AVAILABLE}
[junit4] 2> 641970 INFO (jetty-launcher-461-thread-1) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@6a885f3a{HTTP/1.1,[http/1.1]}{127.0.0.1:37243}
[junit4] 2> 641970 INFO (jetty-launcher-461-thread-1) [ ]
o.e.j.s.Server Started @642100ms
[junit4] 2> 641970 INFO (jetty-launcher-461-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=37243}
[junit4] 2> 641970 ERROR (jetty-launcher-461-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 641970 INFO (jetty-launcher-461-thread-1) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 641970 INFO (jetty-launcher-461-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.4.0
[junit4] 2> 641970 INFO (jetty-launcher-461-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 641970 INFO (jetty-launcher-461-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 641971 INFO (jetty-launcher-461-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-04-19T13:25:36.516Z
[junit4] 2> 641972 INFO (jetty-launcher-461-thread-4) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 641988 INFO (jetty-launcher-461-thread-2) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 29-11-21T22:27:37+01:00,
git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 641988 INFO (jetty-launcher-461-thread-4) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 641988 INFO (jetty-launcher-461-thread-4) [ ]
o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 642037 INFO (jetty-launcher-461-thread-4) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@1faf40be{/solr,null,AVAILABLE}
[junit4] 2> 642058 INFO (zkConnectionManagerCallback-468-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 642058 INFO (jetty-launcher-461-thread-4) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@312a173c{HTTP/1.1,[http/1.1]}{127.0.0.1:36643}
[junit4] 2> 642058 INFO (jetty-launcher-461-thread-4) [ ]
o.e.j.s.Server Started @642188ms
[junit4] 2> 642058 INFO (jetty-launcher-461-thread-4) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=36643}
[junit4] 2> 642058 INFO (jetty-launcher-461-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 642058 ERROR (jetty-launcher-461-thread-4) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 642058 INFO (jetty-launcher-461-thread-4) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 642058 INFO (jetty-launcher-461-thread-4) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.4.0
[junit4] 2> 642058 INFO (jetty-launcher-461-thread-4) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 642059 INFO (jetty-launcher-461-thread-4) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 642059 INFO (jetty-launcher-461-thread-4) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-04-19T13:25:36.604Z
[junit4] 2> 642082 INFO (jetty-launcher-461-thread-2) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 642082 INFO (jetty-launcher-461-thread-2) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 642082 INFO (jetty-launcher-461-thread-2) [ ]
o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 642083 INFO (jetty-launcher-461-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@29e00001{/solr,null,AVAILABLE}
[junit4] 2> 642083 INFO (jetty-launcher-461-thread-2) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@3b7d89ad{HTTP/1.1,[http/1.1]}{127.0.0.1:43128}
[junit4] 2> 642083 INFO (jetty-launcher-461-thread-2) [ ]
o.e.j.s.Server Started @642213ms
[junit4] 2> 642083 INFO (jetty-launcher-461-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=43128}
[junit4] 2> 642084 ERROR (jetty-launcher-461-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 642084 INFO (jetty-launcher-461-thread-2) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 642084 INFO (jetty-launcher-461-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.4.0
[junit4] 2> 642084 INFO (jetty-launcher-461-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 642084 INFO (jetty-launcher-461-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 642084 INFO (jetty-launcher-461-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-04-19T13:25:36.629Z
[junit4] 2> 642085 INFO (jetty-launcher-461-thread-3) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35704/solr
[junit4] 2> 642124 INFO (jetty-launcher-461-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35704/solr
[junit4] 2> 642125 INFO (zkConnectionManagerCallback-473-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 642135 INFO (zkConnectionManagerCallback-480-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 642179 INFO (zkConnectionManagerCallback-470-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 642181 INFO (jetty-launcher-461-thread-4) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 642200 INFO (jetty-launcher-461-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 642203 INFO (zkConnectionManagerCallback-482-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 642207 INFO (zkConnectionManagerCallback-476-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 642275 INFO (jetty-launcher-461-thread-4) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35704/solr
[junit4] 2> 642289 INFO (zkConnectionManagerCallback-484-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 642308 INFO (zkConnectionManagerCallback-488-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 642323 INFO (jetty-launcher-461-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35704/solr
[junit4] 2> 642342 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid
0x101825776690009, likely client has closed socket
[junit4] 2> 642383 INFO (zkConnectionManagerCallback-498-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 642383 INFO (zkConnectionManagerCallback-496-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 642395 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid
0x10182577669000b, likely client has closed socket
[junit4] 2> 642416 INFO (zkConnectionManagerCallback-500-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 642513 INFO (jetty-launcher-461-thread-2)
[n:127.0.0.1:43128_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 642514 INFO (jetty-launcher-461-thread-2)
[n:127.0.0.1:43128_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:43128_solr
[junit4] 2> 642514 INFO (jetty-launcher-461-thread-4)
[n:127.0.0.1:36643_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 642526 INFO (jetty-launcher-461-thread-2)
[n:127.0.0.1:43128_solr ] o.a.s.c.Overseer Overseer
(id=72482381174997004-127.0.0.1:43128_solr-n_0000000000) starting
[junit4] 2> 642527 INFO (jetty-launcher-461-thread-4)
[n:127.0.0.1:36643_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:36643_solr
[junit4] 2> 642594 INFO (zkCallback-495-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 642594 INFO (zkCallback-499-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 642641 INFO (zkConnectionManagerCallback-509-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 642654 INFO (jetty-launcher-461-thread-2)
[n:127.0.0.1:43128_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 642655 INFO (jetty-launcher-461-thread-2)
[n:127.0.0.1:43128_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:35704/solr ready
[junit4] 2> 642678 INFO (jetty-launcher-461-thread-2)
[n:127.0.0.1:43128_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 642678 INFO (jetty-launcher-461-thread-2)
[n:127.0.0.1:43128_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:43128_solr
[junit4] 2> 642708 INFO (zkCallback-499-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 642708 INFO (zkCallback-495-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 642752 INFO (zkCallback-508-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 643000 INFO (jetty-launcher-461-thread-1)
[n:127.0.0.1:37243_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 643001 INFO (jetty-launcher-461-thread-3)
[n:127.0.0.1:40075_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 643002 INFO (jetty-launcher-461-thread-1)
[n:127.0.0.1:37243_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 643003 INFO (jetty-launcher-461-thread-3)
[n:127.0.0.1:40075_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 643023 INFO (jetty-launcher-461-thread-1)
[n:127.0.0.1:37243_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 643023 INFO (jetty-launcher-461-thread-1)
[n:127.0.0.1:37243_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:37243_solr
[junit4] 2> 643051 INFO (zkCallback-495-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 643051 INFO (jetty-launcher-461-thread-3)
[n:127.0.0.1:40075_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 643051 INFO (jetty-launcher-461-thread-3)
[n:127.0.0.1:40075_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:40075_solr
[junit4] 2> 643065 INFO (zkCallback-495-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 643065 INFO (zkCallback-508-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (4)
[junit4] 2> 643138 INFO (zkCallback-481-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (4)
[junit4] 2> 643178 INFO (zkCallback-499-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (4)
[junit4] 2> 643293 INFO (zkCallback-483-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (4)
[junit4] 2> 644045 INFO (jetty-launcher-461-thread-1)
[n:127.0.0.1:37243_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37243.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5ad4474f
[junit4] 2> 644068 INFO (jetty-launcher-461-thread-1)
[n:127.0.0.1:37243_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37243.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5ad4474f
[junit4] 2> 644080 INFO (jetty-launcher-461-thread-1)
[n:127.0.0.1:37243_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37243.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5ad4474f
[junit4] 2> 644081 INFO (jetty-launcher-461-thread-1)
[n:127.0.0.1:37243_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J2/temp/solr.cloud.api.collections.CustomCollectionTest_A4B187167D18FE3A-001/tempDir-001/node1/.
[junit4] 2> 644189 INFO (zkConnectionManagerCallback-514-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 644211 INFO (jetty-launcher-461-thread-1)
[n:127.0.0.1:37243_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 644212 INFO (jetty-launcher-461-thread-1)
[n:127.0.0.1:37243_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:35704/solr ready
[junit4] 2> 644228 INFO (jetty-launcher-461-thread-2)
[n:127.0.0.1:43128_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_43128.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5ad4474f
[junit4] 2> 644233 INFO (jetty-launcher-461-thread-4)
[n:127.0.0.1:36643_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36643.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5ad4474f
[junit4] 2> 644272 INFO (jetty-launcher-461-thread-3)
[n:127.0.0.1:40075_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_40075.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5ad4474f
[junit4] 2> 644331 INFO (jetty-launcher-461-thread-2)
[n:127.0.0.1:43128_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_43128.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5ad4474f
[junit4] 2> 644331 INFO (jetty-launcher-461-thread-2)
[n:127.0.0.1:43128_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_43128.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5ad4474f
[junit4] 2> 644343 INFO (jetty-launcher-461-thread-3)
[n:127.0.0.1:40075_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_40075.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5ad4474f
[junit4] 2> 644343 INFO (jetty-launcher-461-thread-3)
[n:127.0.0.1:40075_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_40075.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5ad4474f
[junit4] 2> 644351 INFO (jetty-launcher-461-thread-4)
[n:127.0.0.1:36643_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36643.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5ad4474f
[junit4] 2> 644351 INFO (jetty-launcher-461-thread-4)
[n:127.0.0.1:36643_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36643.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5ad4474f
[junit4] 2> 644352 INFO (jetty-launcher-461-thread-4)
[n:127.0.0.1:36643_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J2/temp/solr.cloud.api.collections.CustomCollectionTest_A4B187167D18FE3A-001/tempDir-001/node4/.
[junit4] 2> 644352 INFO (jetty-launcher-461-thread-2)
[n:127.0.0.1:43128_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J2/temp/solr.cloud.api.collections.CustomCollectionTest_A4B187167D18FE3A-001/tempDir-001/node2/.
[junit4] 2> 644378 INFO (jetty-launcher-461-thread-3)
[n:127.0.0.1:40075_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J2/temp/solr.cloud.api.collections.CustomCollectionTest_A4B187167D18FE3A-001/tempDir-001/node3/.
[junit4] 2> 644410 INFO (zkConnectionManagerCallback-519-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 644411 INFO (jetty-launcher-461-thread-4)
[n:127.0.0.1:36643_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 644412 INFO (jetty-launcher-461-thread-4)
[n:127.0.0.1:36643_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:35704/solr ready
[junit4] 2> 644430 INFO (zkConnectionManagerCallback-524-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 644431 INFO (jetty-launcher-461-thread-3)
[n:127.0.0.1:40075_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 644432 INFO (jetty-launcher-461-thread-3)
[n:127.0.0.1:40075_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:35704/solr ready
[junit4] 2> 644609 INFO (zkConnectionManagerCallback-526-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 644624 INFO (zkConnectionManagerCallback-531-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 644625 INFO
(SUITE-CustomCollectionTest-seed#[A4B187167D18FE3A]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 644626 INFO
(SUITE-CustomCollectionTest-seed#[A4B187167D18FE3A]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:35704/solr ready
[junit4] 2> 644698 INFO
(TEST-CustomCollectionTest.testCreateShardRepFactor-seed#[A4B187167D18FE3A]) [
] o.a.s.SolrTestCaseJ4 ###Starting testCreateShardRepFactor
[junit4] 2> 644699 INFO
(TEST-CustomCollectionTest.testCreateShardRepFactor-seed#[A4B187167D18FE3A]) [
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 644703 INFO (qtp2051432336-2207) [n:127.0.0.1:37243_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
shards=a,b&replicationFactor=1&collection.configName=conf&name=testCreateShardRepFactor&router.name=implicit&nrtReplicas=1&action=CREATE&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 644705 INFO (OverseerThreadFactory-653-thread-1) [ ]
o.a.s.c.a.c.CreateCollectionCmd Create collection testCreateShardRepFactor
[junit4] 2> 644844 INFO
(OverseerStateUpdate-72482381174997004-127.0.0.1:43128_solr-n_0000000000) [
] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testCreateShardRepFactor",
[junit4] 2> "shard":"a",
[junit4] 2> "core":"testCreateShardRepFactor_a_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:37243/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 644846 INFO
(OverseerStateUpdate-72482381174997004-127.0.0.1:43128_solr-n_0000000000) [
] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testCreateShardRepFactor",
[junit4] 2> "shard":"b",
[junit4] 2> "core":"testCreateShardRepFactor_b_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:36643/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 645051 INFO (qtp2051432336-2229) [n:127.0.0.1:37243_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=testCreateShardRepFactor_a_replica_n1&action=CREATE&numShards=2&collection=testCreateShardRepFactor&shard=a&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 645053 INFO (qtp249479759-2221) [n:127.0.0.1:36643_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=testCreateShardRepFactor_b_replica_n2&action=CREATE&numShards=2&collection=testCreateShardRepFactor&shard=b&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 645053 INFO (qtp249479759-2221) [n:127.0.0.1:36643_solr ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 646094 INFO (qtp249479759-2221) [n:127.0.0.1:36643_solr
c:testCreateShardRepFactor s:b r:core_node4
x:testCreateShardRepFactor_b_replica_n2] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 7.4.0
[junit4] 2> 646102 INFO (qtp2051432336-2229) [n:127.0.0.1:37243_solr
c:testCreateShardRepFactor s:a r:core_node3
x:testCreateShardRepFactor_a_replica_n1] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 7.4.0
[junit4] 2> 646139 INFO (qtp249479759-2221) [n:127.0.0.1:36643_solr
c:testCreateShardRepFactor s:b r:core_node4
x:testCreateShardRepFactor_b_replica_n2] o.a.s.s.IndexSchema
[testCreateShardRepFactor_b_replica_n2] Schema name=cloud-dynamic
[junit4] 2> 646139 INFO (qtp2051432336-2229) [n:127.0.0.1:37243_solr
c:testCreateShardRepFactor s:a r:core_node3
x:testCreateShardRepFactor_a_replica_n1] o.a.s.s.IndexSchema
[testCreateShardRepFactor_a_replica_n1] Schema name=cloud-dynamic
[junit4] 2> 646214 INFO (qtp249479759-2221) [n:127.0.0.1:36643_solr
c:testCreateShardRepFactor s:b r:core_node4
x:testCreateShardRepFactor_b_replica_n2] o.a.s.s.IndexSchema Loaded schema
cloud-dynamic/1.6 with uniqueid field id
[junit4] 2> 646214 INFO (qtp249479759-2221) [n:127.0.0.1:36643_solr
c:testCreateShardRepFactor s:b r:core_node4
x:testCreateShardRepFactor_b_replica_n2] o.a.s.c.CoreContainer Creating
SolrCore 'testCreateShardRepFactor_b_replica_n2' using configuration from
collection testCreateShardRepFactor, trusted=true
[junit4] 2> 646214 INFO (qtp249479759-2221) [n:127.0.0.1:36643_solr
c:testCreateShardRepFactor s:b r:core_node4
x:testCreateShardRepFactor_b_replica_n2] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_36643.solr.core.testCreateShardRepFactor.b.replica_n2'
(registry 'solr.core.testCreateShardRepFactor.b.replica_n2') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5ad4474f
[junit4] 2> 646214 INFO (qtp249479759-2221) [n:127.0.0.1:36643_solr
c:testCreateShardRepFactor s:b r:core_node4
x:testCreateShardRepFactor_b_replica_n2] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 646215 INFO (qtp249479759-2221) [n:127.0.0.1:36643_solr
c:testCreateShardRepFactor s:b r:core_node4
x:testCreateShardRepFactor_b_replica_n2] o.a.s.c.SolrCore
[[testCreateShardRepFactor_b_replica_n2] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J2/temp/solr.cloud.api.collections.CustomCollectionTest_A4B187167D18FE3A-001/tempDir-001/node4/testCreateShardRepFactor_b_replica_n2],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J2/temp/solr.cloud.api.collections.CustomCollectionTest_A4B187167D18FE3A-001/tempDir-001/node4/./testCreateShardRepFactor_b_replica_n2/data/]
[junit4] 2> 646233 INFO (qtp2051432336-2229) [n:127.0.0.1:37243_solr
c:testCreateShardRepFactor s:a r:core_node3
x:testCreateShardRepFactor_a_replica_n1] o.a.s.s.IndexSchema Loaded schema
cloud-dynamic/1.6 with uniqueid field id
[junit4] 2> 646233 INFO (qtp2051432336-2229) [n:127.0.0.1:37243_solr
c:testCreateShardRepFactor s:a r:core_node3
x:testCreateShardRepFactor_a_replica_n1] o.a.s.c.CoreContainer Creating
SolrCore 'testCreateShardRepFactor_a_replica_n1' using configuration from
collection testCreateShardRepFactor, trusted=true
[junit4] 2> 646249 INFO (qtp2051432336-2229) [n:127.0.0.1:37243_solr
c:testCreateShardRepFactor s:a r:core_node3
x:testCreateShardRepFactor_a_replica_n1] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_37243.solr.core.testCreateShardRepFactor.a.replica_n1'
(registry 'solr.core.testCreateShardRepFactor.a.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5ad4474f
[junit4] 2> 646250 INFO (qtp2051432336-2229) [n:127.0.0.1:37243_solr
c:testCreateShardRepFactor s:a r:core_node3
x:testCreateShardRepFactor_a_replica_n1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 646250 INFO (qtp2051432336-2229) [n:127.0.0.1:37243_solr
c:testCreateShardRepFactor s:a r:core_node3
x:testCreateShardRepFactor_a_replica_n1] o.a.s.c.SolrCore
[[testCreateShardRepFactor_a_replica_n1] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J2/temp/solr.cloud.api.collections.CustomCollectionTest_A4B187167D18FE3A-001/tempDir-001/node1/testCreateShardRepFactor_a_replica_n1],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J2/temp/solr.cloud.api.collections.CustomCollectionTest_A4B187167D18FE3A-001/tempDir-001/node1/./testCreateShardRepFactor_a_replica_n1/data/]
[junit4] 2> 646417 INFO (qtp2051432336-2229) [n:127.0.0.1:37243_solr
c:testCreateShardRepFactor s:a r:core_node3
x:testCreateShardRepFactor_a_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog
implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 646418 INFO (qtp2051432336-2229) [n:127.0.0.1:37243_solr
c:testCreateShardRepFactor s:a r:core_node3
x:testCreateShardRepFactor_a_replica_n1] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 646419 INFO (qtp2051432336-2229) [n:127.0.0.1:37243_solr
c:testCreateShardRepFactor s:a r:core_node3
x:testCreateShardRepFactor_a_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit:
disabled
[junit4] 2> 646419 INFO (qtp2051432336-2229) [n:127.0.0.1:37243_solr
c:testCreateShardRepFactor s:a r:core_node3
x:testCreateShardRepFactor_a_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit:
disabled
[junit4] 2> 646432 INFO (qtp249479759-2221) [n:127.0.0.1:36643_solr
c:testCreateShardRepFactor s:b r:core_node4
x:testCreateShardRepFactor_b_replica_n2] o.a.s.u.UpdateHandler Using UpdateLog
implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 646432 INFO (qtp249479759-2221) [n:127.0.0.1:36643_solr
c:testCreateShardRepFactor s:b r:core_node4
x:testCreateShardRepFactor_b_replica_n2] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 646433 INFO (qtp2051432336-2229) [n:127.0.0.1:37243_solr
c:testCreateShardRepFactor s:a r:core_node3
x:testCreateShardRepFactor_a_replica_n1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@4cfb007c[testCreateShardRepFactor_a_replica_n1] main]
[junit4] 2> 646433 INFO (qtp249479759-2221) [n:127.0.0.1:36643_solr
c:testCreateShardRepFactor s:b r:core_node4
x:testCreateShardRepFactor_b_replica_n2] o.a.s.u.CommitTracker Hard AutoCommit:
disabled
[junit4] 2> 646433 INFO (qtp249479759-2221) [n:127.0.0.1:36643_solr
c:testCreateShardRepFactor s:b r:core_node4
x:testCreateShardRepFactor_b_replica_n2] o.a.s.u.CommitTracker Soft AutoCommit:
disabled
[junit4] 2> 646434 INFO (qtp2051432336-2229) [n:127.0.0.1:37243_solr
c:testCreateShardRepFactor s:a r:core_node3
x:testCreateShardRepFactor_a_replica_n1] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 646434 INFO (qtp2051432336-2229) [n:127.0.0.1:37243_solr
c:testCreateShardRepFactor s:a r:core_node3
x:testCreateShardRepFactor_a_replica_n1] o.a.s.r.ManagedResourceStorage Loaded
null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 646435 INFO (qtp249479759-2221) [n:127.0.0.1:36643_solr
c:testCreateShardRepFactor s:b r:core_node4
x:testCreateShardRepFactor_b_replica_n2] o.a.s.s.SolrIndexSearcher Opening
[Searcher@16947c91[testCreateShardRepFactor_b_replica_n2] main]
[junit4] 2> 646435 INFO (qtp2051432336-2229) [n:127.0.0.1:37243_solr
c:testCreateShardRepFactor s:a r:core_node3
x:testCreateShardRepFactor_a_replica_n1] o.a.s.h.ReplicationHandler Commits
will be reserved for 10000ms.
[junit4] 2> 646474 INFO (qtp249479759-2221) [n:127.0.0.1:36643_solr
c:testCreateShardRepFactor s:b r:core_node4
x:testCreateShardRepFactor_b_replica_n2] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 646474 INFO
(searcherExecutor-663-thread-1-processing-n:127.0.0.1:37243_solr
x:testCreateShardRepFactor_a_replica_n1 c:testCreateShardRepFactor s:a
r:core_node3) [n:127.0.0.1:37243_solr c:testCreateShardRepFactor s:a
r:core_node3 x:testCreateShardRepFactor_a_replica_n1] o.a.s.c.SolrCore
[testCreateShardRepFactor_a_replica_n1] Registered new searcher
Searcher@4cfb007c[testCreateShardRepFactor_a_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 646474 INFO (qtp2051432336-2229) [n:127.0.0.1:37243_solr
c:testCreateShardRepFactor s:a r:core_node3
x:testCreateShardRepFactor_a_replica_n1] o.a.s.u.UpdateLog Could not find max
version in index or recent updates, using new clock 1598181176528338944
[junit4] 2> 646474 INFO (qtp249479759-2221) [n:127.0.0.1:36643_solr
c:testCreateShardRepFactor s:b r:core_node4
x:testCreateShardRepFactor_b_replica_n2] o.a.s.r.ManagedResourceStorage Loaded
null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 646475 INFO (qtp249479759-2221) [n:127.0.0.1:36643_solr
c:testCreateShardRepFactor s:b r:core_node4
x:testCreateShardRepFactor_b_replica_n2] o.a.s.h.ReplicationHandler Commits
will be reserved for 10000ms.
[junit4] 2> 646476 INFO
(searcherExecutor-662-thread-1-processing-n:127.0.0.1:36643_solr
x:testCreateShardRepFactor_b_replica_n2 c:testCreateShardRepFactor s:b
r:core_node4) [n:127.0.0.1:36643_solr c:testCreateShardRepFactor s:b
r:core_node4 x:testCreateShardRepFactor_b_replica_n2] o.a.s.c.SolrCore
[testCreateShardRepFactor_b_replica_n2] Registered new searcher
Searcher@16947c91[testCreateShardRepFactor_b_replica_n2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 646476 INFO (qtp249479759-2221) [n:127.0.0.1:36643_solr
c:testCreateShardRepFactor s:b r:core_node4
x:testCreateShardRepFactor_b_replica_n2] o.a.s.u.UpdateLog Could not find max
version in index or recent updates, using new clock 1598181176530436096
[junit4] 2> 646504 INFO (qtp2051432336-2229) [n:127.0.0.1:37243_solr
c:testCreateShardRepFactor s:a r:core_node3
x:testCreateShardRepFactor_a_replica_n1] o.a.s.c.ZkShardTerms Successful update
of terms at /collections/testCreateShardRepFactor/terms/a to
Terms{values={core_node3=0}, version=0}
[junit4] 2> 646504 INFO (qtp249479759-2221) [n:127.0.0.1:36643_solr
c:testCreateShardRepFactor s:b r:core_node4
x:testCreateShardRepFactor_b_replica_n2] o.a.s.c.ZkShardTerms Successful update
of terms at /collections/testCreateShardRepFactor/terms/b to
Terms{values={core_node4=0}, version=0}
[junit4] 2> 646515 INFO (qtp2051432336-2229) [n:127.0.0.1:37243_solr
c:testCreateShardRepFactor s:a r:core_node3
x:testCreateShardRepFactor_a_replica_n1] o.a.s.c.ShardLeaderElectionContext
Enough replicas found to continue.
[junit4] 2> 646515 INFO (qtp2051432336-2229) [n:127.0.0.1:37243_solr
c:testCreateShardRepFactor s:a r:core_node3
x:testCreateShardRepFactor_a_replica_n1] o.a.s.c.ShardLeaderElectionContext I
may be the new leader - try and sync
[junit4] 2> 646516 INFO (qtp2051432336-2229) [n:127.0.0.1:37243_solr
c:testCreateShardRepFactor s:a r:core_node3
x:testCreateShardRepFactor_a_replica_n1] o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:37243/solr/testCreateShardRepFactor_a_replica_n1/
[junit4] 2> 646516 INFO (qtp249479759-2221) [n:127.0.0.1:36643_solr
c:testCreateShardRepFactor s:b r:core_node4
x:testCreateShardRepFactor_b_replica_n2] o.a.s.c.ShardLeaderElectionContext
Enough replicas found to continue.
[junit4] 2> 646516 INFO (qtp249479759-2221) [n:127.0.0.1:36643_solr
c:testCreateShardRepFactor s:b r:core_node4
x:testCreateShardRepFactor_b_replica_n2] o.a.s.c.ShardLeaderElectionContext I
may be the new leader - try and sync
[junit4] 2> 646516 INFO (qtp249479759-2221) [n:127.0.0.1:36643_solr
c:testCreateShardRepFactor s:b r:core_node4
x:testCreateShardRepFactor_b_replica_n2] o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:36643/solr/testCreateShardRepFactor_b_replica_n2/
[junit4] 2> 646516 INFO (qtp2051432336-2229) [n:127.0.0.1:37243_solr
c:testCreateShardRepFactor s:a r:core_node3
x:testCreateShardRepFactor_a_replica_n1] o.a.s.c.SyncStrategy Sync Success -
now sync replicas to me
[junit4] 2> 646516 INFO (qtp249479759-2221) [n:127.0.0.1:36643_solr
c:testCreateShardRepFactor s:b r:core_node4
x:testCreateShardRepFactor_b_replica_n2] o.a.s.c.SyncStrategy Sync Success -
now sync replicas to me
[junit4] 2> 646516 INFO (qtp2051432336-2229) [n:127.0.0.1:37243_solr
c:testCreateShardRepFactor s:a r:core_node3
x:testCreateShardRepFactor_a_replica_n1] o.a.s.c.SyncStrategy
http://127.0.0.1:37243/solr/testCreateShardRepFactor_a_replica_n1/ has no
replicas
[junit4] 2> 646516 INFO (qtp249479759-2221) [n:127.0.0.1:36643_solr
c:testCreateShardRepFactor s:b r:core_node4
x:testCreateShardRepFactor_b_replica_n2] o.a.s.c.SyncStrategy
http://127.0.0.1:36643/solr/testCreateShardRepFactor_b_replica_n2/ has no
replicas
[junit4] 2> 646516 INFO (qtp249479759-2221) [n:127.0.0.1:36643_solr
c:testCreateShardRepFactor s:b r:core_node4
x:testCreateShardRepFactor_b_replica_n2] o.a.s.c.ShardLeaderElectionContext
Found all replicas participating in election, clear LIR
[junit4] 2> 646516 INFO (qtp2051432336-2229) [n:127.0.0.1:37243_solr
c:testCreateShardRepFactor s:a r:core_node3
x:testCreateShardRepFactor_a_replica_n1] o.a.s.c.ShardLeaderElectionContext
Found all replicas participating in election, clear LIR
[junit4] 2> 646528 INFO (qtp2051432336-2229) [n:127.0.0.1:37243_solr
c:testCreateShardRepFactor s:a r:core_node3
x:testCreateShardRepFactor_a_replica_n1] o.a.s.c.ShardLeaderElectionContext I
am the new leader:
http://127.0.0.1:37243/solr/testCreateShardRepFactor_a_replica_n1/ a
[junit4] 2> 646528 INFO (qtp249479759-2221) [n:127.0.0.1:36643_solr
c:testCreateShardRepFactor s:b r:core_node4
x:testCreateShardRepFactor_b_replica_n2] o.a.s.c.ShardLeaderElectionContext I
am the new leader:
http://127.0.0.1:36643/solr/testCreateShardRepFactor_b_replica_n2/ b
[junit4] 2> 646632 INFO (qtp249479759-2221) [n:127.0.0.1:36643_solr
c:testCreateShardRepFactor s:b r:core_node4
x:testCreateShardRepFactor_b_replica_n2] o.a.s.c.ZkController I am the leader,
no recovery necessary
[junit4] 2> 646632 INFO (qtp2051432336-2229) [n:127.0.0.1:37243_solr
c:testCreateShardRepFactor s:a r:core_node3
x:testCreateShardRepFactor_a_replica_n1] o.a.s.c.ZkController I am the leader,
no recovery necessary
[junit4] 2> 646635 INFO (qtp249479759-2221) [n:127.0.0.1:36643_solr
c:testCreateShardRepFactor s:b r:core_node4
x:testCreateShardRepFactor_b_replica_n2] o.a.s.s.HttpSolrCall [admin]
webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=testCreateShardRepFactor_b_replica_n2&action=CREATE&numShards=2&collection=testCreateShardRepFactor&shard=b&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1581
[junit4] 2> 646635 INFO (qtp2051432336-2229) [n:127.0.0.1:37243_solr
c:testCreateShardRepFactor s:a r:core_node3
x:testCreateShardRepFactor_a_replica_n1] o.a.s.s.HttpSolrCall [admin]
webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=testCreateShardRepFactor_a_replica_n1&action=CREATE&numShards=2&collection=testCreateShardRepFactor&shard=a&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1584
[junit4] 2> 646638 INFO (qtp2051432336-2207) [n:127.0.0.1:37243_solr ]
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most
30 seconds. Check all shard replicas
[junit4] 2> 646707 INFO
(OverseerCollectionConfigSetProcessor-72482381174997004-127.0.0.1:43128_solr-n_0000000000)
[ ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 646735 INFO (zkCallback-481-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testCreateShardRepFactor/state.json] for collection
[testCreateShardRepFactor] has occurred - updating... (live nodes size: [4])
[junit4] 2> 646735 INFO (zkCallback-495-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testCreateShardRepFactor/state.json] for collection
[testCreateShardRepFactor] has occurred - updating... (live nodes size: [4])
[junit4] 2> 647638 INFO (qtp2051432336-2207) [n:127.0.0.1:37243_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={shards=a,b&replicationFactor=1&collection.configName=conf&name=testCreateShardRepFactor&router.name=implicit&nrtReplicas=1&action=CREATE&wt=javabin&version=2}
status=0 QTime=2935
[junit4] 2> 647642 INFO (qtp2051432336-2220) [n:127.0.0.1:37243_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :createshard with params
action=CREATESHARD&collection=testCreateShardRepFactor&shard=x&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 647644 INFO (OverseerThreadFactory-653-thread-2) [ ]
o.a.s.c.a.c.CreateShardCmd Create shard invoked: {
[junit4] 2> "collection":"testCreateShardRepFactor",
[junit4] 2> "shard":"x",
[junit4] 2> "operation":"createshard"}
[junit4] 2> 647750 INFO (zkCallback-481-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testCreateShardRepFactor/state.json] for collection
[testCreateShardRepFactor] has occurred - updating... (live nodes size: [4])
[junit4] 2> 647750 INFO (zkCallback-495-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testCreateShardRepFactor/state.json] for collection
[testCreateShardRepFactor] has occurred - updating... (live nodes size: [4])
[junit4] 2> 648652 INFO (OverseerThreadFactory-653-thread-2) [ ]
o.a.s.c.a.c.CreateShardCmd Creating replica
testCreateShardRepFactor_x_replica_n5 as part of slice x of collection
testCreateShardRepFactor on 127.0.0.1:43128_solr
[junit4] 2> 648653 INFO (OverseerThreadFactory-653-thread-2) [ ]
o.a.s.c.a.c.AddReplicaCmd Node Identified 127.0.0.1:43128_solr for creating new
replica
[junit4] 2> 648655 INFO
(OverseerStateUpdate-72482381174997004-127.0.0.1:43128_solr-n_0000000000) [
] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"addreplica",
[junit4] 2> "collection":"testCreateShardRepFactor",
[junit4] 2> "shard":"x",
[junit4] 2> "core":"testCreateShardRepFactor_x_replica_n5",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:43128/solr";,
[junit4] 2> "node_name":"127.0.0.1:43128_solr",
[junit4] 2> "type":"NRT"}
[junit4] 2> 648757 INFO (zkCallback-481-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testCreateShardRepFactor/state.json] for collection
[testCreateShardRepFactor] has occurred - updating... (live nodes size: [4])
[junit4] 2> 648757 INFO (zkCallback-495-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testCreateShardRepFactor/state.json] for collection
[testCreateShardRepFactor] has occurred - updating... (live nodes size: [4])
[junit4] 2> 648859 INFO (qtp1303375981-2239) [n:127.0.0.1:43128_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node6&collection.configName=conf&name=testCreateShardRepFactor_x_replica_n5&action=CREATE&collection=testCreateShardRepFactor&shard=x&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 648883 INFO (qtp1303375981-2239) [n:127.0.0.1:43128_solr
c:testCreateShardRepFactor s:x r:core_node6
x:testCreateShardRepFactor_x_replica_n5] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 7.4.0
[junit4] 2> 648902 INFO (qtp1303375981-2239) [n:127.0.0.1:43128_solr
c:testCreateShardRepFactor s:x r:core_node6
x:testCreateShardRepFactor_x_replica_n5] o.a.s.s.IndexSchema
[testCreateShardRepFactor_x_replica_n5] Schema name=cloud-dynamic
[junit4] 2> 648962 INFO (qtp1303375981-2239) [n:127.0.0.1:43128_solr
c:testCreateShardRepFactor s:x r:core_node6
x:testCreateShardRepFactor_x_replica_n5] o.a.s.s.IndexSchema Loaded schema
cloud-dynamic/1.6 with uniqueid field id
[junit4] 2> 648962 INFO (qtp1303375981-2239) [n:127.0.0.1:43128_solr
c:testCreateShardRepFactor s:x r:core_node6
x:testCreateShardRepFactor_x_replica_n5] o.a.s.c.CoreContainer Creating
SolrCore 'testCreateShardRepFactor_x_replica_n5' using configuration from
collection testCreateShardRepFactor, trusted=true
[junit4] 2> 648963 INFO (qtp1303375981-2239) [n:127.0.0.1:43128_solr
c:testCreateShardRepFactor s:x r:core_node6
x:testCreateShardRepFactor_x_replica_n5] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_43128.solr.core.testCreateShardRepFactor.x.replica_n5'
(registry 'solr.core.testCreateShardRepFactor.x.replica_n5') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5ad4474f
[junit4] 2> 648963 INFO (qtp1303375981-2239) [n:127.0.0.1:43128_solr
c:testCreateShardRepFactor s:x r:core_node6
x:testCreateShardRepFactor_x_replica_n5] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 648963 INFO (qtp1303375981-2239) [n:127.0.0.1:43128_solr
c:testCreateShardRepFactor s:x r:core_node6
x:testCreateShardRepFactor_x_replica_n5] o.a.s.c.SolrCore
[[testCreateShardRepFactor_x_replica_n5] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J2/temp/solr.cloud.api.collections.CustomCollectionTest_A4B187167D18FE3A-001/tempDir-001/node2/testCreateShardRepFactor_x_replica_n5],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J2/temp/solr.cloud.api.collections.CustomCollectionTest_A4B187167D18FE3A-001/tempDir-001/node2/./testCreateShardRepFactor_x_replica_n5/data/]
[junit4] 2> 648989 INFO (zkCallback-481-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testCreateShardRepFactor/state.json] for collection
[testCreateShardRepFactor] has occurred - updating... (live nodes size: [4])
[junit4] 2> 648990 INFO (zkCallback-495-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testCreateShardRepFactor/state.json] for collection
[testCreateShardRepFactor] has occurred - updating... (live nodes size: [4])
[junit4] 2> 649177 INFO (qtp1303375981-2239) [n:127.0.0.1:43128_solr
c:testCreateShardRepFactor s:x r:core_node6
x:testCreateShardRepFactor_x_replica_n5] o.a.s.u.UpdateHandler Using UpdateLog
implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 649177 INFO (qtp1303375981-2239) [n:127.0.0.1:43128_solr
c:testCreateShardRepFactor s:x r:core_node6
x:testCreateShardRepFactor_x_replica_n5] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 649178 INFO (qtp1303375981-2239) [n:127.0.0.1:43128_solr
c:testCreateShardRepFactor s:x r:core_node6
x:testCreateShardRepFactor_x_replica_n5] o.a.s.u.CommitTracker Hard AutoCommit:
disabled
[junit4] 2> 649192 INFO (qtp1303375981-2239) [n:127.0.0.1:43128_solr
c:testCreateShardRepFactor s:x r:core_node6
x:testCreateShardRepFactor_x_replica_n5] o.a.s.u.CommitTracker Soft AutoCommit:
disabled
[junit4] 2> 649194 INFO (qtp1303375981-2239) [n:127.0.0.1:43128_solr
c:testCreateShardRepFactor s:x r:core_node6
x:testCreateShardRepFactor_x_replica_n5] o.a.s.s.SolrIndexSearcher Opening
[Searcher@6a32e7a3[testCreateShardRepFactor_x_replica_n5] main]
[junit4] 2> 649209 INFO (qtp1303375981-2239) [n:127.0.0.1:43128_solr
c:testCreateShardRepFactor s:x r:core_node6
x:testCreateShardRepFactor_x_replica_n5] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 649209 INFO (qtp1303375981-2239) [n:127.0.0.1:43128_solr
c:testCreateShardRepFactor s:x r:core_node6
x:testCreateShardRepFactor_x_replica_n5] o.a.s.r.ManagedResourceStorage Loaded
null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 649210 INFO (qtp1303375981-2239) [n:127.0.0.1:43128_solr
c:testCreateShardRepFactor s:x r:core_node6
x:testCreateShardRepFactor_x_replica_n5] o.a.s.h.ReplicationHandler Commits
will be reserved for 10000ms.
[junit4] 2> 649210 INFO (qtp1303375981-2239) [n:127.0.0.1:43128_solr
c:testCreateShardRepFactor s:x r:core_node6
x:testCreateShardRepFactor_x_replica_n5] o.a.s.u.UpdateLog Could not find max
version in index or recent updates, using new clock 1598181179397242880
[junit4] 2> 649306 INFO (qtp1303375981-2239) [n:127.0.0.1:43128_solr
c:testCreateShardRepFactor s:x r:core_node6
x:testCreateShardRepFactor_x_replica_n5] o.a.s.c.ZkShardTerms Successful update
of terms at /collections/testCreateShardRepFactor/terms/x to
Terms{values={core_node6=0}, version=0}
[junit4] 2> 649307 INFO
(searcherExecutor-672-thread-1-processing-n:127.0.0.1:43128_solr
x:testCreateShardRepFactor_x_replica_n5 c:testCreateShardRepFactor s:x
r:core_node6) [n:127.0.0.1:43128_solr c:testCreateShardRepFactor s:x
r:core_node6 x:testCreateShardRepFactor_x_replica_n5] o.a.s.c.SolrCore
[testCreateShardRepFactor_x_replica_n5] Registered new searcher
Searcher@6a32e7a3[testCreateShardRepFactor_x_replica_n5]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 649309 INFO (qtp1303375981-2239) [n:127.0.0.1:43128_solr
c:testCreateShardRepFactor s:x r:core_node6
x:testCreateShardRepFactor_x_replica_n5] o.a.s.c.ShardLeaderElectionContext
Enough replicas found to continue.
[junit4] 2> 649309 INFO (qtp1303375981-2239) [n:127.0.0.1:43128_solr
c:testCreateShardRepFactor s:x r:core_node6
x:testCreateShardRepFactor_x_replica_n5] o.a.s.c.ShardLeaderElectionContext I
may be the new leader - try and sync
[junit4] 2> 649309 INFO (qtp1303375981-2239) [n:127.0.0.1:43128_solr
c:testCreateShardRepFactor s:x r:core_node6
x:testCreateShardRepFactor_x_replica_n5] o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:43128/solr/testCreateShardRepFactor_x_replica_n5/
[junit4] 2> 649309 INFO (qtp1303375981-2239) [n:127.0.0.1:43128_solr
c:testCreateShardRepFactor s:x r:core_node6
x:testCreateShardRepFactor_x_replica_n5] o.a.s.c.SyncStrategy Sync Success -
now sync replicas to me
[junit4] 2> 649309 INFO (qtp1303375981-2239) [n:127.0.0.1:43128_solr
c:testCreateShardRepFactor s:x r:core_node6
x:testCreateShardRepFactor_x_replica_n5] o.a.s.c.SyncStrategy
http://127.0.0.1:43128/solr/testCreateShardRepFactor_x_replica_n5/ has no
replicas
[junit4] 2> 649309 INFO (qtp1303375981-2239) [n:127.0.0.1:43128_solr
c:testCreateShardRepFactor s:x r:core_node6
x:testCreateShardRepFactor_x_replica_n5] o.a.s.c.ShardLeaderElectionContext
Found all replicas participating in election, clear LIR
[junit4] 2> 649325 INFO (qtp1303375981-2239) [n:127.0.0.1:43128_solr
c:testCreateShardRepFactor s:x r:core_node6
x:testCreateShardRepFactor_x_replica_n5] o.a.s.c.ShardLeaderElectionContext I
am the new leader:
http://127.0.0.1:43128/solr/testCreateShardRepFactor_x_replica_n5/ x
[junit4] 2> 649426 INFO (zkCallback-481-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testCreateShardRepFactor/state.json] for collection
[testCreateShardRepFactor] has occurred - updating... (live nodes size: [4])
[junit4] 2> 649426 INFO (zkCallback-495-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testCreateShardRepFactor/state.json] for collection
[testCreateShardRepFactor] has occurred - updating... (live nodes size: [4])
[junit4] 2> 649428 INFO (qtp1303375981-2239) [n:127.0.0.1:43128_solr
c:testCreateShardRepFactor s:x r:core_node6
x:testCreateShardRepFactor_x_replica_n5] o.a.s.c.ZkController I am the leader,
no recovery necessary
[junit4] 2> 649449 INFO (qtp1303375981-2239) [n:127.0.0.1:43128_solr
c:testCreateShardRepFactor s:x r:core_node6
x:testCreateShardRepFactor_x_replica_n5] o.a.s.s.HttpSolrCall [admin]
webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node6&collection.configName=conf&name=testCreateShardRepFactor_x_replica_n5&action=CREATE&collection=testCreateShardRepFactor&shard=x&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=589
[junit4] 2> 649450 INFO (OverseerThreadFactory-653-thread-2) [ ]
o.a.s.c.a.c.CreateShardCmd Finished create command on all shards for
collection: testCreateShardRepFactor
[junit4] 2> 649466 INFO (qtp2051432336-2220) [n:127.0.0.1:37243_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={action=CREATESHARD&collection=testCreateShardRepFactor&shard=x&wt=javabin&version=2}
status=0 QTime=1824
[junit4] 2> 649477 INFO
(TEST-CustomCollectionTest.testCreateShardRepFactor-seed#[A4B187167D18FE3A]) [
] o.a.s.SolrTestCaseJ4 ###Ending testCreateShardRepFactor
[junit4] 2> 649562 INFO (zkCallback-495-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testCreateShardRepFactor/state.json] for collection
[testCreateShardRepFactor] has occurred - updating... (live nodes size: [4])
[junit4] 2> 649562 INFO (zkCallback-499-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testCreateShardRepFactor/state.json] for collection
[testCreateShardRepFactor] has occurred - updating... (live nodes size: [4])
[junit4] 2> 649561 INFO (zkCallback-481-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testCreateShardRepFactor/state.json] for collection
[testCreateShardRepFactor] has occurred - updating... (live nodes size: [4])
[junit4] 2> 649632 INFO
(TEST-CustomCollectionTest.testRouteFieldForHashRouter-seed#[A4B187167D18FE3A])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testRouteFieldForHashRouter
[junit4] 2> 649633 INFO
(TEST-CustomCollectionTest.testRouteFieldForHashRouter-seed#[A4B187167D18FE3A])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 649643 INFO (qtp2051432336-2229) [n:127.0.0.1:37243_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params
name=testCreateShardRepFactor&action=DELETE&wt=javabin&version=2 and
sendToOCPQueue=true
[junit4] 2> 649659 INFO (OverseerThreadFactory-653-thread-3) [ ]
o.a.s.c.a.c.OverseerCollectionMessageHandler Executing Collection
Cmd=action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true, asyncId=null
[junit4] 2> 649659 INFO
(OverseerCollectionConfigSetProcessor-72482381174997004-127.0.0.1:43128_solr-n_0000000000)
[ ] 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> 649661 INFO (qtp1303375981-2240) [n:127.0.0.1:43128_solr ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.testCreateShardRepFactor.x.replica_n5, tag=null
[junit4] 2> 649661 INFO (qtp1303375981-2240) [n:127.0.0.1:43128_solr ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@6ba357c2: rootName =
solr_43128, domain = solr.core.testCreateShardRepFactor.x.replica_n5, service
url = null, agent id = null] for registry
solr.core.testCreateShardRepFactor.x.replica_n5 /
com.codahale.metrics.MetricRegistry@5294605d
[junit4] 2> 649687 INFO (qtp249479759-2225) [n:127.0.0.1:36643_solr ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.testCreateShardRepFactor.b.replica_n2, tag=null
[junit4] 2> 649688 INFO (qtp249479759-2225) [n:127.0.0.1:36643_solr ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@14412a68: rootName =
solr_36643, domain = solr.core.testCreateShardRepFactor.b.replica_n2, service
url = null, agent id = null] for registry
solr.core.testCreateShardRepFactor.b.replica_n2 /
com.codahale.metrics.MetricRegistry@7c618f8
[junit4] 2> 649700 INFO (qtp2051432336-2230) [n:127.0.0.1:37243_solr ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.testCreateShardRepFactor.a.replica_n1, tag=null
[junit4] 2> 649700 INFO (qtp2051432336-2230) [n:127.0.0.1:37243_solr ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@61e7e98d: rootName =
solr_37243, domain = solr.core.testCreateShardRepFactor.a.replica_n1, service
url = null, agent id = null] for registry
solr.core.testCreateShardRepFactor.a.replica_n1 /
com.codahale.metrics.MetricRegistry@2a9aa49
[junit4] 2> 649719 INFO (qtp1303375981-2240) [n:127.0.0.1:43128_solr ]
o.a.s.c.SolrCore [testCreateShardRepFactor_x_replica_n5] CLOSING SolrCore
org.apache.solr.core.SolrCore@7daef9b0
[junit4] 2> 649719 INFO (qtp1303375981-2240) [n:127.0.0.1:43128_solr ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.testCreateShardRepFactor.x.replica_n5, tag=7daef9b0
[junit4] 2> 649719 INFO (qtp1303375981-2240) [n:127.0.0.1:43128_solr ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.collection.testCreateShardRepFactor.x.leader, tag=7daef9b0
[junit4] 2> 649761 INFO (qtp249479759-2225) [n:127.0.0.1:36643_solr ]
o.a.s.c.SolrCore [testCreateShardRepFactor_b_replica_n2] CLOSING SolrCore
org.apache.solr.core.SolrCore@27a1c8de
[junit4] 2> 649761 INFO (qtp2051432336-2230) [n:127.0.0.1:37243_solr ]
o.a.s.c.SolrCore [testCreateShardRepFactor_a_replica_n1] CLOSING SolrCore
org.apache.solr.core.SolrCore@7be0265b
[junit4] 2> 649762 INFO (qtp249479759-2225) [n:127.0.0.1:36643_solr ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.testCreateShardRepFactor.b.replica_n2, tag=27a1c8de
[junit4] 2> 649762 INFO (qtp2051432336-2230) [n:127.0.0.1:37243_solr ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.testCreateShardRepFactor.a.replica_n1, tag=7be0265b
[junit4] 2> 649762 INFO (qtp249479759-2225) [n:127.0.0.1:36643_solr ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.collection.testCreateShardRepFactor.b.leader, tag=27a1c8de
[junit4] 2> 649762 INFO (qtp2051432336-2230) [n:127.0.0.1:37243_solr ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.collection.testCreateShardRepFactor.a.leader, tag=7be0265b
[junit4] 2> 649792 INFO (qtp1303375981-2240) [n:127.0.0.1:43128_solr ]
o.a.s.c.ZkShardTerms Successful update of terms at
/collections/testCreateShardRepFactor/terms/x to Terms{values={}, version=1}
[junit4] 2> 649796 INFO (qtp1303375981-2240) [n:127.0.0.1:43128_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={deleteInstanceDir=true&core=testCreateShardRepFactor_x_replica_n5&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2}
status=0 QTime=135
[junit4] 2> 649815 INFO (qtp249479759-2225) [n:127.0.0.1:36643_solr ]
o.a.s.c.ZkShardTerms Successful update of terms at
/collections/testCreateShardRepFactor/terms/b to Terms{values={}, version=1}
[junit4] 2> 649816 INFO (qtp2051432336-2230) [n:127.0.0.1:37243_solr ]
o.a.s.c.ZkShardTerms Successful update of terms at
/collections/testCreateShardRepFactor/terms/a to Terms{values={}, version=1}
[junit4] 2> 649818 INFO (qtp249479759-2225) [n:127.0.0.1:36643_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={deleteInstanceDir=true&core=testCreateShardRepFactor_b_replica_n2&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2}
status=0 QTime=145
[junit4] 2> 649818 INFO (qtp2051432336-2230) [n:127.0.0.1:37243_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={deleteInstanceDir=true&core=testCreateShardRepFactor_a_replica_n1&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2}
status=0 QTime=146
[junit4] 2> 649921 INFO (zkCallback-481-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDeleted
path:/collections/testCreateShardRepFactor/state.json] for collection
[testCreateShardRepFactor] has occurred - updating... (live nodes size: [4])
[junit4] 2> 649921 INFO (zkCallback-499-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDeleted
path:/collections/testCreateShardRepFactor/state.json] for collection
[testCreateShardRepFactor] has occurred - updating... (live nodes size: [4])
[junit4] 2> 649921 INFO (zkCallback-495-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDeleted
path:/collections/testCreateShardRepFactor/state.json] for collection
[testCreateShardRepFactor] has occurred - updating... (live nodes size: [4])
[junit4] 2> 650546 INFO (qtp2051432336-2229) [n:127.0.0.1:37243_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={name=testCreateShardRepFactor&action=DELETE&wt=javabin&version=2}
status=0 QTime=902
[junit4] 2> 650547 INFO (qtp2051432336-2220) [n:127.0.0.1:37243_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=2&collection.configName=conf&maxShardsPerNode=3&router.field=shard_s&name=routeFieldColl&nrtReplicas=2&action=CREATE&numShards=4&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 650557 INFO (OverseerThreadFactory-653-thread-4) [ ]
o.a.s.c.a.c.CreateCollectionCmd Create collection routeFieldColl
[junit4] 2> 650557 INFO
(OverseerCollectionConfigSetProcessor-72482381174997004-127.0.0.1:43128_solr-n_0000000000)
[ ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000004 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 650773 INFO
(OverseerStateUpdate-72482381174997004-127.0.0.1:43128_solr-n_0000000000) [
] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"routeFieldColl",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"routeFieldColl_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:36643/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 650776 INFO
(OverseerStateUpdate-72482381174997004-127.0.0.1:43128_solr-n_0000000000) [
] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"routeFieldColl",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"routeFieldColl_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:37243/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 650778 INFO
(OverseerStateUpdate-72482381174997004-127.0.0.1:43128_solr-n_0000000000) [
] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"routeFieldColl",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"routeFieldColl_shard2_replica_n4",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:43128/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 650780 INFO
(OverseerStateUpdate-72482381174997004-127.0.0.1:43128_solr-n_0000000000) [
] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"routeFieldColl",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"routeFieldColl_shard2_replica_n6",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:40075/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 650794 INFO
(OverseerStateUpdate-72482381174997004-127.0.0.1:43128_solr-n_0000000000) [
] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"routeFieldColl",
[junit4] 2> "shard":"shard3",
[junit4] 2> "core":"routeFieldColl_shard3_replica_n9",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:36643/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 650817 INFO
(OverseerStateUpdate-72482381174997004-127.0.0.1:43128_solr-n_0000000000) [
] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"routeFieldColl",
[junit4] 2> "shard":"shard3",
[junit4] 2> "core":"routeFieldColl_shard3_replica_n10",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:37243/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 650819 INFO
(OverseerStateUpdate-72482381174997004-127.0.0.1:43128_solr-n_0000000000) [
] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"routeFieldColl",
[junit4] 2> "shard":"shard4",
[junit4] 2> "core":"routeFieldColl_shard4_replica_n12",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:43128/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 650821 INFO
(OverseerStateUpdate-72482381174997004-127.0.0.1:43128_solr-n_0000000000) [
] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"routeFieldColl",
[junit4] 2> "shard":"shard4",
[junit4] 2> "core":"routeFieldColl_shard4_replica_n14",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:40075/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 651024 INFO (qtp2051432336-2231) [n:127.0.0.1:37243_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf&newCollection=true&name=routeFieldColl_shard1_replica_n2&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 651024 INFO (qtp1303375981-2245) [n:127.0.0.1:43128_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf&newCollection=true&name=routeFieldColl_shard2_replica_n4&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 651024 INFO (qtp249479759-2226) [n:127.0.0.1:36643_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=routeFieldColl_shard1_replica_n1&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 651102 INFO (qtp2051432336-2228) [n:127.0.0.1:37243_solr ]
o.a.s.h.a.CoreAdminOperation core create com
[...truncated too long message...]
/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
jar-checksums:
[mkdir] Created dir:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/null2080287188
[copy] Copying 40 files to
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/null2080287188
[delete] Deleting directory
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/null2080287188
resolve-example:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
resolve-server:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
jar-checksums:
[mkdir] Created dir:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/null1187361933
[copy] Copying 246 files to
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/null1187361933
[delete] Deleting directory
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/null1187361933
check-working-copy:
[ivy:cachepath] :: resolving dependencies ::
org.eclipse.jgit#org.eclipse.jgit-caller;working
[ivy:cachepath] confs: [default]
[ivy:cachepath] found
org.eclipse.jgit#org.eclipse.jgit;4.6.0.201612231935-r in public
[ivy:cachepath] found com.jcraft#jsch;0.1.53 in public
[ivy:cachepath] found com.googlecode.javaewah#JavaEWAH;1.1.6 in public
[ivy:cachepath] found org.apache.httpcomponents#httpclient;4.3.6 in
public
[ivy:cachepath] found org.apache.httpcomponents#httpcore;4.3.3 in public
[ivy:cachepath] found commons-logging#commons-logging;1.1.3 in public
[ivy:cachepath] found commons-codec#commons-codec;1.6 in public
[ivy:cachepath] found org.slf4j#slf4j-api;1.7.2 in public
[ivy:cachepath] :: resolution report :: resolve 64ms :: artifacts dl 1ms
---------------------------------------------------------------------
| | modules || artifacts |
| conf | number| search|dwnlded|evicted|| number|dwnlded|
---------------------------------------------------------------------
| default | 8 | 0 | 0 | 0 || 8 | 0 |
---------------------------------------------------------------------
[wc-checker] Initializing working copy...
[wc-checker] SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder".
[wc-checker] SLF4J: Defaulting to no-operation (NOP) logger implementation
[wc-checker] SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for
further details.
[wc-checker] Checking working copy status...
-jenkins-base:
BUILD SUCCESSFUL
Total time: 183 minutes 48 seconds
Archiving artifacts
WARN: No artifacts found that match the file pattern
"**/*.events,heapdumps/**,**/hs_err_pid*". Configuration error?
WARN: java.lang.InterruptedException: no matches found within 10000
Recording test results
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
