You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2015/12/26 11:30:12 UTC

[JENKINS] Lucene-Solr-5.x-MacOSX (64bit/jdk1.7.0) - Build # 2912 - Still Failing!

Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-MacOSX/2912/
Java: 64bit/jdk1.7.0 -XX:-UseCompressedOops -XX:+UseG1GC

2 tests failed.
FAILED:  org.apache.solr.TestDistributedSearch.test

Error Message:
Error from server at http://127.0.0.1:64090//collection1: java.lang.NullPointerException  at org.apache.solr.search.grouping.distributed.responseprocessor.TopGroupsShardResponseProcessor.process(TopGroupsShardResponseProcessor.java:106)  at org.apache.solr.handler.component.QueryComponent.handleGroupedResponses(QueryComponent.java:751)  at org.apache.solr.handler.component.QueryComponent.handleResponses(QueryComponent.java:734)  at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:406)  at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:156)  at org.apache.solr.core.SolrCore.execute(SolrCore.java:2070)  at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:658)  at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:457)  at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:223)  at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:181)  at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)  at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:110)  at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)  at org.eclipse.jetty.servlets.UserAgentFilter.doFilter(UserAgentFilter.java:83)  at org.eclipse.jetty.servlets.GzipFilter.doFilter(GzipFilter.java:364)  at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)  at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:585)  at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:221)  at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1127)  at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:515)  at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)  at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1061)  at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)  at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:97)  at org.eclipse.jetty.server.Server.handle(Server.java:499)  at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:310)  at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:257)  at org.eclipse.jetty.io.AbstractConnection$2.run(AbstractConnection.java:540)  at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635)  at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555)  at java.lang.Thread.run(Thread.java:745) 

Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:64090//collection1: java.lang.NullPointerException
	at org.apache.solr.search.grouping.distributed.responseprocessor.TopGroupsShardResponseProcessor.process(TopGroupsShardResponseProcessor.java:106)
	at org.apache.solr.handler.component.QueryComponent.handleGroupedResponses(QueryComponent.java:751)
	at org.apache.solr.handler.component.QueryComponent.handleResponses(QueryComponent.java:734)
	at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:406)
	at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:156)
	at org.apache.solr.core.SolrCore.execute(SolrCore.java:2070)
	at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:658)
	at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:457)
	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:223)
	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:181)
	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)
	at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:110)
	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)
	at org.eclipse.jetty.servlets.UserAgentFilter.doFilter(UserAgentFilter.java:83)
	at org.eclipse.jetty.servlets.GzipFilter.doFilter(GzipFilter.java:364)
	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)
	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:585)
	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:221)
	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1127)
	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:515)
	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1061)
	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:97)
	at org.eclipse.jetty.server.Server.handle(Server.java:499)
	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:310)
	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:257)
	at org.eclipse.jetty.io.AbstractConnection$2.run(AbstractConnection.java:540)
	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635)
	at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555)
	at java.lang.Thread.run(Thread.java:745)

	at __randomizedtesting.SeedInfo.seed([8B8A1A232E972CF1:3DE25F9806B4109]:0)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:575)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230)
	at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:150)
	at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:943)
	at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:958)
	at org.apache.solr.TestDistributedSearch.queryRandomUpServer(TestDistributedSearch.java:1139)
	at org.apache.solr.TestDistributedSearch.queryPartialResults(TestDistributedSearch.java:1101)
	at org.apache.solr.TestDistributedSearch.test(TestDistributedSearch.java:974)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:987)
	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:940)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
	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:46)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	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:54)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(Thread.java:745)


FAILED:  org.apache.solr.handler.TestReplicationHandler.doTestStressReplication

Error Message:
timed out waiting for collection1 startAt time to exceed: Sat Dec 26 17:50:01 ULAT 2015

Stack Trace:
java.lang.AssertionError: timed out waiting for collection1 startAt time to exceed: Sat Dec 26 17:50:01 ULAT 2015
	at __randomizedtesting.SeedInfo.seed([8B8A1A232E972CF1:50211AE52BBF4542]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.apache.solr.handler.TestReplicationHandler.watchCoreStartAt(TestReplicationHandler.java:1419)
	at org.apache.solr.handler.TestReplicationHandler.doTestStressReplication(TestReplicationHandler.java:771)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
	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:46)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	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:54)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 10102 lines...]
   [junit4] Suite: org.apache.solr.handler.TestReplicationHandler
   [junit4]   2> Creating dataDir: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/init-core-data-001
   [junit4]   2> 1054483 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.SolrTestCaseJ4 ###Starting doTestRepeater
   [junit4]   2> 1054484 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-001/collection1
   [junit4]   2> 1054493 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.e.j.s.Server jetty-9.2.13.v20150730
   [junit4]   2> 1054498 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4110eecd{/solr,null,AVAILABLE}
   [junit4]   2> 1054502 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.e.j.s.ServerConnector Started ServerConnector@3eadf61a{HTTP/1.1}{127.0.0.1:61182}
   [junit4]   2> 1054502 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.e.j.s.Server Started @1058394ms
   [junit4]   2> 1054502 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-001/collection1/data, hostPort=61182}
   [junit4]   2> 1054502 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@373ee92
   [junit4]   2> 1054502 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-001'
   [junit4]   2> 1054503 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1054503 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
   [junit4]   2> 1054503 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-001/solr.xml
   [junit4]   2> 1054539 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-001/.
   [junit4]   2> 1054539 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CoreContainer New CoreContainer 1974847919
   [junit4]   2> 1054539 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-001]
   [junit4]   2> 1054539 WARN  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CoreContainer Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-001/lib to classpath: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-001/lib
   [junit4]   2> 1054539 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
   [junit4]   2> 1054542 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1054542 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1054542 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1054542 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
   [junit4]   2> 1054542 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 1054546 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-001/.
   [junit4]   2> 1054549 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, transient=false, configSetProperties=configsetprops.json, config=solrconfig.xml, schema=schema.xml, loadOnStartup=true, dataDir=data/}
   [junit4]   2> 1054549 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CorePropertiesLocator Found core collection1 in /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-001/./collection1
   [junit4]   2> 1054549 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
   [junit4]   2> 1054550 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.s.SolrDispatchFilter user.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0
   [junit4]   2> 1054550 INFO  (coreLoadExecutor-2226-thread-1) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-001/collection1'
   [junit4]   2> 1054550 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 1054551 INFO  (coreLoadExecutor-2226-thread-1) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1054551 INFO  (coreLoadExecutor-2226-thread-1) [    ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
   [junit4]   2> 1054565 INFO  (coreLoadExecutor-2226-thread-1) [    ] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 1054583 INFO  (coreLoadExecutor-2226-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.5.0
   [junit4]   2> 1054614 INFO  (coreLoadExecutor-2226-thread-1) [    ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1054618 INFO  (coreLoadExecutor-2226-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1054629 INFO  (coreLoadExecutor-2226-thread-1) [    ] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1054635 INFO  (coreLoadExecutor-2226-thread-1) [    ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-001/collection1'
   [junit4]   2> 1054635 INFO  (coreLoadExecutor-2226-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-001/./collection1
   [junit4]   2> 1054635 INFO  (coreLoadExecutor-2226-thread-1) [    x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1054635 INFO  (coreLoadExecutor-2226-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-001/collection1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-001/./collection1/data/]
   [junit4]   2> 1054636 INFO  (coreLoadExecutor-2226-thread-1) [    x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
   [junit4]   2> 1054636 INFO  (coreLoadExecutor-2226-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-001/./collection1/data
   [junit4]   2> 1054636 INFO  (coreLoadExecutor-2226-thread-1) [    x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-001/./collection1/data/index/
   [junit4]   2> 1054636 WARN  (coreLoadExecutor-2226-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-001/./collection1/data/index' doesn't exist. Creating new index...
   [junit4]   2> 1054636 INFO  (coreLoadExecutor-2226-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-001/./collection1/data/index
   [junit4]   2> 1054637 INFO  (coreLoadExecutor-2226-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=34, maxMergeAtOnceExplicit=25, maxMergedSegmentMB=25.751953125, floorSegmentMB=0.642578125, forceMergeDeletesPctAllowed=17.377212696712288, segmentsPerTier=14.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5518614597198589
   [junit4]   2> 1054637 INFO  (coreLoadExecutor-2226-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@55194a21 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f51e82c),segFN=segments_1,generation=1}
   [junit4]   2> 1054637 INFO  (coreLoadExecutor-2226-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1054638 INFO  (OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-001/./collection1/data/
   [junit4]   2> 1054641 INFO  (coreLoadExecutor-2226-thread-1) [    x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1054648 INFO  (coreLoadExecutor-2226-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1054649 INFO  (coreLoadExecutor-2226-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1054651 INFO  (coreLoadExecutor-2226-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1054652 INFO  (coreLoadExecutor-2226-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1054662 INFO  (coreLoadExecutor-2226-thread-1) [    x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy 
   [junit4]   2> 1054662 INFO  (coreLoadExecutor-2226-thread-1) [    x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/plugins,/admin/threads,/admin/logging,/admin/mbeans,/admin/ping,/admin/file,/admin/segments,/admin/luke,/update/json,/admin/properties,/config,/update/json/docs,/update/csv,/replication,defaults,/get,/schema,/admin/system,/update,lazy,standard
   [junit4]   2> 1054663 INFO  (coreLoadExecutor-2226-thread-1) [    x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1054664 INFO  (coreLoadExecutor-2226-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1054664 INFO  (coreLoadExecutor-2226-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1054664 INFO  (coreLoadExecutor-2226-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=45, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=15.2373046875, floorSegmentMB=1.8271484375, forceMergeDeletesPctAllowed=29.713425864847558, segmentsPerTier=18.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.47515426154583873
   [junit4]   2> 1054665 INFO  (coreLoadExecutor-2226-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@55194a21 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f51e82c),segFN=segments_1,generation=1}
   [junit4]   2> 1054665 INFO  (coreLoadExecutor-2226-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1054665 INFO  (coreLoadExecutor-2226-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@5746635b[collection1] main
   [junit4]   2> 1054665 INFO  (coreLoadExecutor-2226-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-001/collection1/conf
   [junit4]   2> 1054665 INFO  (coreLoadExecutor-2226-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-001/collection1/conf}
   [junit4]   2> 1054665 INFO  (coreLoadExecutor-2226-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-001/collection1/conf
   [junit4]   2> 1054666 INFO  (coreLoadExecutor-2226-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 1054666 INFO  (coreLoadExecutor-2226-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml,xslt/dummy.xsl
   [junit4]   2> 1054666 INFO  (coreLoadExecutor-2226-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1054666 INFO  (coreLoadExecutor-2226-thread-1) [    x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 1054666 INFO  (searcherExecutor-2227-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5746635b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1055054 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/collection1
   [junit4]   2> 1055062 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.e.j.s.Server jetty-9.2.13.v20150730
   [junit4]   2> 1055065 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4f7630fc{/solr,null,AVAILABLE}
   [junit4]   2> 1055066 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.e.j.s.ServerConnector Started ServerConnector@588a1925{HTTP/1.1}{127.0.0.1:61189}
   [junit4]   2> 1055066 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.e.j.s.Server Started @1058958ms
   [junit4]   2> 1055066 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=61189, solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/collection1/data}
   [junit4]   2> 1055066 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@373ee92
   [junit4]   2> 1055066 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002'
   [junit4]   2> 1055066 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1055067 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
   [junit4]   2> 1055067 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/solr.xml
   [junit4]   2> 1055091 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/.
   [junit4]   2> 1055091 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CoreContainer New CoreContainer 1603345
   [junit4]   2> 1055091 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002]
   [junit4]   2> 1055091 WARN  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CoreContainer Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/lib to classpath: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/lib
   [junit4]   2> 1055092 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
   [junit4]   2> 1055094 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1055095 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1055095 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1055095 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
   [junit4]   2> 1055095 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 1055097 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/.
   [junit4]   2> 1055099 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, configSetProperties=configsetprops.json, config=solrconfig.xml, schema=schema.xml, dataDir=data/, loadOnStartup=true, transient=false}
   [junit4]   2> 1055099 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CorePropertiesLocator Found core collection1 in /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/./collection1
   [junit4]   2> 1055099 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
   [junit4]   2> 1055101 INFO  (coreLoadExecutor-2236-thread-1) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/collection1'
   [junit4]   2> 1055101 INFO  (coreLoadExecutor-2236-thread-1) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1055101 INFO  (coreLoadExecutor-2236-thread-1) [    ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
   [junit4]   2> 1055101 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.s.SolrDispatchFilter user.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0
   [junit4]   2> 1055101 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 1055114 INFO  (coreLoadExecutor-2236-thread-1) [    ] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 1055129 INFO  (coreLoadExecutor-2236-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.5.0
   [junit4]   2> 1055157 INFO  (coreLoadExecutor-2236-thread-1) [    ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1055161 INFO  (coreLoadExecutor-2236-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1055170 INFO  (coreLoadExecutor-2236-thread-1) [    ] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1055175 INFO  (coreLoadExecutor-2236-thread-1) [    ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/collection1'
   [junit4]   2> 1055175 INFO  (coreLoadExecutor-2236-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/./collection1
   [junit4]   2> 1055175 INFO  (coreLoadExecutor-2236-thread-1) [    x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1055175 INFO  (coreLoadExecutor-2236-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/collection1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/./collection1/data/]
   [junit4]   2> 1055175 INFO  (coreLoadExecutor-2236-thread-1) [    x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
   [junit4]   2> 1055176 INFO  (coreLoadExecutor-2236-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/./collection1/data
   [junit4]   2> 1055176 INFO  (coreLoadExecutor-2236-thread-1) [    x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/./collection1/data/index/
   [junit4]   2> 1055176 WARN  (coreLoadExecutor-2236-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/./collection1/data/index' doesn't exist. Creating new index...
   [junit4]   2> 1055176 INFO  (coreLoadExecutor-2236-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/./collection1/data/index
   [junit4]   2> 1055176 INFO  (coreLoadExecutor-2236-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=34, maxMergeAtOnceExplicit=25, maxMergedSegmentMB=25.751953125, floorSegmentMB=0.642578125, forceMergeDeletesPctAllowed=17.377212696712288, segmentsPerTier=14.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5518614597198589
   [junit4]   2> 1055177 INFO  (coreLoadExecutor-2236-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@156a8d37 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@65d20dd),segFN=segments_1,generation=1}
   [junit4]   2> 1055177 INFO  (coreLoadExecutor-2236-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1055178 INFO  (OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/./collection1/data/
   [junit4]   2> 1055181 INFO  (coreLoadExecutor-2236-thread-1) [    x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1055190 INFO  (coreLoadExecutor-2236-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1055191 INFO  (coreLoadExecutor-2236-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1055192 INFO  (coreLoadExecutor-2236-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1055193 INFO  (coreLoadExecutor-2236-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1055195 INFO  (coreLoadExecutor-2236-thread-1) [    x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy 
   [junit4]   2> 1055195 INFO  (coreLoadExecutor-2236-thread-1) [    x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/plugins,/admin/threads,/admin/logging,/admin/mbeans,/admin/ping,/admin/file,/admin/segments,/admin/luke,/update/json,/admin/properties,/config,/update/json/docs,/update/csv,/replication,defaults,/get,/schema,/admin/system,/update,lazy,standard
   [junit4]   2> 1055197 INFO  (coreLoadExecutor-2236-thread-1) [    x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1055198 INFO  (coreLoadExecutor-2236-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1055198 INFO  (coreLoadExecutor-2236-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1055198 INFO  (coreLoadExecutor-2236-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=45, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=15.2373046875, floorSegmentMB=1.8271484375, forceMergeDeletesPctAllowed=29.713425864847558, segmentsPerTier=18.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.47515426154583873
   [junit4]   2> 1055198 INFO  (coreLoadExecutor-2236-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@156a8d37 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@65d20dd),segFN=segments_1,generation=1}
   [junit4]   2> 1055198 INFO  (coreLoadExecutor-2236-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1055199 INFO  (coreLoadExecutor-2236-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@b58e1f7[collection1] main
   [junit4]   2> 1055199 INFO  (coreLoadExecutor-2236-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/collection1/conf
   [junit4]   2> 1055199 INFO  (coreLoadExecutor-2236-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/collection1/conf}
   [junit4]   2> 1055199 INFO  (coreLoadExecutor-2236-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/collection1/conf
   [junit4]   2> 1055199 INFO  (coreLoadExecutor-2236-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 1055205 INFO  (coreLoadExecutor-2236-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
   [junit4]   2> 1055205 INFO  (coreLoadExecutor-2236-thread-1) [    x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 1055205 INFO  (searcherExecutor-2237-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@b58e1f7[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1055210 INFO  (qtp468051105-5868) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={wt=javabin&command=indexversion&qt=/replication&version=2} status=0 QTime=0
   [junit4]   2> 1055606 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.e.j.s.ServerConnector Stopped ServerConnector@588a1925{HTTP/1.1}{127.0.0.1:0}
   [junit4]   2> 1055607 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1603345
   [junit4]   2> 1055607 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@6f7e7ce7
   [junit4]   2> 1055608 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    x:collection1] o.a.s.u.DirectUpdateHandler2 closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
   [junit4]   2> 1055608 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
   [junit4]   2> 1055608 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 1055609 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
   [junit4]   2> 1055611 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
   [junit4]   2> 1055611 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 1055611 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/./collection1/data/index [CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/./collection1/data/index;done=false>>]
   [junit4]   2> 1055611 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/./collection1/data/index
   [junit4]   2> 1055611 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/./collection1/data [CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/./collection1/data;done=false>>]
   [junit4]   2> 1055611 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/./collection1/data
   [junit4]   2> 1055613 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    x:collection1] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@4f7630fc{/solr,null,UNAVAILABLE}
   [junit4]   2> 1055617 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.e.j.s.Server jetty-9.2.13.v20150730
   [junit4]   2> 1055621 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@697cceac{/solr,null,AVAILABLE}
   [junit4]   2> 1055622 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.e.j.s.ServerConnector Started ServerConnector@e4b44f{HTTP/1.1}{127.0.0.1:61191}
   [junit4]   2> 1055622 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.e.j.s.Server Started @1059514ms
   [junit4]   2> 1055622 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=61191, solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/collection1/data}
   [junit4]   2> 1055622 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@373ee92
   [junit4]   2> 1055622 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002'
   [junit4]   2> 1055622 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1055622 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
   [junit4]   2> 1055623 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/solr.xml
   [junit4]   2> 1055635 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/.
   [junit4]   2> 1055635 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CoreContainer New CoreContainer 1031973601
   [junit4]   2> 1055635 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002]
   [junit4]   2> 1055636 WARN  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CoreContainer Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/lib to classpath: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/lib
   [junit4]   2> 1055636 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
   [junit4]   2> 1055637 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1055637 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1055637 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1055637 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
   [junit4]   2> 1055637 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 1055638 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/.
   [junit4]   2> 1055639 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {config=solrconfig.xml, name=collection1, loadOnStartup=true, transient=false, schema=schema.xml, configSetProperties=configsetprops.json, dataDir=data/}
   [junit4]   2> 1055639 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CorePropertiesLocator Found core collection1 in /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/./collection1
   [junit4]   2> 1055640 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
   [junit4]   2> 1055641 INFO  (coreLoadExecutor-2247-thread-1) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/collection1'
   [junit4]   2> 1055641 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.s.SolrDispatchFilter user.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0
   [junit4]   2> 1055641 INFO  (coreLoadExecutor-2247-thread-1) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1055641 INFO  (coreLoadExecutor-2247-thread-1) [    ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
   [junit4]   2> 1055641 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 1055649 INFO  (coreLoadExecutor-2247-thread-1) [    ] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 1055662 INFO  (coreLoadExecutor-2247-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.5.0
   [junit4]   2> 1055689 INFO  (coreLoadExecutor-2247-thread-1) [    ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1055693 INFO  (coreLoadExecutor-2247-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1055701 INFO  (coreLoadExecutor-2247-thread-1) [    ] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1055702 INFO  (coreLoadExecutor-2247-thread-1) [    ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/collection1'
   [junit4]   2> 1055702 INFO  (coreLoadExecutor-2247-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/./collection1
   [junit4]   2> 1055703 INFO  (coreLoadExecutor-2247-thread-1) [    x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1055703 INFO  (coreLoadExecutor-2247-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/collection1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/./collection1/data/]
   [junit4]   2> 1055703 INFO  (coreLoadExecutor-2247-thread-1) [    x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
   [junit4]   2> 1055703 INFO  (coreLoadExecutor-2247-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/./collection1/data
   [junit4]   2> 1055703 INFO  (coreLoadExecutor-2247-thread-1) [    x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/./collection1/data/index/
   [junit4]   2> 1055703 WARN  (coreLoadExecutor-2247-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/./collection1/data/index' doesn't exist. Creating new index...
   [junit4]   2> 1055704 INFO  (coreLoadExecutor-2247-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/./collection1/data/index
   [junit4]   2> 1055704 INFO  (coreLoadExecutor-2247-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=34, maxMergeAtOnceExplicit=25, maxMergedSegmentMB=25.751953125, floorSegmentMB=0.642578125, forceMergeDeletesPctAllowed=17.377212696712288, segmentsPerTier=14.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5518614597198589
   [junit4]   2> 1055704 INFO  (coreLoadExecutor-2247-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@4684c5b4 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@36cfd097),segFN=segments_1,generation=1}
   [junit4]   2> 1055704 INFO  (coreLoadExecutor-2247-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1055705 INFO  (OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/./collection1/data/
   [junit4]   2> 1055707 INFO  (coreLoadExecutor-2247-thread-1) [    x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1055709 INFO  (coreLoadExecutor-2247-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1055710 INFO  (coreLoadExecutor-2247-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1055711 INFO  (coreLoadExecutor-2247-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1055712 INFO  (coreLoadExecutor-2247-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1055757 INFO  (coreLoadExecutor-2247-thread-1) [    x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy 
   [junit4]   2> 1055757 INFO  (coreLoadExecutor-2247-thread-1) [    x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/plugins,/admin/threads,/admin/logging,/admin/mbeans,/admin/ping,/admin/file,/admin/segments,/admin/luke,/update/json,/admin/properties,/config,/update/json/docs,/update/csv,/replication,defaults,/get,/schema,/admin/system,/update,lazy,standard
   [junit4]   2> 1055758 INFO  (coreLoadExecutor-2247-thread-1) [    x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1055760 INFO  (coreLoadExecutor-2247-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1055760 INFO  (coreLoadExecutor-2247-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1055760 INFO  (coreLoadExecutor-2247-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=45, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=15.2373046875, floorSegmentMB=1.8271484375, forceMergeDeletesPctAllowed=29.713425864847558, segmentsPerTier=18.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.47515426154583873
   [junit4]   2> 1055761 INFO  (coreLoadExecutor-2247-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@4684c5b4 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@36cfd097),segFN=segments_1,generation=1}
   [junit4]   2> 1055761 INFO  (coreLoadExecutor-2247-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1055761 INFO  (coreLoadExecutor-2247-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@6e6d8dcd[collection1] main
   [junit4]   2> 1055761 INFO  (coreLoadExecutor-2247-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/collection1/conf
   [junit4]   2> 1055761 INFO  (coreLoadExecutor-2247-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/collection1/conf}
   [junit4]   2> 1055761 INFO  (coreLoadExecutor-2247-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-002/collection1/conf
   [junit4]   2> 1055761 INFO  (coreLoadExecutor-2247-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 1055762 INFO  (coreLoadExecutor-2247-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1055762 INFO  (searcherExecutor-2248-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6e6d8dcd[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1055762 INFO  (coreLoadExecutor-2247-thread-1) [    x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 1056145 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-003/collection1
   [junit4]   2> 1056159 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.e.j.s.Server jetty-9.2.13.v20150730
   [junit4]   2> 1056162 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5bd26dcf{/solr,null,AVAILABLE}
   [junit4]   2> 1056163 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.e.j.s.ServerConnector Started ServerConnector@54276021{HTTP/1.1}{127.0.0.1:61192}
   [junit4]   2> 1056163 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.e.j.s.Server Started @1060055ms
   [junit4]   2> 1056163 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostPort=61192, solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-003/collection1/data, hostContext=/solr}
   [junit4]   2> 1056164 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@373ee92
   [junit4]   2> 1056164 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-003'
   [junit4]   2> 1056164 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1056164 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
   [junit4]   2> 1056164 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-003/solr.xml
   [junit4]   2> 1056194 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-003/.
   [junit4]   2> 1056195 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CoreContainer New CoreContainer 248767724
   [junit4]   2> 1056195 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-003]
   [junit4]   2> 1056195 WARN  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CoreContainer Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-003/lib to classpath: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-003/lib
   [junit4]   2> 1056195 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
   [junit4]   2> 1056199 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1056200 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1056200 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1056200 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
   [junit4]   2> 1056200 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 1056201 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-003/.
   [junit4]   2> 1056205 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {config=solrconfig.xml, configSetProperties=configsetprops.json, schema=schema.xml, loadOnStartup=true, transient=false, name=collection1, dataDir=data/}
   [junit4]   2> 1056205 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CorePropertiesLocator Found core collection1 in /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-003/./collection1
   [junit4]   2> 1056205 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
   [junit4]   2> 1056206 INFO  (coreLoadExecutor-2257-thread-1) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-003/collection1'
   [junit4]   2> 1056206 INFO  (coreLoadExecutor-2257-thread-1) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1056206 INFO  (coreLoadExecutor-2257-thread-1) [    ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
   [junit4]   2> 1056207 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.s.SolrDispatchFilter user.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0
   [junit4]   2> 1056207 INFO  (TEST-TestReplicationHandler.doTestRepeater-seed#[8B8A1A232E972CF1]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 1056222 INFO  (coreLoadExecutor-2257-thread-1) [    ] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 1056242 INFO  (coreLoadExecutor-2257-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.5.0
   [junit4]   2> 1056274 INFO  (coreLoadExecutor-2257-thread-1) [    ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1056278 INFO  (coreLoadExecutor-2257-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1056288 INFO  (coreLoadExecutor-2257-thread-1) [    ] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1056292 INFO  (coreLoadExecutor-2257-thread-1) [    ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-003/collection1'
   [junit4]   2> 1056292 INFO  (coreLoadExecutor-2257-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-003/./collection1
   [junit4]   2> 1056292 INFO  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1056293 INFO  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-003/collection1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-003/./collection1/data/]
   [junit4]   2> 1056293 INFO  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
   [junit4]   2> 1056293 INFO  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-003/./collection1/data
   [junit4]   2> 1056293 INFO  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-003/./collection1/data/index/
   [junit4]   2> 1056293 WARN  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-003/./collection1/data/index' doesn't exist. Creating new index...
   [junit4]   2> 1056293 INFO  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-003/./collection1/data/index
   [junit4]   2> 1056293 INFO  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=34, maxMergeAtOnceExplicit=25, maxMergedSegmentMB=25.751953125, floorSegmentMB=0.642578125, forceMergeDeletesPctAllowed=17.377212696712288, segmentsPerTier=14.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5518614597198589
   [junit4]   2> 1056294 INFO  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@25b4234f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@557a2adf),segFN=segments_1,generation=1}
   [junit4]   2> 1056294 INFO  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1056295 INFO  (OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-003/./collection1/data/
   [junit4]   2> 1056297 INFO  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1056304 INFO  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1056305 INFO  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1056306 INFO  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1056307 INFO  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1056309 INFO  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy 
   [junit4]   2> 1056309 INFO  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/plugins,/admin/threads,/admin/logging,/admin/mbeans,/admin/ping,/admin/file,/admin/segments,/admin/luke,/update/json,/admin/properties,/config,/update/json/docs,/update/csv,/replication,defaults,/get,/schema,/admin/system,/update,lazy,standard
   [junit4]   2> 1056311 INFO  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1056311 INFO  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1056312 INFO  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1056312 INFO  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=45, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=15.2373046875, floorSegmentMB=1.8271484375, forceMergeDeletesPctAllowed=29.713425864847558, segmentsPerTier=18.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.47515426154583873
   [junit4]   2> 1056313 INFO  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@25b4234f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@557a2adf),segFN=segments_1,generation=1}
   [junit4]   2> 1056313 INFO  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1056313 INFO  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@3561706e[collection1] main
   [junit4]   2> 1056313 INFO  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-003/collection1/conf
   [junit4]   2> 1056313 INFO  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-003/collection1/conf}
   [junit4]   2> 1056313 INFO  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_8B8A1A232E972CF1-001/solr-instance-003/collection1/conf
   [junit4]   2> 1056314 INFO  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 1056314 WARN  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix
   [junit4]   2> 1056315 INFO  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler  No value set for 'pollInterval'. Timer Task not started.
   [junit4]   2> 1056315 INFO  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml
   [junit4]   2> 1056315 INFO  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1056315 INFO  (coreLoadExecutor-2257-thread-1) [    x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 1056315 INFO  (searcherExecutor-2258-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3561706e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1056715 INFO  (qtp468051105-5870) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[0]} 0 2
   [junit4]   2> 1056718 INFO  (qtp468051105-5871) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[1]} 0 0
   [junit4]   2> 1056721 INFO  (qtp468051105-5872) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[2]} 0 0
   [junit4]   2> 1056726 INFO  (qtp468051105-5873) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1056730 INFO  (qtp468051105-5873) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@55194a21 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f51e82c),segFN=segments_1,generation=1}
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@55194a21 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f51e82c),segFN=segments_2,generation=2}
   [junit4]   2> 1056730 INFO  (qtp468051105-5873) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 2
   [junit4]   2> 1056732 INFO  (qtp468051105-5873) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@3fc8247a[collection1] main
   [junit4]   2> 1056733 INFO  (qtp468051105-5873) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1056733 INFO  (searcherExecutor-2227-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3fc8247a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.5.0):C3)))}
   [junit4]   2> 1056733 INFO  (qtp468051105-5873) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false}{commit=} 0 6
   [junit4]   2> 1056759 WARN  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix
   [junit4]   2> 1056762 INFO  (qtp468051105-5868) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={wt=javabin&command=indexversion&qt=/replication&version=2} status=0 QTime=0
   [junit4]   2> 1056763 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Master's generation: 2
   [junit4]   2> 1056763 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 1056763 INFO  (explicit-fetchindex-cmd) [    x:collection1] o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 1056765 WARN  (qtp468051105-5869) [    x:collection1] o.a.s.h.ReplicationHandler Could not read checksum from index file: _0_MockRandom_0.sd
   [junit4]   2> java.lang.ArrayIndexOutOfBoundsException: -8
   [junit4]   2> 	at org.apache.lucene.store.RAMInputStream.readByte(RAMInputStream.java:73)
   [junit4]   2> 	at org.apache.lucene.store.DataInput.readInt(DataInput.java:101)
   [junit4]   2> 	at org.apache.lucene.store.MockIndexInputWrapper.readInt(MockIndexInputWrapper.java:157)
   [junit4]   2> 	at

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

doFilter(ServletHandler.java:1652)
   [junit4]    > 	at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:110)
   [junit4]    > 	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)
   [junit4]    > 	at org.eclipse.jetty.servlets.UserAgentFilter.doFilter(UserAgentFilter.java:83)
   [junit4]    > 	at org.eclipse.jetty.servlets.GzipFilter.doFilter(GzipFilter.java:364)
   [junit4]    > 	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)
   [junit4]    > 	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:585)
   [junit4]    > 	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:221)
   [junit4]    > 	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1127)
   [junit4]    > 	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:515)
   [junit4]    > 	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
   [junit4]    > 	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1061)
   [junit4]    > 	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
   [junit4]    > 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:97)
   [junit4]    > 	at org.eclipse.jetty.server.Server.handle(Server.java:499)
   [junit4]    > 	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:310)
   [junit4]    > 	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:257)
   [junit4]    > 	at org.eclipse.jetty.io.AbstractConnection$2.run(AbstractConnection.java:540)
   [junit4]    > 	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635)
   [junit4]    > 	at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([8B8A1A232E972CF1:3DE25F9806B4109]:0)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:575)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230)
   [junit4]    > 	at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:150)
   [junit4]    > 	at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:943)
   [junit4]    > 	at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:958)
   [junit4]    > 	at org.apache.solr.TestDistributedSearch.queryRandomUpServer(TestDistributedSearch.java:1139)
   [junit4]    > 	at org.apache.solr.TestDistributedSearch.queryPartialResults(TestDistributedSearch.java:1101)
   [junit4]    > 	at org.apache.solr.TestDistributedSearch.test(TestDistributedSearch.java:974)
   [junit4]    > 	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:987)
   [junit4]    > 	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:940)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 2243158 INFO  (SUITE-TestDistributedSearch-seed#[8B8A1A232E972CF1]-worker) [    ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_8B8A1A232E972CF1-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene54): {oddField_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), id=PostingsFormat(name=MockRandom), foo_d=PostingsFormat(name=MockRandom), range_facet_l=FST50, n_d1=FST50, foo_f=PostingsFormat(name=LuceneVarGapDocFreqInterval), n_tl1=Lucene50(blocksize=128), n_tdt1=FST50, n_ti1=PostingsFormat(name=MockRandom), a_n_tdt=PostingsFormat(name=MockRandom), a_i1=FST50, _version_=FST50, n_dt1=Lucene50(blocksize=128), n_f1=Lucene50(blocksize=128), rnd_b=PostingsFormat(name=MockRandom), foo_sev_enum=PostingsFormat(name=MockRandom), lowerfilt1and2=Lucene50(blocksize=128), intDefault=FST50, foo_b=PostingsFormat(name=LuceneVarGapDocFreqInterval), severity=PostingsFormat(name=LuceneVarGapDocFreqInterval), timestamp=FST50, n_td1=Lucene50(blocksize=128), multiDefault=Lucene50(blocksize=128), range_facet_l_dv=PostingsFormat(name=MockRandom), lowerfilt=Lucene50(blocksize=128), n_l1=FST50, b_n_tdt=FST50, other_tl1=FST50, SubjectTerms_mfacet=FST50, range_facet_i_dv=FST50, n_tf1=FST50, text=PostingsFormat(name=LuceneVarGapDocFreqInterval), a_t=FST50}, docValues:{timestamp=DocValuesFormat(name=Memory), range_facet_l_dv=DocValuesFormat(name=Direct), foo_sev_enum=DocValuesFormat(name=Direct), range_facet_i_dv=DocValuesFormat(name=Memory)}, sim=RandomSimilarityProvider(queryNorm=true,coord=yes): {}, locale=es_CO, timezone=Mexico/General
   [junit4]   2> NOTE: Mac OS X 10.8.5 x86_64/Oracle Corporation 1.7.0_80 (64-bit)/cpus=3,threads=1,free=247196648,total=526385152
   [junit4]   2> NOTE: All tests run in this JVM: [TestDistribIDF, SolrIndexSplitterTest, LukeRequestHandlerTest, DistribCursorPagingTest, ConvertedLegacyTest, TestCollectionAPI, ZkSolrClientTest, HdfsWriteToMultipleCollectionsTest, DateFieldTest, SaslZkACLProviderTest, VMParamsZkACLAndCredentialsProvidersTest, CollectionsAPIDistributedZkTest, IndexSchemaRuntimeFieldTest, DefaultValueUpdateProcessorTest, TestSolrIndexConfig, DistributedVersionInfoTest, TestDistributedGrouping, TestAuthorizationFramework, TestIndexSearcher, CollectionReloadTest, LeaderElectionIntegrationTest, TestMaxScoreQueryParser, DistanceUnitsTest, HLLUtilTest, DistributedIntervalFacetingTest, DirectSolrConnectionTest, AssignTest, OpenExchangeRatesOrgProviderTest, TestSuggestSpellingConverter, CoreAdminHandlerTest, HdfsNNFailoverTest, SuggesterWFSTTest, TestConfigSetsAPIExclusivity, TestSystemIdResolver, TestRestoreCore, TestReplicaProperties, SolrCoreCheckLockOnStartupTest, BasicFunctionalityTest, LoggingHandlerTest, TestTrackingShardHandlerFactory, BinaryUpdateRequestHandlerTest, SpellCheckComponentTest, HighlighterMaxOffsetTest, DeleteInactiveReplicaTest, AnalyticsMergeStrategyTest, TestAtomicUpdateErrorCases, ZkStateWriterTest, TestLeaderElectionZkExpiry, TestRealTimeGet, BasicZkTest, SuggesterTSTTest, TestBM25SimilarityFactory, TestRandomRequestDistribution, TestFieldTypeResource, TestSimpleTrackingShardHandler, TestCryptoKeys, TestOmitPositions, TestRTimerTree, TestSolr4Spatial, HdfsBasicDistributedZkTest, SegmentsInfoRequestHandlerTest, TestRangeQuery, HdfsDirectoryTest, SharedFSAutoReplicaFailoverTest, TestJsonRequest, SimpleCollectionCreateDeleteTest, TestCharFilters, TestTrie, TestHashQParserPlugin, DistribJoinFromCollectionTest, DistributedMLTComponentTest, TestSimpleQParserPlugin, ResponseLogComponentTest, TestSolrJ, ChangedSchemaMergeTest, TestEmbeddedSolrServerConstructors, TestOrdValues, TestRecovery, NoCacheHeaderTest, OutputWriterTest, TestValueSourceCache, TestReversedWildcardFilterFactory, SolrCmdDistributorTest, DistributedExpandComponentTest, TestFastWriter, ResourceLoaderTest, CleanupOldIndexTest, TestSolr4Spatial2, TestStressUserVersions, LeaderInitiatedRecoveryOnCommitTest, TestNoOpRegenerator, TestDistributedMissingSort, TestLMJelinekMercerSimilarityFactory, SuggesterTest, MultiTermTest, TestInitParams, RecoveryAfterSoftCommitTest, AsyncMigrateRouteKeyTest, DocExpirationUpdateProcessorFactoryTest, TestAnalyzeInfixSuggestions, OverseerStatusTest, DistributedTermsComponentTest, TestUtils, ResponseHeaderTest, TestManagedResource, TestCrossCoreJoin, TestJsonFacets, TestCollapseQParserPlugin, TestManagedSchemaFieldResource, QueryResultKeyTest, TestReload, TestCloudManagedSchema, TestFileDictionaryLookup, TestSolrQueryParser, ParsingFieldUpdateProcessorsTest, TestCloudInspectUtil, SpatialHeatmapFacetsTest, TestDynamicFieldResource, PluginInfoTest, TestCollationField, ShardRoutingCustomTest, ExitableDirectoryReaderTest, MigrateRouteKeyTest, TestSchemaVersionResource, CollectionTooManyReplicasTest, TestSolrConfigHandlerConcurrent, TestExactStatsCache, SearchHandlerTest, TestAddFieldRealTimeGet, FileUtilsTest, ZkNodePropsTest, TestJoin, TermVectorComponentDistributedTest, StatsComponentTest, BasicDistributedZkTest, ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test, OpenCloseCoreStressTest, OverseerTest, RecoveryZkTest, ClusterStateUpdateTest, TestRandomFaceting, TestZkChroot, TestDistributedSearch]
   [junit4] Completed [306/558 (2!)] on J1 in 159.25s, 1 test, 1 error <<< FAILURES!

[...truncated 817 lines...]
BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:794: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:738: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:59: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build.xml:233: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/common-build.xml:526: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/lucene/common-build.xml:1456: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/lucene/common-build.xml:1010: There were test failures: 558 suites (7 ignored), 2219 tests, 1 error, 1 failure, 87 ignored (37 assumptions) [seed: 8B8A1A232E972CF1]

Total time: 85 minutes 58 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any



[JENKINS] Lucene-Solr-5.x-MacOSX (64bit/jdk1.7.0) - Build # 2913 - Still Failing!

Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-MacOSX/2913/
Java: 64bit/jdk1.7.0 -XX:-UseCompressedOops -XX:+UseParallelGC

1 tests failed.
FAILED:  org.apache.solr.handler.TestReplicationHandler.doTestStressReplication

Error Message:
timed out waiting for collection1 startAt time to exceed: Sun Dec 27 02:43:13 CST 2015

Stack Trace:
java.lang.AssertionError: timed out waiting for collection1 startAt time to exceed: Sun Dec 27 02:43:13 CST 2015
	at __randomizedtesting.SeedInfo.seed([8AC3BB462F9566EA:5168BB802ABD0F59]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.apache.solr.handler.TestReplicationHandler.watchCoreStartAt(TestReplicationHandler.java:1419)
	at org.apache.solr.handler.TestReplicationHandler.doTestStressReplication(TestReplicationHandler.java:771)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
	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:46)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	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:54)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 10465 lines...]
   [junit4] Suite: org.apache.solr.handler.TestReplicationHandler
   [junit4]   2> Creating dataDir: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/init-core-data-001
   [junit4]   2> 1421370 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.SolrTestCaseJ4 ###Starting doTestReplicateAfterWrite2Slave
   [junit4]   2> 1421370 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-001/collection1
   [junit4]   2> 1421379 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.e.j.s.Server jetty-9.2.13.v20150730
   [junit4]   2> 1421383 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@29003bc7{/solr,null,AVAILABLE}
   [junit4]   2> 1421383 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.e.j.s.ServerConnector Started ServerConnector@4e549ad8{HTTP/1.1}{127.0.0.1:63254}
   [junit4]   2> 1421383 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.e.j.s.Server Started @1425512ms
   [junit4]   2> 1421383 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostPort=63254, solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-001/collection1/data, hostContext=/solr}
   [junit4]   2> 1421384 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@532996d6
   [junit4]   2> 1421384 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-001'
   [junit4]   2> 1421384 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1421384 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
   [junit4]   2> 1421385 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-001/solr.xml
   [junit4]   2> 1421424 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-001/.
   [junit4]   2> 1421424 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.c.CoreContainer New CoreContainer 1023196536
   [junit4]   2> 1421425 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-001]
   [junit4]   2> 1421425 WARN  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.c.CoreContainer Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-001/lib to classpath: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-001/lib
   [junit4]   2> 1421425 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
   [junit4]   2> 1421428 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1421429 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1421429 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1421429 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
   [junit4]   2> 1421429 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 1421432 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-001/.
   [junit4]   2> 1421434 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {loadOnStartup=true, dataDir=data/, name=collection1, transient=false, configSetProperties=configsetprops.json, config=solrconfig.xml, schema=schema.xml}
   [junit4]   2> 1421434 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.c.CorePropertiesLocator Found core collection1 in /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-001/./collection1
   [junit4]   2> 1421434 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
   [junit4]   2> 1421435 INFO  (coreLoadExecutor-4328-thread-1) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-001/collection1'
   [junit4]   2> 1421435 INFO  (coreLoadExecutor-4328-thread-1) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1421435 INFO  (coreLoadExecutor-4328-thread-1) [    ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
   [junit4]   2> 1421436 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.s.SolrDispatchFilter user.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1
   [junit4]   2> 1421436 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 1421446 INFO  (coreLoadExecutor-4328-thread-1) [    ] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 1421457 INFO  (coreLoadExecutor-4328-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.5.0
   [junit4]   2> 1421480 INFO  (coreLoadExecutor-4328-thread-1) [    ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1421484 INFO  (coreLoadExecutor-4328-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1421503 INFO  (coreLoadExecutor-4328-thread-1) [    ] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1421507 INFO  (coreLoadExecutor-4328-thread-1) [    ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-001/collection1'
   [junit4]   2> 1421507 INFO  (coreLoadExecutor-4328-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-001/./collection1
   [junit4]   2> 1421507 INFO  (coreLoadExecutor-4328-thread-1) [    x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1421507 INFO  (coreLoadExecutor-4328-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-001/collection1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-001/./collection1/data/]
   [junit4]   2> 1421507 INFO  (coreLoadExecutor-4328-thread-1) [    x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
   [junit4]   2> 1421507 INFO  (coreLoadExecutor-4328-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-001/./collection1/data
   [junit4]   2> 1421507 INFO  (coreLoadExecutor-4328-thread-1) [    x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-001/./collection1/data/index/
   [junit4]   2> 1421507 WARN  (coreLoadExecutor-4328-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-001/./collection1/data/index' doesn't exist. Creating new index...
   [junit4]   2> 1421508 INFO  (coreLoadExecutor-4328-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-001/./collection1/data/index
   [junit4]   2> 1421508 INFO  (coreLoadExecutor-4328-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=16, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
   [junit4]   2> 1421508 INFO  (coreLoadExecutor-4328-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@726872a2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@273e245c),segFN=segments_1,generation=1}
   [junit4]   2> 1421508 INFO  (coreLoadExecutor-4328-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1421509 INFO  (OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-001/./collection1/data/
   [junit4]   2> 1421510 INFO  (coreLoadExecutor-4328-thread-1) [    x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1421515 INFO  (coreLoadExecutor-4328-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1421517 INFO  (coreLoadExecutor-4328-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1421518 INFO  (coreLoadExecutor-4328-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1421519 INFO  (coreLoadExecutor-4328-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1421521 INFO  (coreLoadExecutor-4328-thread-1) [    x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy 
   [junit4]   2> 1421521 INFO  (coreLoadExecutor-4328-thread-1) [    x:collection1] o.a.s.c.RequestHandlers Registered paths: defaults,/update,/admin/file,/admin/threads,/admin/ping,standard,/admin/properties,/update/csv,/admin/plugins,/admin/system,/update/json,lazy,/admin/mbeans,/update/json/docs,/admin/logging,/schema,/config,/replication,/get,/admin/luke,/admin/segments
   [junit4]   2> 1421522 INFO  (coreLoadExecutor-4328-thread-1) [    x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1421522 INFO  (coreLoadExecutor-4328-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1421522 INFO  (coreLoadExecutor-4328-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1421522 INFO  (coreLoadExecutor-4328-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=32, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
   [junit4]   2> 1421523 INFO  (coreLoadExecutor-4328-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@726872a2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@273e245c),segFN=segments_1,generation=1}
   [junit4]   2> 1421523 INFO  (coreLoadExecutor-4328-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1421523 INFO  (coreLoadExecutor-4328-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@2669abe1[collection1] main
   [junit4]   2> 1421523 INFO  (coreLoadExecutor-4328-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-001/collection1/conf
   [junit4]   2> 1421523 INFO  (coreLoadExecutor-4328-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-001/collection1/conf}
   [junit4]   2> 1421523 INFO  (coreLoadExecutor-4328-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-001/collection1/conf
   [junit4]   2> 1421524 INFO  (coreLoadExecutor-4328-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 1421524 INFO  (coreLoadExecutor-4328-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml,xslt/dummy.xsl
   [junit4]   2> 1421524 INFO  (coreLoadExecutor-4328-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1421524 INFO  (coreLoadExecutor-4328-thread-1) [    x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 1421524 INFO  (searcherExecutor-4329-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2669abe1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1421938 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-002/collection1
   [junit4]   2> 1421944 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.e.j.s.Server jetty-9.2.13.v20150730
   [junit4]   2> 1421948 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5f0cc94f{/solr,null,AVAILABLE}
   [junit4]   2> 1421948 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.e.j.s.ServerConnector Started ServerConnector@40749249{HTTP/1.1}{127.0.0.1:63255}
   [junit4]   2> 1421948 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.e.j.s.Server Started @1426077ms
   [junit4]   2> 1421948 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostPort=63255, solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-002/collection1/data, hostContext=/solr}
   [junit4]   2> 1421948 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@532996d6
   [junit4]   2> 1421948 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-002'
   [junit4]   2> 1421949 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1421949 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
   [junit4]   2> 1421949 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-002/solr.xml
   [junit4]   2> 1421989 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-002/.
   [junit4]   2> 1421989 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.c.CoreContainer New CoreContainer 2098466072
   [junit4]   2> 1421989 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-002]
   [junit4]   2> 1421989 WARN  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.c.CoreContainer Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-002/lib to classpath: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-002/lib
   [junit4]   2> 1421989 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
   [junit4]   2> 1421990 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1421990 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1421991 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1421991 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
   [junit4]   2> 1421991 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 1421992 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-002/.
   [junit4]   2> 1421993 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {loadOnStartup=true, name=collection1, dataDir=data/, config=solrconfig.xml, schema=schema.xml, transient=false, configSetProperties=configsetprops.json}
   [junit4]   2> 1421993 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.c.CorePropertiesLocator Found core collection1 in /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-002/./collection1
   [junit4]   2> 1421993 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
   [junit4]   2> 1421994 INFO  (coreLoadExecutor-4338-thread-1) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-002/collection1'
   [junit4]   2> 1421994 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.s.SolrDispatchFilter user.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1
   [junit4]   2> 1421994 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8AC3BB462F9566EA]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 1421994 INFO  (coreLoadExecutor-4338-thread-1) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1421994 INFO  (coreLoadExecutor-4338-thread-1) [    ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
   [junit4]   2> 1422003 INFO  (coreLoadExecutor-4338-thread-1) [    ] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 1422020 INFO  (coreLoadExecutor-4338-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.5.0
   [junit4]   2> 1422055 INFO  (coreLoadExecutor-4338-thread-1) [    ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1422061 INFO  (coreLoadExecutor-4338-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1422073 INFO  (coreLoadExecutor-4338-thread-1) [    ] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1422076 INFO  (coreLoadExecutor-4338-thread-1) [    ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-002/collection1'
   [junit4]   2> 1422076 INFO  (coreLoadExecutor-4338-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-002/./collection1
   [junit4]   2> 1422076 INFO  (coreLoadExecutor-4338-thread-1) [    x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1422076 INFO  (coreLoadExecutor-4338-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-002/collection1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-002/./collection1/data/]
   [junit4]   2> 1422077 INFO  (coreLoadExecutor-4338-thread-1) [    x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
   [junit4]   2> 1422077 INFO  (coreLoadExecutor-4338-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-002/./collection1/data
   [junit4]   2> 1422077 INFO  (coreLoadExecutor-4338-thread-1) [    x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-002/./collection1/data/index/
   [junit4]   2> 1422077 WARN  (coreLoadExecutor-4338-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-002/./collection1/data/index' doesn't exist. Creating new index...
   [junit4]   2> 1422077 INFO  (coreLoadExecutor-4338-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-002/./collection1/data/index
   [junit4]   2> 1422078 INFO  (coreLoadExecutor-4338-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=16, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
   [junit4]   2> 1422078 INFO  (coreLoadExecutor-4338-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@4a9e0b5e lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4dfc6e97),segFN=segments_1,generation=1}
   [junit4]   2> 1422078 INFO  (coreLoadExecutor-4338-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1422079 INFO  (OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-002/./collection1/data/
   [junit4]   2> 1422081 INFO  (coreLoadExecutor-4338-thread-1) [    x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1422083 INFO  (coreLoadExecutor-4338-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1422084 INFO  (coreLoadExecutor-4338-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1422085 INFO  (coreLoadExecutor-4338-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1422087 INFO  (coreLoadExecutor-4338-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1422088 INFO  (coreLoadExecutor-4338-thread-1) [    x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy 
   [junit4]   2> 1422088 INFO  (coreLoadExecutor-4338-thread-1) [    x:collection1] o.a.s.c.RequestHandlers Registered paths: defaults,/update,/admin/file,/admin/threads,/admin/ping,standard,/admin/properties,/update/csv,/admin/plugins,/admin/system,/update/json,lazy,/admin/mbeans,/update/json/docs,/admin/logging,/schema,/config,/replication,/get,/admin/luke,/admin/segments
   [junit4]   2> 1422089 INFO  (coreLoadExecutor-4338-thread-1) [    x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1422090 INFO  (coreLoadExecutor-4338-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1422090 INFO  (coreLoadExecutor-4338-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1422090 INFO  (coreLoadExecutor-4338-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=32, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
   [junit4]   2> 1422090 INFO  (coreLoadExecutor-4338-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@4a9e0b5e lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4dfc6e97),segFN=segments_1,generation=1}
   [junit4]   2> 1422090 INFO  (coreLoadExecutor-4338-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1422091 INFO  (coreLoadExecutor-4338-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@2755d02d[collection1] main
   [junit4]   2> 1422091 INFO  (coreLoadExecutor-4338-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-002/collection1/conf
   [junit4]   2> 1422091 INFO  (coreLoadExecutor-4338-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-002/collection1/conf}
   [junit4]   2> 1422091 INFO  (coreLoadExecutor-4338-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-002/collection1/conf
   [junit4]   2> 1422091 INFO  (coreLoadExecutor-4338-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 1422095 INFO  (coreLoadExecutor-4338-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
   [junit4]   2> 1422095 INFO  (coreLoadExecutor-4338-thread-1) [    x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 1422095 INFO  (searcherExecutor-4339-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2755d02d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1422500 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/solr path=/select params={q=*:*&version=2&wt=javabin&sort=id+desc} hits=0 status=0 QTime=0
   [junit4]   2> 1422503 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[0]} 0 0
   [junit4]   2> 1422507 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[1]} 0 0
   [junit4]   2> 1422510 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[2]} 0 0
   [junit4]   2> 1422514 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[3]} 0 0
   [junit4]   2> 1422519 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[4]} 0 0
   [junit4]   2> 1422522 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[5]} 0 0
   [junit4]   2> 1422525 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[6]} 0 0
   [junit4]   2> 1422529 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[7]} 0 0
   [junit4]   2> 1422532 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[8]} 0 0
   [junit4]   2> 1422535 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[9]} 0 0
   [junit4]   2> 1422538 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[10]} 0 1
   [junit4]   2> 1422543 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[11]} 0 0
   [junit4]   2> 1422545 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[12]} 0 0
   [junit4]   2> 1422548 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[13]} 0 0
   [junit4]   2> 1422552 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[14]} 0 0
   [junit4]   2> 1422556 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[15]} 0 0
   [junit4]   2> 1422558 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[16]} 0 0
   [junit4]   2> 1422560 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[17]} 0 0
   [junit4]   2> 1422563 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[18]} 0 0
   [junit4]   2> 1422566 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[19]} 0 0
   [junit4]   2> 1422568 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[20]} 0 0
   [junit4]   2> 1422570 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[21]} 0 0
   [junit4]   2> 1422573 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[22]} 0 0
   [junit4]   2> 1422576 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[23]} 0 0
   [junit4]   2> 1422578 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[24]} 0 0
   [junit4]   2> 1422581 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[25]} 0 0
   [junit4]   2> 1422583 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[26]} 0 0
   [junit4]   2> 1422586 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[27]} 0 0
   [junit4]   2> 1422589 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[28]} 0 0
   [junit4]   2> 1422594 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[29]} 0 0
   [junit4]   2> 1422598 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[30]} 0 0
   [junit4]   2> 1422600 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[31]} 0 0
   [junit4]   2> 1422602 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[32]} 0 0
   [junit4]   2> 1422605 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[33]} 0 0
   [junit4]   2> 1422607 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[34]} 0 0
   [junit4]   2> 1422610 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[35]} 0 0
   [junit4]   2> 1422612 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[36]} 0 0
   [junit4]   2> 1422614 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[37]} 0 0
   [junit4]   2> 1422616 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[38]} 0 0
   [junit4]   2> 1422619 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[39]} 0 0
   [junit4]   2> 1422621 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[40]} 0 0
   [junit4]   2> 1422624 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[41]} 0 0
   [junit4]   2> 1422627 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[42]} 0 0
   [junit4]   2> 1422629 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[43]} 0 0
   [junit4]   2> 1422632 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[44]} 0 0
   [junit4]   2> 1422634 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[45]} 0 0
   [junit4]   2> 1422637 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[46]} 0 0
   [junit4]   2> 1422640 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[47]} 0 0
   [junit4]   2> 1422642 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[48]} 0 0
   [junit4]   2> 1422648 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[49]} 0 3
   [junit4]   2> 1422652 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[50]} 0 1
   [junit4]   2> 1422655 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[51]} 0 0
   [junit4]   2> 1422658 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[52]} 0 0
   [junit4]   2> 1422660 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[53]} 0 0
   [junit4]   2> 1422664 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[54]} 0 0
   [junit4]   2> 1422668 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[55]} 0 0
   [junit4]   2> 1422671 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[56]} 0 0
   [junit4]   2> 1422674 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[57]} 0 0
   [junit4]   2> 1422676 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[58]} 0 0
   [junit4]   2> 1422679 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[59]} 0 0
   [junit4]   2> 1422681 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[60]} 0 0
   [junit4]   2> 1422684 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[61]} 0 0
   [junit4]   2> 1422686 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[62]} 0 0
   [junit4]   2> 1422689 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[63]} 0 0
   [junit4]   2> 1422692 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[64]} 0 0
   [junit4]   2> 1422695 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[65]} 0 0
   [junit4]   2> 1422699 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[66]} 0 0
   [junit4]   2> 1422704 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[67]} 0 0
   [junit4]   2> 1422706 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[68]} 0 0
   [junit4]   2> 1422709 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[69]} 0 0
   [junit4]   2> 1422712 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[70]} 0 0
   [junit4]   2> 1422715 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[71]} 0 0
   [junit4]   2> 1422719 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[72]} 0 0
   [junit4]   2> 1422723 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[73]} 0 0
   [junit4]   2> 1422726 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[74]} 0 0
   [junit4]   2> 1422728 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[75]} 0 0
   [junit4]   2> 1422731 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[76]} 0 0
   [junit4]   2> 1422735 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[77]} 0 0
   [junit4]   2> 1422739 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[78]} 0 0
   [junit4]   2> 1422741 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[79]} 0 0
   [junit4]   2> 1422744 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[80]} 0 0
   [junit4]   2> 1422747 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[81]} 0 0
   [junit4]   2> 1422749 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[82]} 0 0
   [junit4]   2> 1422751 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[83]} 0 0
   [junit4]   2> 1422755 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[84]} 0 0
   [junit4]   2> 1422759 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[85]} 0 0
   [junit4]   2> 1422764 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[86]} 0 0
   [junit4]   2> 1422767 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[87]} 0 0
   [junit4]   2> 1422769 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[88]} 0 0
   [junit4]   2> 1422772 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[89]} 0 0
   [junit4]   2> 1422774 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[90]} 0 0
   [junit4]   2> 1422778 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[91]} 0 0
   [junit4]   2> 1422780 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[92]} 0 0
   [junit4]   2> 1422783 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[93]} 0 0
   [junit4]   2> 1422785 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[94]} 0 0
   [junit4]   2> 1422787 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[95]} 0 0
   [junit4]   2> 1422790 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[96]} 0 0
   [junit4]   2> 1422792 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[97]} 0 0
   [junit4]   2> 1422795 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[98]} 0 0
   [junit4]   2> 1422799 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[99]} 0 1
   [junit4]   2> 1422803 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[100]} 0 0
   [junit4]   2> 1422806 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[101]} 0 0
   [junit4]   2> 1422809 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[102]} 0 0
   [junit4]   2> 1422811 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[103]} 0 0
   [junit4]   2> 1422814 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[104]} 0 0
   [junit4]   2> 1422816 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[105]} 0 0
   [junit4]   2> 1422818 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[106]} 0 0
   [junit4]   2> 1422824 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[107]} 0 0
   [junit4]   2> 1422827 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[108]} 0 0
   [junit4]   2> 1422829 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[109]} 0 0
   [junit4]   2> 1422832 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[110]} 0 0
   [junit4]   2> 1422834 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[111]} 0 0
   [junit4]   2> 1422837 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[112]} 0 0
   [junit4]   2> 1422840 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[113]} 0 0
   [junit4]   2> 1422842 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[114]} 0 0
   [junit4]   2> 1422845 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[115]} 0 0
   [junit4]   2> 1422848 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[116]} 0 0
   [junit4]   2> 1422851 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[117]} 0 0
   [junit4]   2> 1422853 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[118]} 0 0
   [junit4]   2> 1422858 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[119]} 0 0
   [junit4]   2> 1422862 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[120]} 0 0
   [junit4]   2> 1422865 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[121]} 0 0
   [junit4]   2> 1422869 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[122]} 0 0
   [junit4]   2> 1422871 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[123]} 0 0
   [junit4]   2> 1422874 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[124]} 0 0
   [junit4]   2> 1422877 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[125]} 0 0
   [junit4]   2> 1422879 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[126]} 0 0
   [junit4]   2> 1422885 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[127]} 0 0
   [junit4]   2> 1422888 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[128]} 0 0
   [junit4]   2> 1422891 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[129]} 0 0
   [junit4]   2> 1422894 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[130]} 0 0
   [junit4]   2> 1422899 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[131]} 0 0
   [junit4]   2> 1422901 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[132]} 0 0
   [junit4]   2> 1422904 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[133]} 0 0
   [junit4]   2> 1422906 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[134]} 0 0
   [junit4]   2> 1422909 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[135]} 0 0
   [junit4]   2> 1422913 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[136]} 0 0
   [junit4]   2> 1422915 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[137]} 0 0
   [junit4]   2> 1422918 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[138]} 0 0
   [junit4]   2> 1422920 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[139]} 0 0
   [junit4]   2> 1422925 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[140]} 0 0
   [junit4]   2> 1422927 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[141]} 0 0
   [junit4]   2> 1422930 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[142]} 0 0
   [junit4]   2> 1422932 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[143]} 0 0
   [junit4]   2> 1422935 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[144]} 0 0
   [junit4]   2> 1422938 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[145]} 0 0
   [junit4]   2> 1422940 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[146]} 0 0
   [junit4]   2> 1422945 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[147]} 0 0
   [junit4]   2> 1422948 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[148]} 0 0
   [junit4]   2> 1422955 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[149]} 0 1
   [junit4]   2> 1422958 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[150]} 0 0
   [junit4]   2> 1422961 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[151]} 0 0
   [junit4]   2> 1422964 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[152]} 0 0
   [junit4]   2> 1422969 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[153]} 0 0
   [junit4]   2> 1422971 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[154]} 0 0
   [junit4]   2> 1422974 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[155]} 0 0
   [junit4]   2> 1422979 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[156]} 0 0
   [junit4]   2> 1422981 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[157]} 0 0
   [junit4]   2> 1422984 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[158]} 0 0
   [junit4]   2> 1422986 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[159]} 0 0
   [junit4]   2> 1422989 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[160]} 0 0
   [junit4]   2> 1422991 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[161]} 0 0
   [junit4]   2> 1422994 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[162]} 0 0
   [junit4]   2> 1422999 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[163]} 0 0
   [junit4]   2> 1423004 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[164]} 0 0
   [junit4]   2> 1423008 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[165]} 0 0
   [junit4]   2> 1423010 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[166]} 0 0
   [junit4]   2> 1423015 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[167]} 0 0
   [junit4]   2> 1423019 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[168]} 0 0
   [junit4]   2> 1423021 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[169]} 0 0
   [junit4]   2> 1423023 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[170]} 0 0
   [junit4]   2> 1423029 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[171]} 0 0
   [junit4]   2> 1423031 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[172]} 0 0
   [junit4]   2> 1423034 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[173]} 0 0
   [junit4]   2> 1423039 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[174]} 0 0
   [junit4]   2> 1423042 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[175]} 0 0
   [junit4]   2> 1423045 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[176]} 0 0
   [junit4]   2> 1423049 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[177]} 0 0
   [junit4]   2> 1423051 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[178]} 0 0
   [junit4]   2> 1423054 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[179]} 0 0
   [junit4]   2> 1423056 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[180]} 0 0
   [junit4]   2> 1423059 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[181]} 0 0
   [junit4]   2> 1423061 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[182]} 0 0
   [junit4]   2> 1423066 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[183]} 0 0
   [junit4]   2> 1423068 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={version=2&wt=javabin&qt=/replication&command=indexversion} status=0 QTime=0
   [junit4]   2> 1423069 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[184]} 0 0
   [junit4]   2> 1423073 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[185]} 0 0
   [junit4]   2> 1423075 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[186]} 0 0
   [junit4]   2> 1423078 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[187]} 0 0
   [junit4]   2> 1423080 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[188]} 0 0
   [junit4]   2> 1423083 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[189]} 0 0
   [junit4]   2> 1423087 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[190]} 0 0
   [junit4]   2> 1423091 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[191]} 0 0
   [junit4]   2> 1423094 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[192]} 0 0
   [junit4]   2> 1423097 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[193]} 0 0
   [junit4]   2> 1423099 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[194]} 0 0
   [junit4]   2> 1423103 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[195]} 0 0
   [junit4]   2> 1423106 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[196]} 0 0
   [junit4]   2> 1423108 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[197]} 0 0
   [junit4]   2> 1423111 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[198]} 0 0
   [junit4]   2> 1423115 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[199]} 0 1
   [junit4]   2> 1423118 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[200]} 0 0
   [junit4]   2> 1423120 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[201]} 0 0
   [junit4]   2> 1423122 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[202]} 0 0
   [junit4]   2> 1423125 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[203]} 0 0
   [junit4]   2> 1423127 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[204]} 0 0
   [junit4]   2> 1423130 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[205]} 0 0
   [junit4]   2> 1423132 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[206]} 0 0
   [junit4]   2> 1423134 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[207]} 0 0
   [junit4]   2> 1423137 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[208]} 0 0
   [junit4]   2> 1423140 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[209]} 0 0
   [junit4]   2> 1423142 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[210]} 0 0
   [junit4]   2> 1423144 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[211]} 0 0
   [junit4]   2> 1423149 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[212]} 0 0
   [junit4]   2> 1423154 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[213]} 0 0
   [junit4]   2> 1423157 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[214]} 0 0
   [junit4]   2> 1423159 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[215]} 0 0
   [junit4]   2> 1423162 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[216]} 0 0
   [junit4]   2> 1423165 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[217]} 0 0
   [junit4]   2> 1423168 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[218]} 0 0
   [junit4]   2> 1423174 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[219]} 0 0
   [junit4]   2> 1423177 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[220]} 0 0
   [junit4]   2> 1423179 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[221]} 0 0
   [junit4]   2> 1423181 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[222]} 0 0
   [junit4]   2> 1423184 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[223]} 0 0
   [junit4]   2> 1423188 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[224]} 0 0
   [junit4]   2> 1423190 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[225]} 0 0
   [junit4]   2> 1423195 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[226]} 0 0
   [junit4]   2> 1423197 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[227]} 0 0
   [junit4]   2> 1423200 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[228]} 0 0
   [junit4]   2> 1423203 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[229]} 0 0
   [junit4]   2> 1423205 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[230]} 0 0
   [junit4]   2> 1423209 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[231]} 0 0
   [junit4]   2> 1423211 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[232]} 0 0
   [junit4]   2> 1423214 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[233]} 0 0
   [junit4]   2> 1423219 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[234]} 0 0
   [junit4]   2> 1423221 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[235]} 0 0
   [junit4]   2> 1423224 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[236]} 0 0
   [junit4]   2> 1423229 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[237]} 0 0
   [junit4]   2> 1423232 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[238]} 0 0
   [junit4]   2> 1423235 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[239]} 0 0
   [junit4]   2> 1423237 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[240]} 0 0
   [junit4]   2> 1423240 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[241]} 0 0
   [junit4]   2> 1423245 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[242]} 0 0
   [junit4]   2> 1423249 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[243]} 0 0
   [junit4]   2> 1423254 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[244]} 0 0
   [junit4]   2> 1423257 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[245]} 0 0
   [junit4]   2> 1423260 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[246]} 0 0
   [junit4]   2> 1423262 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[247]} 0 0
   [junit4]   2> 1423264 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[248]} 0 0
   [junit4]   2> 1423268 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[249]} 0 1
   [junit4]   2> 1423270 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[250]} 0 0
   [junit4]   2> 1423274 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[251]} 0 0
   [junit4]   2> 1423277 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[252]} 0 0
   [junit4]   2> 1423279 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[253]} 0 0
   [junit4]   2> 1423282 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[254]} 0 0
   [junit4]   2> 1423284 INFO  (qtp806355792-8920) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[255]} 0 0
   [junit4]   2> 1423287 INFO  (qtp806355792-8915) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[256]} 0 0
   [junit4]   2> 1423289 INFO  (qtp806355792-8916) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[257]} 0 0
   [junit4]   2> 1423295 INFO  (qtp806355792-8917) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[258]} 0 0
   [junit4]   2> 1423297 INFO  (qtp806355792-8918) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={version=2&wt=javabin}{add=[259]} 0 0
   [junit4]   2> 1423300 INFO  (qtp806355792-8919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/updat

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

ervletContextHandler@470ca6fe{/solr,null,UNAVAILABLE}
   [junit4]   2> 1528760 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[8AC3BB462F9566EA]) [    ] o.e.j.s.ServerConnector Stopped ServerConnector@6199cfaa{HTTP/1.1}{127.0.0.1:0}
   [junit4]   2> 1528760 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[8AC3BB462F9566EA]) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=126010404
   [junit4]   2> 1528761 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[8AC3BB462F9566EA]) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@769f6062
   [junit4]   2> 1528762 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[8AC3BB462F9566EA]) [    x:collection1] o.a.s.u.DirectUpdateHandler2 closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
   [junit4]   2> 1528762 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[8AC3BB462F9566EA]) [    x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
   [junit4]   2> 1528762 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[8AC3BB462F9566EA]) [    x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 1528762 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[8AC3BB462F9566EA]) [    x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
   [junit4]   2> 1528764 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[8AC3BB462F9566EA]) [    x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
   [junit4]   2> 1528766 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[8AC3BB462F9566EA]) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing NRTCachingDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 1528766 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[8AC3BB462F9566EA]) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-028/collection1/data [CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-028/collection1/data;done=false>>]
   [junit4]   2> 1528766 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[8AC3BB462F9566EA]) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-028/collection1/data
   [junit4]   2> 1528766 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[8AC3BB462F9566EA]) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-028/collection1/data/index [CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-028/collection1/data/index;done=false>>]
   [junit4]   2> 1528766 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[8AC3BB462F9566EA]) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001/solr-instance-028/collection1/data/index
   [junit4]   2> 1528767 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[8AC3BB462F9566EA]) [    x:collection1] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@321c5331{/solr,null,UNAVAILABLE}
   [junit4]   2> 1528769 INFO  (SUITE-TestReplicationHandler-seed#[8AC3BB462F9566EA]-worker) [    ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_8AC3BB462F9566EA-001
   [junit4]   2> NOTE: test params are: codec=FastCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST, chunkSize=14, maxDocsPerChunk=10, blockSize=923), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST, chunkSize=14, blockSize=923)), sim=RandomSimilarityProvider(queryNorm=false,coord=yes): {}, locale=fi, timezone=Asia/Chungking
   [junit4]   2> NOTE: Mac OS X 10.8.5 x86_64/Oracle Corporation 1.7.0_80 (64-bit)/cpus=3,threads=1,free=141959296,total=512753664
   [junit4]   2> NOTE: All tests run in this JVM: [WordBreakSolrSpellCheckerTest, DistribCursorPagingTest, TestIndexSearcher, DateFieldTest, OpenCloseCoreStressTest, TestDynamicFieldResource, SortByFunctionTest, TestClusterStateMutator, DistributedSuggestComponentTest, TestSolr4Spatial, SpatialHeatmapFacetsTest, InfoHandlerTest, LoggingHandlerTest, HLLUtilTest, MultiTermTest, AtomicUpdatesTest, TestHighFrequencyDictionaryFactory, NotRequiredUniqueKeyTest, TestUniqueKeyFieldResource, TestFieldTypeResource, ConvertedLegacyTest, CurrencyFieldOpenExchangeTest, TestTrie, DistributedMLTComponentTest, TestFuzzyAnalyzedSuggestions, TestCoreDiscovery, TestCollationField, LeaderElectionIntegrationTest, TestOmitPositions, HighlighterConfigTest, UpdateRequestProcessorFactoryTest, TestRestoreCore, BasicAuthIntegrationTest, ShardRoutingCustomTest, TestMaxScoreQueryParser, ShowFileRequestHandlerTest, DistanceUnitsTest, TestConfigSetsAPIExclusivity, TestFastOutputStream, SuggesterTSTTest, HdfsBasicDistributedZkTest, TestSolrCoreProperties, SolrCmdDistributorTest, TestSchemaResource, AnalyticsMergeStrategyTest, SolrXmlInZkTest, TestCrossCoreJoin, SimpleMLTQParserTest, StatsComponentTest, CursorMarkTest, TestRTimerTree, TestHashQParserPlugin, TestExceedMaxTermLength, TestRandomFaceting, BasicFunctionalityTest, TestRealTimeGet, HdfsRecoveryZkTest, TestLMJelinekMercerSimilarityFactory, DistributedFacetPivotSmallTest, ResourceLoaderTest, NumericFieldsTest, OutputWriterTest, MigrateRouteKeyTest, TestClassNameShortening, DistributedIntervalFacetingTest, TestManagedResource, BasicDistributedZk2Test, DefaultValueUpdateProcessorTest, RulesTest, SpellCheckCollatorTest, ZkStateWriterTest, TestBadConfig, TestDistribIDF, ResponseLogComponentTest, TestRuleBasedAuthorizationPlugin, TestSolrQueryParser, TestStressRecovery, TestReloadAndDeleteDocs, HighlighterMaxOffsetTest, TestCloudSchemaless, TestValueSourceCache, LukeRequestHandlerTest, BigEndianAscendingWordDeserializerTest, SpatialRPTFieldTypeTest, VersionInfoTest, BadIndexSchemaTest, TestSolrConfigHandler, TestLeaderElectionZkExpiry, TestEmbeddedSolrServerConstructors, ChaosMonkeySafeLeaderTest, TestFiltering, FieldAnalysisRequestHandlerTest, TestReRankQParserPlugin, TestQueryUtils, SaslZkACLProviderTest, TermVectorComponentTest, TestIndexingPerformance, VMParamsZkACLAndCredentialsProvidersTest, DistribJoinFromCollectionTest, DistributedFacetPivotLongTailTest, OverseerStatusTest, TestAuthorizationFramework, TestDownShardTolerantSearch, DeleteReplicaTest, ActionThrottleTest, OverseerCollectionConfigSetProcessorTest, TestZkChroot, HdfsDirectoryTest, BasicZkTest, NoCacheHeaderTest, TestSolrCloudWithKerberosAlt, TestReplicationHandlerBackup, DocExpirationUpdateProcessorFactoryTest, TestConfigSets, DocValuesMissingTest, QueryResultKeyTest, BitVectorTest, FileUtilsTest, TestSolrQueryResponse, TestManagedSchema, TestRandomCollapseQParserPlugin, TestSolrDeletionPolicy2, TestJoin, TestFileDictionaryLookup, TestTrackingShardHandlerFactory, HdfsChaosMonkeySafeLeaderTest, ChangedSchemaMergeTest, HdfsWriteToMultipleCollectionsTest, ConnectionManagerTest, TestExpandComponent, TestBM25SimilarityFactory, OpenExchangeRatesOrgProviderTest, IndexSchemaRuntimeFieldTest, ZkNodePropsTest, DistributedTermsComponentTest, AsyncMigrateRouteKeyTest, OverseerTest, ShardRoutingTest, TestReplicationHandler]
   [junit4] Completed [287/558 (1!)] on J1 in 107.43s, 13 tests, 1 failure <<< FAILURES!

[...truncated 861 lines...]
BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:794: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:738: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:59: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build.xml:233: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/common-build.xml:526: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/lucene/common-build.xml:1456: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/lucene/common-build.xml:1010: There were test failures: 558 suites (7 ignored), 2219 tests, 1 failure, 87 ignored (37 assumptions) [seed: 8AC3BB462F9566EA]

Total time: 79 minutes 4 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any