Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-5.4/3/
3 tests failed. FAILED: org.apache.solr.handler.TestReplicationHandler.doTestIndexFetchWithMasterUrl Error Message: Timeout occured while waiting response from server at: http://127.0.0.1:51104/solr/collection1 Stack Trace: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:51104/solr/collection1 at __randomizedtesting.SeedInfo.seed([AEE36FAB3C1AB230:B5589ED45DA5CA86]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:584) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:240) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:229) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:150) at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:174) at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:139) at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:153) at org.apache.solr.handler.TestReplicationHandler.index(TestReplicationHandler.java:169) at org.apache.solr.handler.TestReplicationHandler.doTestIndexFetchWithMasterUrl(TestReplicationHandler.java:659) 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) Caused by: java.net.SocketTimeoutException: Read timed out at java.net.SocketInputStream.socketRead0(Native Method) at java.net.SocketInputStream.read(SocketInputStream.java:152) at java.net.SocketInputStream.read(SocketInputStream.java:122) at org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160) at org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84) at org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273) at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140) at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57) at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261) at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283) at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251) at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197) at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272) at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124) at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685) at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487) at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:479) ... 47 more FAILED: junit.framework.TestSuite.org.apache.solr.handler.TestReplicationHandler Error Message: 2 threads leaked from SUITE scope at org.apache.solr.handler.TestReplicationHandler: 1) Thread[id=25191, name=searcherExecutor-4769-thread-1, state=WAITING, group=TGRP-TestReplicationHandler] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) at java.lang.Thread.run(Thread.java:745) 2) Thread[id=25178, name=qtp850712954-25178, state=TIMED_WAITING, group=TGRP-TestReplicationHandler] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226) at java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedNanos(AbstractQueuedSynchronizer.java:1033) at java.util.concurrent.locks.AbstractQueuedSynchronizer.tryAcquireSharedNanos(AbstractQueuedSynchronizer.java:1326) at java.util.concurrent.locks.ReentrantReadWriteLock$ReadLock.tryLock(ReentrantReadWriteLock.java:873) at org.apache.solr.update.DefaultSolrCoreState.lock(DefaultSolrCoreState.java:150) at org.apache.solr.update.DefaultSolrCoreState.getIndexWriter(DefaultSolrCoreState.java:95) at org.apache.solr.update.DirectUpdateHandler2.doNormalUpdate(DirectUpdateHandler2.java:261) at org.apache.solr.update.DirectUpdateHandler2.addDoc0(DirectUpdateHandler2.java:202) at org.apache.solr.update.DirectUpdateHandler2.addDoc(DirectUpdateHandler2.java:164) at org.apache.solr.update.processor.RunUpdateProcessor.processAdd(RunUpdateProcessorFactory.java:69) at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:51) at org.apache.solr.update.processor.DistributedUpdateProcessor.versionAdd(DistributedUpdateProcessor.java:949) at org.apache.solr.update.processor.DistributedUpdateProcessor.processAdd(DistributedUpdateProcessor.java:701) at org.apache.solr.update.processor.LogUpdateProcessor.processAdd(LogUpdateProcessorFactory.java:104) at org.apache.solr.handler.loader.XMLLoader.processUpdate(XMLLoader.java:250) at org.apache.solr.handler.loader.XMLLoader.load(XMLLoader.java:177) at org.apache.solr.handler.UpdateRequestHandler$1.load(UpdateRequestHandler.java:98) at org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:74) at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:151) at org.apache.solr.core.SolrCore.execute(SolrCore.java:2072) at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:654) at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:455) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:221) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:180) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652) at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:109) 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:300) 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: com.carrotsearch.randomizedtesting.ThreadLeakError: 2 threads leaked from SUITE scope at org.apache.solr.handler.TestReplicationHandler: 1) Thread[id=25191, name=searcherExecutor-4769-thread-1, state=WAITING, group=TGRP-TestReplicationHandler] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) at java.lang.Thread.run(Thread.java:745) 2) Thread[id=25178, name=qtp850712954-25178, state=TIMED_WAITING, group=TGRP-TestReplicationHandler] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226) at java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedNanos(AbstractQueuedSynchronizer.java:1033) at java.util.concurrent.locks.AbstractQueuedSynchronizer.tryAcquireSharedNanos(AbstractQueuedSynchronizer.java:1326) at java.util.concurrent.locks.ReentrantReadWriteLock$ReadLock.tryLock(ReentrantReadWriteLock.java:873) at org.apache.solr.update.DefaultSolrCoreState.lock(DefaultSolrCoreState.java:150) at org.apache.solr.update.DefaultSolrCoreState.getIndexWriter(DefaultSolrCoreState.java:95) at org.apache.solr.update.DirectUpdateHandler2.doNormalUpdate(DirectUpdateHandler2.java:261) at org.apache.solr.update.DirectUpdateHandler2.addDoc0(DirectUpdateHandler2.java:202) at org.apache.solr.update.DirectUpdateHandler2.addDoc(DirectUpdateHandler2.java:164) at org.apache.solr.update.processor.RunUpdateProcessor.processAdd(RunUpdateProcessorFactory.java:69) at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:51) at org.apache.solr.update.processor.DistributedUpdateProcessor.versionAdd(DistributedUpdateProcessor.java:949) at org.apache.solr.update.processor.DistributedUpdateProcessor.processAdd(DistributedUpdateProcessor.java:701) at org.apache.solr.update.processor.LogUpdateProcessor.processAdd(LogUpdateProcessorFactory.java:104) at org.apache.solr.handler.loader.XMLLoader.processUpdate(XMLLoader.java:250) at org.apache.solr.handler.loader.XMLLoader.load(XMLLoader.java:177) at org.apache.solr.handler.UpdateRequestHandler$1.load(UpdateRequestHandler.java:98) at org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:74) at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:151) at org.apache.solr.core.SolrCore.execute(SolrCore.java:2072) at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:654) at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:455) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:221) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:180) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652) at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:109) 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:300) 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([AEE36FAB3C1AB230]:0) FAILED: junit.framework.TestSuite.org.apache.solr.handler.TestReplicationHandler Error Message: There are still zombie threads that couldn't be terminated: 1) Thread[id=25178, name=qtp850712954-25178, state=TIMED_WAITING, group=TGRP-TestReplicationHandler] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226) at java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedNanos(AbstractQueuedSynchronizer.java:1033) at java.util.concurrent.locks.AbstractQueuedSynchronizer.tryAcquireSharedNanos(AbstractQueuedSynchronizer.java:1326) at java.util.concurrent.locks.ReentrantReadWriteLock$ReadLock.tryLock(ReentrantReadWriteLock.java:873) at org.apache.solr.update.DefaultSolrCoreState.lock(DefaultSolrCoreState.java:150) at org.apache.solr.update.DefaultSolrCoreState.getIndexWriter(DefaultSolrCoreState.java:95) at org.apache.solr.update.DirectUpdateHandler2.doNormalUpdate(DirectUpdateHandler2.java:261) at org.apache.solr.update.DirectUpdateHandler2.addDoc0(DirectUpdateHandler2.java:202) at org.apache.solr.update.DirectUpdateHandler2.addDoc(DirectUpdateHandler2.java:164) at org.apache.solr.update.processor.RunUpdateProcessor.processAdd(RunUpdateProcessorFactory.java:69) at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:51) at org.apache.solr.update.processor.DistributedUpdateProcessor.versionAdd(DistributedUpdateProcessor.java:949) at org.apache.solr.update.processor.DistributedUpdateProcessor.processAdd(DistributedUpdateProcessor.java:701) at org.apache.solr.update.processor.LogUpdateProcessor.processAdd(LogUpdateProcessorFactory.java:104) at org.apache.solr.handler.loader.XMLLoader.processUpdate(XMLLoader.java:250) at org.apache.solr.handler.loader.XMLLoader.load(XMLLoader.java:177) at org.apache.solr.handler.UpdateRequestHandler$1.load(UpdateRequestHandler.java:98) at org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:74) at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:151) at org.apache.solr.core.SolrCore.execute(SolrCore.java:2072) at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:654) at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:455) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:221) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:180) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652) at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:109) 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:300) 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) 2) Thread[id=25191, name=searcherExecutor-4769-thread-1, state=WAITING, group=TGRP-TestReplicationHandler] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) at java.lang.Thread.run(Thread.java:745) Stack Trace: com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated: 1) Thread[id=25178, name=qtp850712954-25178, state=TIMED_WAITING, group=TGRP-TestReplicationHandler] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226) at java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedNanos(AbstractQueuedSynchronizer.java:1033) at java.util.concurrent.locks.AbstractQueuedSynchronizer.tryAcquireSharedNanos(AbstractQueuedSynchronizer.java:1326) at java.util.concurrent.locks.ReentrantReadWriteLock$ReadLock.tryLock(ReentrantReadWriteLock.java:873) at org.apache.solr.update.DefaultSolrCoreState.lock(DefaultSolrCoreState.java:150) at org.apache.solr.update.DefaultSolrCoreState.getIndexWriter(DefaultSolrCoreState.java:95) at org.apache.solr.update.DirectUpdateHandler2.doNormalUpdate(DirectUpdateHandler2.java:261) at org.apache.solr.update.DirectUpdateHandler2.addDoc0(DirectUpdateHandler2.java:202) at org.apache.solr.update.DirectUpdateHandler2.addDoc(DirectUpdateHandler2.java:164) at org.apache.solr.update.processor.RunUpdateProcessor.processAdd(RunUpdateProcessorFactory.java:69) at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:51) at org.apache.solr.update.processor.DistributedUpdateProcessor.versionAdd(DistributedUpdateProcessor.java:949) at org.apache.solr.update.processor.DistributedUpdateProcessor.processAdd(DistributedUpdateProcessor.java:701) at org.apache.solr.update.processor.LogUpdateProcessor.processAdd(LogUpdateProcessorFactory.java:104) at org.apache.solr.handler.loader.XMLLoader.processUpdate(XMLLoader.java:250) at org.apache.solr.handler.loader.XMLLoader.load(XMLLoader.java:177) at org.apache.solr.handler.UpdateRequestHandler$1.load(UpdateRequestHandler.java:98) at org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:74) at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:151) at org.apache.solr.core.SolrCore.execute(SolrCore.java:2072) at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:654) at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:455) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:221) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:180) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652) at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:109) 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:300) 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) 2) Thread[id=25191, name=searcherExecutor-4769-thread-1, state=WAITING, group=TGRP-TestReplicationHandler] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) at java.lang.Thread.run(Thread.java:745) at __randomizedtesting.SeedInfo.seed([AEE36FAB3C1AB230]:0) Build Log: [...truncated 11429 lines...] [junit4] Suite: org.apache.solr.handler.TestReplicationHandler [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/init-core-data-001 [junit4] 2> 2248432 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.SolrTestCaseJ4 ###Starting doTestRepeater [junit4] 2> 2248433 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-001/collection1 [junit4] 2> 2248438 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.e.j.s.Server jetty-9.2.13.v20150730 [junit4] 2> 2248440 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7ca780fa{/solr,null,AVAILABLE} [junit4] 2> 2248441 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.e.j.s.ServerConnector Started ServerConnector@5904dd05{HTTP/1.1}{127.0.0.1:60585} [junit4] 2> 2248441 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.e.j.s.Server Started @2251049ms [junit4] 2> 2248441 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-001/collection1/data, hostPort=60585, hostContext=/solr} [junit4] 2> 2248441 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@265f00f9 [junit4] 2> 2248441 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-001' [junit4] 2> 2248441 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 2248441 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 2248441 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-001/solr.xml [junit4] 2> 2248454 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-001/. [junit4] 2> 2248454 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoreContainer New CoreContainer 344867160 [junit4] 2> 2248454 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-001] [junit4] 2> 2248454 WARN (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-001/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-001/lib [junit4] 2> 2248455 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] 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> 2248456 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 2248456 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 2248456 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 2248456 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 2248456 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 2248457 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoresLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-001/. [junit4] 2> 2248458 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.SolrCore Created CoreDescriptor: {instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-001/./collection1, loadOnStartup=true, dataDir=data/, name=collection1, schema=schema.xml, transient=false, absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-001/./collection1/, config=solrconfig.xml, configSetProperties=configsetprops.json} [junit4] 2> 2248458 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoresLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-001/./collection1/ [junit4] 2> 2248458 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoresLocator Found 1 core definitions [junit4] 2> 2248459 INFO (coreLoadExecutor-4354-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-001/collection1' [junit4] 2> 2248466 INFO (coreLoadExecutor-4354-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 2248466 INFO (coreLoadExecutor-4354-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 2248459 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1 [junit4] 2> 2248472 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 2248473 INFO (coreLoadExecutor-4354-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 2248485 INFO (coreLoadExecutor-4354-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.4.0 [junit4] 2> 2248507 INFO (coreLoadExecutor-4354-thread-1) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml [junit4] 2> 2248511 INFO (coreLoadExecutor-4354-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 2248518 INFO (coreLoadExecutor-4354-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 2248519 INFO (coreLoadExecutor-4354-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-001/collection1' [junit4] 2> 2248519 INFO (coreLoadExecutor-4354-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-001/./collection1 [junit4] 2> 2248520 INFO (coreLoadExecutor-4354-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 2248520 INFO (coreLoadExecutor-4354-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-001/collection1], dataDir=[null] [junit4] 2> 2248520 INFO (coreLoadExecutor-4354-thread-1) [ x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1 [junit4] 2> 2248520 INFO (coreLoadExecutor-4354-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-001/./collection1/data [junit4] 2> 2248520 INFO (coreLoadExecutor-4354-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-001/./collection1/data/index/ [junit4] 2> 2248520 WARN (coreLoadExecutor-4354-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-001/./collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 2248520 INFO (coreLoadExecutor-4354-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-001/./collection1/data/index [junit4] 2> 2248521 INFO (coreLoadExecutor-4354-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=17, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=44.927734375, floorSegmentMB=1.9677734375, forceMergeDeletesPctAllowed=8.625827530006413, segmentsPerTier=44.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8157415221824477 [junit4] 2> 2248521 INFO (coreLoadExecutor-4354-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@2cf0ba1a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@704a1802),segFN=segments_1,generation=1} [junit4] 2> 2248521 INFO (coreLoadExecutor-4354-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 2248523 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-001/./collection1/data/ [junit4] 2> 2248524 INFO (coreLoadExecutor-4354-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 2248526 INFO (coreLoadExecutor-4354-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 2248527 INFO (coreLoadExecutor-4354-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 2248528 INFO (coreLoadExecutor-4354-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 2248529 INFO (coreLoadExecutor-4354-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 2248534 INFO (coreLoadExecutor-4354-thread-1) [ x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy [junit4] 2> 2248534 INFO (coreLoadExecutor-4354-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: standard,/config,/update,lazy,/replication,/admin/plugins,/admin/system,/admin/threads,/admin/logging,/admin/luke,defaults,/admin/mbeans,/get,/admin/file,/update/json,/admin/ping,/admin/properties,/update/json/docs,/update/csv,/schema,/admin/segments [junit4] 2> 2248535 INFO (coreLoadExecutor-4354-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 2248535 INFO (coreLoadExecutor-4354-thread-1) [ x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled [junit4] 2> 2248535 INFO (coreLoadExecutor-4354-thread-1) [ x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled [junit4] 2> 2248535 INFO (coreLoadExecutor-4354-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@7abdba8 [junit4] 2> 2248536 INFO (coreLoadExecutor-4354-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@2cf0ba1a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@704a1802),segFN=segments_1,generation=1} [junit4] 2> 2248536 INFO (coreLoadExecutor-4354-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 2248536 INFO (coreLoadExecutor-4354-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@31caa2d7[collection1] main [junit4] 2> 2248536 INFO (coreLoadExecutor-4354-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-001/collection1/conf [junit4] 2> 2248536 INFO (coreLoadExecutor-4354-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-001/collection1/conf} [junit4] 2> 2248536 INFO (coreLoadExecutor-4354-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-001/collection1/conf [junit4] 2> 2248536 INFO (coreLoadExecutor-4354-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 2248537 INFO (coreLoadExecutor-4354-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml,xslt/dummy.xsl [junit4] 2> 2248537 INFO (coreLoadExecutor-4354-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 2248537 INFO (coreLoadExecutor-4354-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 2248537 INFO (searcherExecutor-4355-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@31caa2d7[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2248973 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/collection1 [junit4] 2> 2248978 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.e.j.s.Server jetty-9.2.13.v20150730 [junit4] 2> 2248981 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@46ca1385{/solr,null,AVAILABLE} [junit4] 2> 2248981 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.e.j.s.ServerConnector Started ServerConnector@17263f17{HTTP/1.1}{127.0.0.1:42798} [junit4] 2> 2248981 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.e.j.s.Server Started @2251589ms [junit4] 2> 2248981 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/collection1/data, hostContext=/solr, hostPort=42798} [junit4] 2> 2248981 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@265f00f9 [junit4] 2> 2248981 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002' [junit4] 2> 2248982 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 2248982 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 2248982 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/solr.xml [junit4] 2> 2249005 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/. [junit4] 2> 2249005 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoreContainer New CoreContainer 1576116215 [junit4] 2> 2249005 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002] [junit4] 2> 2249005 WARN (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/lib [junit4] 2> 2249007 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] 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> 2249009 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 2249010 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 2249010 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 2249010 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 2249010 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 2249011 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoresLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/. [junit4] 2> 2249012 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.SolrCore Created CoreDescriptor: {loadOnStartup=true, name=collection1, config=solrconfig.xml, transient=false, dataDir=data/, absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/./collection1/, configSetProperties=configsetprops.json, schema=schema.xml, instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/./collection1} [junit4] 2> 2249012 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoresLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/./collection1/ [junit4] 2> 2249012 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoresLocator Found 1 core definitions [junit4] 2> 2249012 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1 [junit4] 2> 2249012 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 2249012 INFO (coreLoadExecutor-4364-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/collection1' [junit4] 2> 2249013 INFO (coreLoadExecutor-4364-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 2249013 INFO (coreLoadExecutor-4364-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 2249021 INFO (coreLoadExecutor-4364-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 2249031 INFO (coreLoadExecutor-4364-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.4.0 [junit4] 2> 2249053 INFO (coreLoadExecutor-4364-thread-1) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml [junit4] 2> 2249057 INFO (coreLoadExecutor-4364-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 2249064 INFO (coreLoadExecutor-4364-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 2249065 INFO (coreLoadExecutor-4364-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/collection1' [junit4] 2> 2249065 INFO (coreLoadExecutor-4364-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/./collection1 [junit4] 2> 2249066 INFO (coreLoadExecutor-4364-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 2249066 INFO (coreLoadExecutor-4364-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/collection1], dataDir=[null] [junit4] 2> 2249066 INFO (coreLoadExecutor-4364-thread-1) [ x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1 [junit4] 2> 2249066 INFO (coreLoadExecutor-4364-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/./collection1/data [junit4] 2> 2249066 INFO (coreLoadExecutor-4364-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/./collection1/data/index/ [junit4] 2> 2249066 WARN (coreLoadExecutor-4364-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/./collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 2249067 INFO (coreLoadExecutor-4364-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/./collection1/data/index [junit4] 2> 2249067 INFO (coreLoadExecutor-4364-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=17, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=44.927734375, floorSegmentMB=1.9677734375, forceMergeDeletesPctAllowed=8.625827530006413, segmentsPerTier=44.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8157415221824477 [junit4] 2> 2249067 INFO (coreLoadExecutor-4364-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@7c46bcae lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@80d8340),segFN=segments_1,generation=1} [junit4] 2> 2249067 INFO (coreLoadExecutor-4364-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 2249069 INFO (coreLoadExecutor-4364-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 2249071 INFO (coreLoadExecutor-4364-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 2249072 INFO (coreLoadExecutor-4364-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 2249074 INFO (coreLoadExecutor-4364-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 2249074 INFO (coreLoadExecutor-4364-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 2249076 INFO (coreLoadExecutor-4364-thread-1) [ x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy [junit4] 2> 2249076 INFO (coreLoadExecutor-4364-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: standard,/config,/update,lazy,/replication,/admin/plugins,/admin/system,/admin/threads,/admin/logging,/admin/luke,defaults,/admin/mbeans,/get,/admin/file,/update/json,/admin/ping,/admin/properties,/update/json/docs,/update/csv,/schema,/admin/segments [junit4] 2> 2249077 INFO (coreLoadExecutor-4364-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 2249077 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/./collection1/data/ [junit4] 2> 2249078 INFO (coreLoadExecutor-4364-thread-1) [ x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled [junit4] 2> 2249078 INFO (coreLoadExecutor-4364-thread-1) [ x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled [junit4] 2> 2249078 INFO (coreLoadExecutor-4364-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@72d79ffd [junit4] 2> 2249078 INFO (coreLoadExecutor-4364-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@7c46bcae lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@80d8340),segFN=segments_1,generation=1} [junit4] 2> 2249078 INFO (coreLoadExecutor-4364-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 2249079 INFO (coreLoadExecutor-4364-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@176d3fd3[collection1] main [junit4] 2> 2249079 INFO (coreLoadExecutor-4364-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/collection1/conf [junit4] 2> 2249079 INFO (coreLoadExecutor-4364-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/collection1/conf} [junit4] 2> 2249079 INFO (coreLoadExecutor-4364-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/collection1/conf [junit4] 2> 2249079 INFO (coreLoadExecutor-4364-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 2249080 INFO (coreLoadExecutor-4364-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms [junit4] 2> 2249080 INFO (coreLoadExecutor-4364-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 2249080 INFO (searcherExecutor-4365-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@176d3fd3[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2249084 INFO (qtp1877799944-24538) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=indexversion&version=2&wt=javabin&qt=/replication} status=0 QTime=0 [junit4] 2> 2249515 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.e.j.s.ServerConnector Stopped ServerConnector@17263f17{HTTP/1.1}{127.0.0.1:0} [junit4] 2> 2249515 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1576116215 [junit4] 2> 2249515 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@49200eba [junit4] 2> 2249515 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ x:collection1] o.a.s.u.UpdateHandler 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> 2249515 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState [junit4] 2> 2249515 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter [junit4] 2> 2249515 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser [junit4] 2> 2249516 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request. [junit4] 2> 2249517 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked [junit4] 2> 2249517 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/./collection1/data [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/./collection1/data;done=false>>] [junit4] 2> 2249517 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/./collection1/data [junit4] 2> 2249517 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/./collection1/data/index [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/./collection1/data/index;done=false>>] [junit4] 2> 2249517 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/./collection1/data/index [junit4] 2> 2249517 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ x:collection1] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@46ca1385{/solr,null,UNAVAILABLE} [junit4] 2> 2249524 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.e.j.s.Server jetty-9.2.13.v20150730 [junit4] 2> 2249526 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@272baee9{/solr,null,AVAILABLE} [junit4] 2> 2249526 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.e.j.s.ServerConnector Started ServerConnector@24e85716{HTTP/1.1}{127.0.0.1:54578} [junit4] 2> 2249527 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.e.j.s.Server Started @2252135ms [junit4] 2> 2249527 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostPort=54578, hostContext=/solr, solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/collection1/data} [junit4] 2> 2249527 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@265f00f9 [junit4] 2> 2249527 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002' [junit4] 2> 2249528 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 2249528 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 2249528 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/solr.xml [junit4] 2> 2249539 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/. [junit4] 2> 2249539 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoreContainer New CoreContainer 1848334740 [junit4] 2> 2249539 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002] [junit4] 2> 2249539 WARN (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/lib [junit4] 2> 2249540 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] 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> 2249541 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 2249541 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 2249541 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 2249541 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 2249541 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 2249542 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoresLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/. [junit4] 2> 2249543 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, config=solrconfig.xml, dataDir=data/, absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/./collection1/, transient=false, loadOnStartup=true, configSetProperties=configsetprops.json, instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/./collection1, schema=schema.xml} [junit4] 2> 2249543 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoresLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/./collection1/ [junit4] 2> 2249543 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoresLocator Found 1 core definitions [junit4] 2> 2249544 INFO (coreLoadExecutor-4375-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/collection1' [junit4] 2> 2249545 INFO (coreLoadExecutor-4375-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 2249545 INFO (coreLoadExecutor-4375-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 2249544 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1 [junit4] 2> 2249547 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 2249551 INFO (coreLoadExecutor-4375-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 2249562 INFO (coreLoadExecutor-4375-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.4.0 [junit4] 2> 2249601 INFO (coreLoadExecutor-4375-thread-1) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml [junit4] 2> 2249605 INFO (coreLoadExecutor-4375-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 2249611 INFO (coreLoadExecutor-4375-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 2249612 INFO (coreLoadExecutor-4375-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/collection1' [junit4] 2> 2249612 INFO (coreLoadExecutor-4375-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/./collection1 [junit4] 2> 2249612 INFO (coreLoadExecutor-4375-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 2249613 INFO (coreLoadExecutor-4375-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/collection1], dataDir=[null] [junit4] 2> 2249613 INFO (coreLoadExecutor-4375-thread-1) [ x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1 [junit4] 2> 2249613 INFO (coreLoadExecutor-4375-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/./collection1/data [junit4] 2> 2249614 INFO (coreLoadExecutor-4375-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/./collection1/data/index/ [junit4] 2> 2249614 WARN (coreLoadExecutor-4375-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/./collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 2249614 INFO (coreLoadExecutor-4375-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/./collection1/data/index [junit4] 2> 2249614 INFO (coreLoadExecutor-4375-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=17, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=44.927734375, floorSegmentMB=1.9677734375, forceMergeDeletesPctAllowed=8.625827530006413, segmentsPerTier=44.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8157415221824477 [junit4] 2> 2249615 INFO (coreLoadExecutor-4375-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@3947bcaa lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@14b35a47),segFN=segments_1,generation=1} [junit4] 2> 2249615 INFO (coreLoadExecutor-4375-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 2249616 INFO (coreLoadExecutor-4375-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 2249618 INFO (coreLoadExecutor-4375-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 2249619 INFO (coreLoadExecutor-4375-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 2249620 INFO (coreLoadExecutor-4375-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 2249621 INFO (coreLoadExecutor-4375-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 2249622 INFO (coreLoadExecutor-4375-thread-1) [ x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy [junit4] 2> 2249622 INFO (coreLoadExecutor-4375-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: standard,/config,/update,lazy,/replication,/admin/plugins,/admin/system,/admin/threads,/admin/logging,/admin/luke,defaults,/admin/mbeans,/get,/admin/file,/update/json,/admin/ping,/admin/properties,/update/json/docs,/update/csv,/schema,/admin/segments [junit4] 2> 2249623 INFO (coreLoadExecutor-4375-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 2249624 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/./collection1/data/ [junit4] 2> 2249624 INFO (coreLoadExecutor-4375-thread-1) [ x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled [junit4] 2> 2249624 INFO (coreLoadExecutor-4375-thread-1) [ x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled [junit4] 2> 2249624 INFO (coreLoadExecutor-4375-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@3c7393a3 [junit4] 2> 2249625 INFO (coreLoadExecutor-4375-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@3947bcaa lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@14b35a47),segFN=segments_1,generation=1} [junit4] 2> 2249625 INFO (coreLoadExecutor-4375-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 2249626 INFO (coreLoadExecutor-4375-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@7d12aa61[collection1] main [junit4] 2> 2249626 INFO (coreLoadExecutor-4375-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/collection1/conf [junit4] 2> 2249626 INFO (coreLoadExecutor-4375-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/collection1/conf} [junit4] 2> 2249626 INFO (coreLoadExecutor-4375-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-002/collection1/conf [junit4] 2> 2249627 INFO (coreLoadExecutor-4375-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 2249627 INFO (coreLoadExecutor-4375-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 2249627 INFO (coreLoadExecutor-4375-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 2249627 INFO (searcherExecutor-4376-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7d12aa61[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2250048 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-003/collection1 [junit4] 2> 2250056 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.e.j.s.Server jetty-9.2.13.v20150730 [junit4] 2> 2250061 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@26d9433e{/solr,null,AVAILABLE} [junit4] 2> 2250061 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.e.j.s.ServerConnector Started ServerConnector@66b486e5{HTTP/1.1}{127.0.0.1:39497} [junit4] 2> 2250061 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.e.j.s.Server Started @2252669ms [junit4] 2> 2250062 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=39497, solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-003/collection1/data} [junit4] 2> 2250062 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@265f00f9 [junit4] 2> 2250062 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-003' [junit4] 2> 2250062 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 2250062 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 2250062 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-003/solr.xml [junit4] 2> 2250080 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-003/. [junit4] 2> 2250080 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoreContainer New CoreContainer 79629566 [junit4] 2> 2250080 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-003] [junit4] 2> 2250080 WARN (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-003/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-003/lib [junit4] 2> 2250084 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] 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> 2250084 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 2250085 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 2250085 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 2250085 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 2250085 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 2250086 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.CoresLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-003/. [junit4] 2> 2250088 INFO (TEST-TestReplicationHandler.doTestRepeater-seed#[AEE36FAB3C1AB230]) [ ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, configSetProperties=configsetprops.json, absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_AEE36FAB3C1AB230-001/solr-instance-003/./collection1/, loadOnStartup=true, [...truncated too long message...] vletHandler$CachedChain.doFilter(ServletHandler.java:1652) [junit4] > at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:109) [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:300) [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([AEE36FAB3C1AB230]:0)Throwable #2: com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated: [junit4] > 1) Thread[id=25178, name=qtp850712954-25178, state=TIMED_WAITING, group=TGRP-TestReplicationHandler] [junit4] > at sun.misc.Unsafe.park(Native Method) [junit4] > at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226) [junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedNanos(AbstractQueuedSynchronizer.java:1033) [junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer.tryAcquireSharedNanos(AbstractQueuedSynchronizer.java:1326) [junit4] > at java.util.concurrent.locks.ReentrantReadWriteLock$ReadLock.tryLock(ReentrantReadWriteLock.java:873) [junit4] > at org.apache.solr.update.DefaultSolrCoreState.lock(DefaultSolrCoreState.java:150) [junit4] > at org.apache.solr.update.DefaultSolrCoreState.getIndexWriter(DefaultSolrCoreState.java:95) [junit4] > at org.apache.solr.update.DirectUpdateHandler2.doNormalUpdate(DirectUpdateHandler2.java:261) [junit4] > at org.apache.solr.update.DirectUpdateHandler2.addDoc0(DirectUpdateHandler2.java:202) [junit4] > at org.apache.solr.update.DirectUpdateHandler2.addDoc(DirectUpdateHandler2.java:164) [junit4] > at org.apache.solr.update.processor.RunUpdateProcessor.processAdd(RunUpdateProcessorFactory.java:69) [junit4] > at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:51) [junit4] > at org.apache.solr.update.processor.DistributedUpdateProcessor.versionAdd(DistributedUpdateProcessor.java:949) [junit4] > at org.apache.solr.update.processor.DistributedUpdateProcessor.processAdd(DistributedUpdateProcessor.java:701) [junit4] > at org.apache.solr.update.processor.LogUpdateProcessor.processAdd(LogUpdateProcessorFactory.java:104) [junit4] > at org.apache.solr.handler.loader.XMLLoader.processUpdate(XMLLoader.java:250) [junit4] > at org.apache.solr.handler.loader.XMLLoader.load(XMLLoader.java:177) [junit4] > at org.apache.solr.handler.UpdateRequestHandler$1.load(UpdateRequestHandler.java:98) [junit4] > at org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:74) [junit4] > at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:151) [junit4] > at org.apache.solr.core.SolrCore.execute(SolrCore.java:2072) [junit4] > at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:654) [junit4] > at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:455) [junit4] > at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:221) [junit4] > at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:180) [junit4] > at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652) [junit4] > at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:109) [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:300) [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] > 2) Thread[id=25191, name=searcherExecutor-4769-thread-1, state=WAITING, group=TGRP-TestReplicationHandler] [junit4] > at sun.misc.Unsafe.park(Native Method) [junit4] > at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186) [junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043) [junit4] > at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) [junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068) [junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) [junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] > at __randomizedtesting.SeedInfo.seed([AEE36FAB3C1AB230]:0) [junit4] Completed [423/551] on J1 in 785.49s, 13 tests, 3 errors <<< FAILURES! [...truncated 395 lines...] BUILD FAILED /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/build.xml:792: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/build.xml:729: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/build.xml:59: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build.xml:233: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/common-build.xml:526: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/lucene/common-build.xml:1452: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/lucene/common-build.xml:1006: There were test failures: 551 suites (7 ignored), 2177 tests, 2 suite-level errors, 1 error, 354 ignored (18 assumptions) [seed: AEE36FAB3C1AB230] Total time: 171 minutes 58 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts No prior successful build to compare, so performing full copy of artifacts Recording test results Email was triggered for: Failure - Any Sending email for trigger: Failure - Any
--------------------------------------------------------------------- To unsubscribe, e-mail: [email protected] For additional commands, e-mail: [email protected]
