Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Windows/4386/ Java: 64bit/jdk1.8.0_31 -XX:-UseCompressedOops -XX:+UseG1GC
5 tests failed. FAILED: junit.framework.TestSuite.org.apache.solr.core.TestLazyCores Error Message: ERROR: SolrIndexSearcher opens=51 closes=50 Stack Trace: java.lang.AssertionError: ERROR: SolrIndexSearcher opens=51 closes=50 at __randomizedtesting.SeedInfo.seed([50B89A8CE6089DDA]:0) at org.junit.Assert.fail(Assert.java:93) at org.apache.solr.SolrTestCaseJ4.endTrackingSearchers(SolrTestCaseJ4.java:466) at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:212) at sun.reflect.GeneratedMethodAccessor33.invoke(Unknown Source) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:483) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:790) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) 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:365) at java.lang.Thread.run(Thread.java:745) FAILED: junit.framework.TestSuite.org.apache.solr.core.TestLazyCores Error Message: 1 thread leaked from SUITE scope at org.apache.solr.core.TestLazyCores: 1) Thread[id=13568, name=searcherExecutor-6793-thread-1, state=WAITING, group=TGRP-TestLazyCores] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:745) Stack Trace: com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.core.TestLazyCores: 1) Thread[id=13568, name=searcherExecutor-6793-thread-1, state=WAITING, group=TGRP-TestLazyCores] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:745) at __randomizedtesting.SeedInfo.seed([50B89A8CE6089DDA]:0) FAILED: junit.framework.TestSuite.org.apache.solr.core.TestLazyCores Error Message: There are still zombie threads that couldn't be terminated: 1) Thread[id=13568, name=searcherExecutor-6793-thread-1, state=WAITING, group=TGRP-TestLazyCores] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) 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=13568, name=searcherExecutor-6793-thread-1, state=WAITING, group=TGRP-TestLazyCores] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:745) at __randomizedtesting.SeedInfo.seed([50B89A8CE6089DDA]:0) FAILED: junit.framework.TestSuite.org.apache.solr.cloud.BasicDistributedZk2Test Error Message: Could not remove the following files (in the order of attempts): C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.BasicDistributedZk2Test 50B89A8CE6089DDA-001\tempDir-002: java.nio.file.AccessDeniedException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.BasicDistributedZk2Test 50B89A8CE6089DDA-001\tempDir-002 C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.BasicDistributedZk2Test 50B89A8CE6089DDA-001: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.BasicDistributedZk2Test 50B89A8CE6089DDA-001 Stack Trace: java.io.IOException: Could not remove the following files (in the order of attempts): C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.BasicDistributedZk2Test 50B89A8CE6089DDA-001\tempDir-002: java.nio.file.AccessDeniedException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.BasicDistributedZk2Test 50B89A8CE6089DDA-001\tempDir-002 C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.BasicDistributedZk2Test 50B89A8CE6089DDA-001: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.BasicDistributedZk2Test 50B89A8CE6089DDA-001 at __randomizedtesting.SeedInfo.seed([50B89A8CE6089DDA]:0) at org.apache.lucene.util.IOUtils.rm(IOUtils.java:294) at org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:170) at com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterAlways(TestRuleAdapter.java:31) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43) 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:365) at java.lang.Thread.run(Thread.java:745) FAILED: junit.framework.TestSuite.org.apache.solr.handler.TestReplicationHandlerBackup Error Message: Could not remove the following files (in the order of attempts): C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\collection1 C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002 C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\collection1 C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001 C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\collection1\data: java.nio.file.AccessDeniedException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\collection1\data C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001 C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\collection1\data: java.nio.file.AccessDeniedException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\collection1\data C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002 C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001 Stack Trace: java.io.IOException: Could not remove the following files (in the order of attempts): C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\collection1 C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002 C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\collection1 C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001 C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\collection1\data: java.nio.file.AccessDeniedException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\collection1\data C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001 C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\collection1\data: java.nio.file.AccessDeniedException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\collection1\data C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002 C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001 at __randomizedtesting.SeedInfo.seed([50B89A8CE6089DDA]:0) at org.apache.lucene.util.IOUtils.rm(IOUtils.java:294) at org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:170) at com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterAlways(TestRuleAdapter.java:31) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43) 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:365) at java.lang.Thread.run(Thread.java:745) Build Log: [...truncated 9565 lines...] [junit4] Suite: org.apache.solr.handler.TestReplicationHandlerBackup [junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\init-core-data-001 [junit4] 2> 1100351 T5372 oas.SolrTestCaseJ4.setUp ###Starting testBackupOnCommit [junit4] 2> 1100355 T5372 oas.SolrTestCaseJ4.writeCoreProperties Writing core.properties file to C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\collection1 [junit4] 2> 1100390 T5372 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 1100398 T5372 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:65386 [junit4] 2> 1100402 T5372 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@c387f44 [junit4] 2> 1100402 T5372 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 1100402 T5372 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001 [junit4] 2> 1100402 T5372 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\' [junit4] 2> 1100468 T5372 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\solr.xml [junit4] 2> 1100483 T5372 oasc.CorePropertiesLocator.<init> Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\. [junit4] 2> 1100484 T5372 oasc.CoreContainer.<init> New CoreContainer 712765832 [junit4] 2> 1100484 T5372 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\] [junit4] 2> 1100485 T5372 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 1100487 T5372 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: [junit4] 2> 1100488 T5372 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 1100488 T5372 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 1100489 T5372 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000 [junit4] 2> 1100489 T5372 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 1100490 T5372 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 1100490 T5372 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 1100490 T5372 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 1100491 T5372 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 1100491 T5372 oashc.HttpShardHandlerFactory.getParameter Setting useRetries to: false [junit4] 2> 1100493 T5372 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 1100493 T5372 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 1100494 T5372 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 1100494 T5372 oasc.CoreContainer.load Host Name: 127.0.0.1 [junit4] 2> 1100501 T5372 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\. [junit4] 2> 1100508 T5372 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\.\collection1\ [junit4] 2> 1100512 T5372 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 1100513 T5382 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\.\collection1\' [junit4] 2> 1100551 T5382 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1 [junit4] 2> 1100553 T5382 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.1.0 [junit4] 2> 1100578 T5382 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 1100579 T5382 oass.IndexSchema.readSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\.\collection1\conf\schema.xml [junit4] 2> 1100584 T5382 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 1100589 T5382 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 1100589 T5382 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\.\collection1\ [junit4] 2> 1100589 T5382 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 1100591 T5382 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\.\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\collection1\data\ [junit4] 2> 1100591 T5382 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1 [junit4] 2> 1100591 T5382 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\collection1\data\ [junit4] 2> 1100591 T5382 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\collection1\data\index/ [junit4] 2> 1100591 T5382 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\collection1\data\index' doesn't exist. Creating new index... [junit4] 2> 1100593 T5382 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\collection1\data\index [junit4] 2> 1100593 T5382 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=46, maxMergeAtOnceExplicit=20, maxMergedSegmentMB=57.78515625, floorSegmentMB=1.4599609375, forceMergeDeletesPctAllowed=16.83224160951047, segmentsPerTier=22.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7720456777707357 [junit4] 2> 1100595 T5382 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@5f561c01 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@79209717),segFN=segments_1,generation=1} [junit4] 2> 1100595 T5382 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 1100596 T5382 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 1100597 T5382 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler [junit4] 2> 1100597 T5382 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 1100597 T5382 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 1100597 T5382 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 1100597 T5382 oasc.RequestHandlers.initHandlersFromConfig created /config: org.apache.solr.handler.SolrConfigHandler [junit4] 2> 1100598 T5382 oasc.RequestHandlers.initHandlersFromConfig created /schema: org.apache.solr.handler.SchemaHandler [junit4] 2> 1100622 T5382 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler [junit4] 2> 1100622 T5382 oasc.RequestHandlers.initHandlersFromConfig created /get: org.apache.solr.handler.RealTimeGetHandler [junit4] 2> 1100622 T5382 oasc.RequestHandlers.initHandlersFromConfig created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler [junit4] 2> 1100623 T5382 oasc.RequestHandlers.initHandlersFromConfig created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler [junit4] 2> 1100623 T5382 oasc.RequestHandlers.initHandlersFromConfig created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler [junit4] 2> 1100624 T5382 oasc.RequestHandlers.initHandlersFromConfig created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler [junit4] 2> 1100624 T5382 oasc.RequestHandlers.initHandlersFromConfig created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler [junit4] 2> 1100624 T5382 oasc.RequestHandlers.initHandlersFromConfig created /admin/properties: org.apache.solr.handler.admin.PropertiesRequestHandler [junit4] 2> 1100624 T5382 oasc.RequestHandlers.initHandlersFromConfig created /admin/logging: org.apache.solr.handler.admin.LoggingHandler [junit4] 2> 1100625 T5382 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: org.apache.solr.handler.admin.ShowFileRequestHandler [junit4] 2> 1100625 T5382 oasc.RequestHandlers.initHandlersFromConfig created /admin/ping: org.apache.solr.handler.PingRequestHandler [junit4] 2> 1100625 T5382 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4] 2> 1100625 T5382 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler [junit4] 2> 1100625 T5382 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler [junit4] 2> 1100625 T5382 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler [junit4] 2> 1100640 T5382 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1100642 T5382 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1100644 T5382 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1100649 T5382 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1100649 T5382 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 1100650 T5382 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 1100650 T5382 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 1100650 T5382 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=29, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 1100652 T5382 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@5f561c01 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@79209717),segFN=segments_1,generation=1} [junit4] 2> 1100652 T5382 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 1100652 T5382 oass.SolrIndexSearcher.<init> Opening Searcher@6a1f8d9a[collection1] main [junit4] 2> 1100652 T5382 oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage initialized to use dir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\.\collection1\conf [junit4] 2> 1100653 T5382 oasr.RestManager.init Initializing RestManager with initArgs: {storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\.\collection1\conf} [junit4] 2> 1100653 T5382 oasr.ManagedResourceStorage.load Reading _rest_managed.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\.\collection1\conf [junit4] 2> 1100653 T5382 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 1100653 T5382 oash.ReplicationHandler.inform Replication enabled for following config files: schema-replication2.xml:schema.xml [junit4] 2> 1100653 T5382 oash.ReplicationHandler.inform Commits will be reserved for 10000 [junit4] 2> 1100654 T5382 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 1100654 T5383 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6a1f8d9a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1100654 T5372 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0 [junit4] 2> 1100654 T5372 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> ASYNC NEW_CORE C738 name=collection1 org.apache.solr.core.SolrCore@322e648d [junit4] 2> 1100658 T5379 C738 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 1100659 T5379 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:*} 0 1 [junit4] 2> 1100665 T5375 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0]} 0 2 [junit4] 2> 1100668 T5374 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1]} 0 0 [junit4] 2> 1100673 T5376 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[2]} 0 0 [junit4] 2> 1100678 T5379 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[3]} 0 0 [junit4] 2> 1100684 T5377 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[4]} 0 0 [junit4] 2> 1100687 T5378 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[5]} 0 0 [junit4] 2> 1100691 T5375 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[6]} 0 0 [junit4] 2> 1100693 T5374 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[7]} 0 0 [junit4] 2> 1100697 T5376 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[8]} 0 0 [junit4] 2> 1100700 T5379 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[9]} 0 0 [junit4] 2> 1100704 T5377 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[10]} 0 0 [junit4] 2> 1100707 T5378 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[11]} 0 0 [junit4] 2> 1100733 T5375 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[12]} 0 22 [junit4] 2> 1100739 T5374 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[13]} 0 0 [junit4] 2> 1100743 T5376 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[14]} 0 0 [junit4] 2> 1100747 T5379 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[15]} 0 0 [junit4] 2> 1100750 T5377 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[16]} 0 0 [junit4] 2> 1100754 T5378 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[17]} 0 0 [junit4] 2> 1100758 T5375 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[18]} 0 0 [junit4] 2> 1100769 T5374 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[19]} 0 0 [junit4] 2> 1100771 T5376 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[20]} 0 0 [junit4] 2> 1100775 T5379 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[21]} 0 0 [junit4] 2> 1100779 T5377 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[22]} 0 0 [junit4] 2> 1100782 T5378 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[23]} 0 0 [junit4] 2> 1100786 T5375 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[24]} 0 0 [junit4] 2> 1100789 T5374 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[25]} 0 0 [junit4] 2> 1100793 T5376 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[26]} 0 0 [junit4] 2> 1100796 T5379 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[27]} 0 0 [junit4] 2> 1100800 T5377 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[28]} 0 0 [junit4] 2> 1100804 T5375 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[29]} 0 0 [junit4] 2> 1100807 T5374 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[30]} 0 0 [junit4] 2> 1100813 T5376 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[31]} 0 1 [junit4] 2> 1100817 T5379 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[32]} 0 0 [junit4] 2> 1100819 T5378 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[33]} 0 0 [junit4] 2> 1100823 T5377 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[34]} 0 0 [junit4] 2> 1100826 T5375 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[35]} 0 0 [junit4] 2> 1100830 T5374 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[36]} 0 0 [junit4] 2> 1100833 T5376 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[37]} 0 0 [junit4] 2> 1100837 T5379 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[38]} 0 0 [junit4] 2> 1100840 T5378 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[39]} 0 0 [junit4] 2> 1100844 T5377 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[40]} 0 0 [junit4] 2> 1100847 T5375 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[41]} 0 0 [junit4] 2> 1100851 T5374 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[42]} 0 0 [junit4] 2> 1100855 T5376 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[43]} 0 0 [junit4] 2> 1100858 T5379 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[44]} 0 0 [junit4] 2> 1100860 T5378 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[45]} 0 0 [junit4] 2> 1100863 T5377 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[46]} 0 0 [junit4] 2> 1100865 T5375 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[47]} 0 0 [junit4] 2> 1100868 T5374 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[48]} 0 0 [junit4] 2> 1100871 T5376 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[49]} 0 0 [junit4] 2> 1100874 T5379 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[50]} 0 0 [junit4] 2> 1100876 T5378 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[51]} 0 0 [junit4] 2> 1100879 T5377 C738 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1100882 T5377 C738 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@5f561c01 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@79209717),segFN=segments_1,generation=1} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@5f561c01 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@79209717),segFN=segments_2,generation=2} [junit4] 2> 1100883 T5377 C738 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2 [junit4] 2> 1100917 T5377 C738 oass.SolrIndexSearcher.<init> Opening Searcher@455aa085[collection1] main [junit4] 2> 1100919 T5377 C738 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 1100919 T5385 oash.SnapShooter.createSnapshot Creating backup snapshot... [junit4] 2> 1100919 T5383 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@455aa085[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.1.0):C52)))} [junit4] 2> 1100919 T5377 C738 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 40 [junit4] 2> 1100941 T5375 C738 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=2 [junit4] 2> 1100947 T5385 oash.SnapShooter.createSnapshot Done creating backup snapshot: <not named> [junit4] 2> 1102160 T5374 C738 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 [junit4] 2> 1103414 T5372 oas.SolrTestCaseJ4.tearDown ###Ending testBackupOnCommit [junit4] 2> 1103430 T5372 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=712765832 [junit4] 2> 1103433 T5372 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@322e648d [junit4] 2> 1103433 T5372 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=52,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0} [junit4] 2> 1103433 T5372 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState [junit4] 2> 1103433 T5372 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter [junit4] 2> 1103433 T5372 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser [junit4] 2> 1103436 T5372 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request. [junit4] 2> 1103436 T5372 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked [junit4] 2> 1103436 T5372 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\collection1\data\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\collection1\data\index;done=false>>] [junit4] 2> 1103436 T5372 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\collection1\data\index [junit4] 2> 1103436 T5372 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\collection1\data\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\collection1\data\;done=false>>] [junit4] 2> 1103436 T5372 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\collection1\data\ [junit4] 2> 1103439 T5372 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null} [junit4] 2> 1103669 T5372 oas.SolrTestCaseJ4.setUp ###Starting doTestBackup [junit4] 2> 1103672 T5372 oas.SolrTestCaseJ4.writeCoreProperties Writing core.properties file to C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\collection1 [junit4] 2> 1103699 T5372 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 1103706 T5372 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:65390 [junit4] 2> 1103707 T5372 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@c387f44 [junit4] 2> 1103708 T5372 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 1103708 T5372 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002 [junit4] 2> 1103709 T5372 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\' [junit4] 2> 1103779 T5372 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\solr.xml [junit4] 2> 1103797 T5372 oasc.CorePropertiesLocator.<init> Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\. [junit4] 2> 1103798 T5372 oasc.CoreContainer.<init> New CoreContainer 1738700070 [junit4] 2> 1103800 T5372 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\] [junit4] 2> 1103801 T5372 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 1103801 T5372 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: [junit4] 2> 1103802 T5372 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 1103802 T5372 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 1103803 T5372 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000 [junit4] 2> 1103803 T5372 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 1103804 T5372 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 1103804 T5372 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 1103804 T5372 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 1103805 T5372 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 1103805 T5372 oashc.HttpShardHandlerFactory.getParameter Setting useRetries to: false [junit4] 2> 1103807 T5372 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 1103808 T5372 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 1103808 T5372 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 1103809 T5372 oasc.CoreContainer.load Host Name: 127.0.0.1 [junit4] 2> 1103811 T5372 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\. [junit4] 2> 1103814 T5372 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\.\collection1\ [junit4] 2> 1103815 T5372 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 1103820 T5395 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\.\collection1\' [junit4] 2> 1103889 T5395 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1 [junit4] 2> 1103896 T5395 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.1.0 [junit4] 2> 1103909 T5395 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 1103909 T5395 oass.IndexSchema.readSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\.\collection1\conf\schema.xml [junit4] 2> 1103915 T5395 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 1103923 T5395 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 1103925 T5395 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\.\collection1\ [junit4] 2> 1103925 T5395 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 1103927 T5395 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\.\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\collection1\data\ [junit4] 2> 1103927 T5395 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1 [junit4] 2> 1103928 T5395 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\collection1\data\ [junit4] 2> 1103928 T5395 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\collection1\data\index/ [junit4] 2> 1103928 T5395 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\collection1\data\index' doesn't exist. Creating new index... [junit4] 2> 1103929 T5395 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\collection1\data\index [junit4] 2> 1103930 T5395 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=46, maxMergeAtOnceExplicit=20, maxMergedSegmentMB=57.78515625, floorSegmentMB=1.4599609375, forceMergeDeletesPctAllowed=16.83224160951047, segmentsPerTier=22.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7720456777707357 [junit4] 2> 1103931 T5395 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@4b8c3c07 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6703b815),segFN=segments_1,generation=1} [junit4] 2> 1103931 T5395 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 1103932 T5395 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 1103934 T5395 oasc.RequestHandlers.initHandlersFromConfig created /update: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 1103935 T5395 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 1103935 T5395 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 1103935 T5395 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 1103936 T5395 oasc.RequestHandlers.initHandlersFromConfig created /config: org.apache.solr.handler.SolrConfigHandler [junit4] 2> 1103936 T5395 oasc.RequestHandlers.initHandlersFromConfig created /schema: org.apache.solr.handler.SchemaHandler [junit4] 2> 1103936 T5395 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler [junit4] 2> 1103937 T5395 oasc.RequestHandlers.initHandlersFromConfig created /get: org.apache.solr.handler.RealTimeGetHandler [junit4] 2> 1103937 T5395 oasc.RequestHandlers.initHandlersFromConfig created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler [junit4] 2> 1103938 T5395 oasc.RequestHandlers.initHandlersFromConfig created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler [junit4] 2> 1103938 T5395 oasc.RequestHandlers.initHandlersFromConfig created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler [junit4] 2> 1103940 T5395 oasc.RequestHandlers.initHandlersFromConfig created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler [junit4] 2> 1103940 T5395 oasc.RequestHandlers.initHandlersFromConfig created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler [junit4] 2> 1103940 T5395 oasc.RequestHandlers.initHandlersFromConfig created /admin/properties: org.apache.solr.handler.admin.PropertiesRequestHandler [junit4] 2> 1103941 T5395 oasc.RequestHandlers.initHandlersFromConfig created /admin/logging: org.apache.solr.handler.admin.LoggingHandler [junit4] 2> 1103942 T5395 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: org.apache.solr.handler.admin.ShowFileRequestHandler [junit4] 2> 1103942 T5395 oasc.RequestHandlers.initHandlersFromConfig created /admin/ping: org.apache.solr.handler.PingRequestHandler [junit4] 2> 1103942 T5395 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4] 2> 1103953 T5395 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1103955 T5395 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1103956 T5395 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1103960 T5395 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1103960 T5395 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 1103962 T5395 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 1103962 T5395 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 1103962 T5395 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=29, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 1103963 T5395 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@4b8c3c07 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6703b815),segFN=segments_1,generation=1} [junit4] 2> 1103963 T5395 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 1103963 T5395 oass.SolrIndexSearcher.<init> Opening Searcher@106f55ee[collection1] main [junit4] 2> 1103963 T5395 oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage initialized to use dir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\.\collection1\conf [junit4] 2> 1103963 T5395 oasr.RestManager.init Initializing RestManager with initArgs: {storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\.\collection1\conf} [junit4] 2> 1103965 T5395 oasr.ManagedResourceStorage.load Reading _rest_managed.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\.\collection1\conf [junit4] 2> 1103966 T5395 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 1103966 T5395 oash.ReplicationHandler.inform Replication enabled for following config files: schema-replication2.xml:schema.xml [junit4] 2> 1103966 T5395 oash.ReplicationHandler.inform Commits will be reserved for 10000 [junit4] 2> 1103966 T5395 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 1103969 T5372 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0 [junit4] 2> 1103974 T5372 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 1103974 T5396 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@106f55ee[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> ASYNC NEW_CORE C739 name=collection1 org.apache.solr.core.SolrCore@2171040c [junit4] 2> 1103979 T5389 C739 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 1103980 T5389 C739 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:*} 0 1 [junit4] 2> 1103985 T5391 C739 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0]} 0 2 [junit4] 2> 1103991 T5393 C739 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1103994 T5393 C739 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@4b8c3c07 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6703b815),segFN=segments_1,generation=1} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@4b8c3c07 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6703b815),segFN=segments_2,generation=2} [junit4] 2> 1103995 T5393 C739 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2 [junit4] 2> 1103998 T5393 C739 oass.SolrIndexSearcher.<init> Opening Searcher@198a3dd0[collection1] main [junit4] 2> 1103998 T5393 C739 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 1103999 T5396 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@198a3dd0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.1.0):C1)))} [junit4] 2> 1104000 T5393 C739 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 9 [junit4] 2> 1104002 T5398 oash.SnapShooter.createSnapshot Creating backup snapshot... [junit4] 2> 1104021 T5398 oash.SnapShooter.createSnapshot Done creating backup snapshot: <not named> [junit4] 2> 1104027 T5394 C739 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=backup} status=0 QTime=20 [junit4] 2> 1104029 T5399 oash.SnapShooter.createSnapshot Creating backup snapshot... [junit4] 2> 1104046 T5399 oash.SnapShooter.createSnapshot Done creating backup snapshot: <not named> [junit4] 2> 1104050 T5392 C739 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1 [junit4] 2> 1105276 T5401 oash.SnapShooter.createSnapshot Creating backup snapshot... [junit4] 2> 1105277 T5389 C739 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=backup} status=0 QTime=4 [junit4] 2> 1105287 T5391 C739 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 [junit4] 2> 1105294 T5401 oash.SnapShooter.createSnapshot Done creating backup snapshot: <not named> [junit4] 2> 1106450 T5394 C739 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=backup} status=0 QTime=2 [junit4] 2> 1106453 T5402 oash.SnapShooter.createSnapshot Creating backup snapshot... [junit4] 2> 1106464 T5392 C739 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1 [junit4] 2> 1106472 T5402 oash.SnapShooter.createSnapshot Done creating backup snapshot: <not named> [junit4] 2> 1107585 T5390 C739 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=backup} status=0 QTime=2 [junit4] 2> 1107587 T5403 oash.SnapShooter.createSnapshot Creating backup snapshot... [junit4] 2> 1107596 T5389 C739 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 [junit4] 2> 1107610 T5403 oash.SnapShooter.createSnapshot Done creating backup snapshot: <not named> [junit4] 2> 1108698 T5372 oas.SolrTestCaseJ4.tearDown ###Ending doTestBackup [junit4] 2> 1108715 T5372 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1738700070 [junit4] 2> 1108717 T5372 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@2171040c [junit4] 2> 1108717 T5372 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=1,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0} [junit4] 2> 1108717 T5372 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState [junit4] 2> 1108717 T5372 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter [junit4] 2> 1108717 T5372 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser [junit4] 2> 1108721 T5372 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request. [junit4] 2> 1108721 T5372 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked [junit4] 2> 1108721 T5372 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\collection1\data\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\collection1\data\index;done=false>>] [junit4] 2> 1108721 T5372 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\collection1\data\index [junit4] 2> 1108721 T5372 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\collection1\data\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\collection1\data\;done=false>>] [junit4] 2> 1108721 T5372 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\collection1\data\ [junit4] 2> 1108723 T5372 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null} [junit4] 2> 1108921 T5372 oas.SolrTestCaseJ4.deleteCore ###deleteCore [junit4] 2> NOTE: test params are: codec=CheapBastard, sim=RandomSimilarityProvider(queryNorm=true,coord=crazy): {}, locale=tr, timezone=Canada/Newfoundland [junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.8.0_31 (64-bit)/cpus=2,threads=1,free=233874920,total=513802240 [junit4] 2> NOTE: All tests run in this JVM: [TestShortCircuitedRequests, ResponseLogComponentTest, TestPivotHelperCode, LoggingHandlerTest, TestConfigOverlay, ReturnFieldsTest, TestValueSourceCache, TestReRankQParserPlugin, ZkNodePropsTest, DistribDocExpirationUpdateProcessorTest, TestTolerantSearch, TestLuceneMatchVersion, TestFieldResource, UnloadDistributedZkTest, DistributedFacetPivotSmallTest, BlockCacheTest, TestSolrIndexConfig, TestDocSet, SolrPluginUtilsTest, SolrIndexSplitterTest, TestIndexSearcher, TestOrdValues, PeerSyncTest, TestReqParamsAPI, ZkControllerTest, NumericFieldsTest, SoftAutoCommitTest, MultiThreadedOCPTest, SpatialFilterTest, OverriddenZkACLAndCredentialsProvidersTest, NoCacheHeaderTest, TestMiniSolrCloudClusterSSL, TestSurroundQueryParser, XsltUpdateRequestHandlerTest, RollingRestartTest, LukeRequestHandlerTest, SolrIndexConfigTest, CachingDirectoryFactoryTest, TestCollectionAPI, DistributedFacetPivotLongTailTest, CollectionsAPIDistributedZkTest, DirectUpdateHandlerOptimizeTest, TestCloudInspectUtil, TestSolrConfigHandler, DocValuesTest, TestZkChroot, TestReloadAndDeleteDocs, TestPerFieldSimilarity, SpellCheckComponentTest, TestSolr4Spatial, TestBM25SimilarityFactory, UpdateRequestProcessorFactoryTest, TestQueryUtils, TestHighFrequencyDictionaryFactory, PrimUtilsTest, TestRemoteStreaming, CustomCollectionTest, TestJmxMonitoredMap, TermsComponentTest, DistributedMLTComponentTest, TestExactSharedStatsCache, TestFastLRUCache, DistributedFacetPivotSmallAdvancedTest, TestCustomSort, TestHashPartitioner, DateRangeFieldTest, DefaultValueUpdateProcessorTest, SolrTestCaseJ4Test, StandardRequestHandlerTest, TestTrie, AutoCommitTest, DistributedQueueTest, TestFoldingMultitermQuery, SimpleMLTQParserTest, CloudMLTQParserTest, SolrRequestParserTest, TestMaxScoreQueryParser, UUIDFieldTest, URLClassifyProcessorTest, TestSchemaNameResource, TestFaceting, TestCloudManagedSchema, SimpleCollectionCreateDeleteTest, InfoHandlerTest, TestSweetSpotSimilarityFactory, ResponseHeaderTest, FileUtilsTest, TestRandomMergePolicy, TestSchemaVersionResource, ClusterStateUpdateTest, ConnectionManagerTest, FileBasedSpellCheckerTest, TestDynamicFieldCollectionResource, DistributedTermsComponentTest, EchoParamsTest, IndexBasedSpellCheckerTest, TestImplicitCoreProperties, TestSearcherReuse, FieldAnalysisRequestHandlerTest, MBeansHandlerTest, SortByFunctionTest, HdfsChaosMonkeySafeLeaderTest, DistributedSuggestComponentTest, ExternalCollectionsTest, TestFuzzyAnalyzedSuggestions, ShowFileRequestHandlerTest, AsyncMigrateRouteKeyTest, SearchHandlerTest, DirectSolrConnectionTest, TestFastOutputStream, TestPostingsSolrHighlighter, DateFieldTest, TestAtomicUpdateErrorCases, HdfsWriteToMultipleCollectionsTest, CursorMarkTest, TestPseudoReturnFields, TestReplicationHandlerBackup] [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestReplicationHandlerBackup -Dtests.seed=50B89A8CE6089DDA -Dtests.slow=true -Dtests.locale=tr -Dtests.timezone=Canada/Newfoundland -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] ERROR 0.00s | TestReplicationHandlerBackup (suite) <<< [junit4] > Throwable #1: java.io.IOException: Could not remove the following files (in the order of attempts): [junit4] > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\collection1 [junit4] > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002 [junit4] > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\collection1 [junit4] > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001 [junit4] > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\collection1\data: java.nio.file.AccessDeniedException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001\collection1\data [junit4] > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-001 [junit4] > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\collection1\data: java.nio.file.AccessDeniedException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002\collection1\data [junit4] > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001\solr-instance-002 [junit4] > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup 50B89A8CE6089DDA-001 [junit4] > at __randomizedtesting.SeedInfo.seed([50B89A8CE6089DDA]:0) [junit4] > at org.apache.lucene.util.IOUtils.rm(IOUtils.java:294) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] Completed in 8.70s, 2 tests, 1 error <<< FAILURES! [...truncated 369 lines...] [junit4] Suite: org.apache.solr.cloud.BasicDistributedZk2Test [junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.BasicDistributedZk2Test 50B89A8CE6089DDA-001\init-core-data-001 [junit4] 2> 2496885 T10985 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /_z/j [junit4] 2> 2496889 T10985 oasc.ZkTestServer.run STARTING ZK TEST SERVER [junit4] 1> client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 2496890 T10986 oasc.ZkTestServer$ZKServerMain.runFromConfig Starting server [junit4] 2> 2496988 T10985 oasc.ZkTestServer.run start zk server on port:52208 [junit4] 2> 2496988 T10985 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 2496991 T10985 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 2496999 T10993 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@3479f7b7 name:ZooKeeperConnection Watcher:127.0.0.1:52208 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2497000 T10985 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 2497000 T10985 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 2497000 T10985 oascc.SolrZkClient.makePath makePath: /solr [junit4] 2> 2497009 T10985 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 2497011 T10985 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 2497013 T10996 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@2ada31ed name:ZooKeeperConnection Watcher:127.0.0.1:52208/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2497013 T10985 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 2497014 T10985 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 2497014 T10985 oascc.SolrZkClient.makePath makePath: /collections/collection1 [junit4] 2> 2497021 T10985 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards [junit4] 2> 2497023 T10985 oascc.SolrZkClient.makePath makePath: /collections/control_collection [junit4] 2> 2497025 T10985 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards [junit4] 2> 2497028 T10985 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig-tlog.xml to /configs/conf1/solrconfig.xml [junit4] 2> 2497029 T10985 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml [junit4] 2> 2497034 T10985 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\schema.xml to /configs/conf1/schema.xml [junit4] 2> 2497034 T10985 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml [junit4] 2> 2497040 T10985 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 2497040 T10985 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 2497044 T10985 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\stopwords.txt to /configs/conf1/stopwords.txt [junit4] 2> 2497044 T10985 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt [junit4] 2> 2497049 T10985 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\protwords.txt to /configs/conf1/protwords.txt [junit4] 2> 2497049 T10985 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt [junit4] 2> 2497053 T10985 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\currency.xml to /configs/conf1/currency.xml [junit4] 2> 2497053 T10985 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml [junit4] 2> 2497058 T10985 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\enumsConfig.xml to /configs/conf1/enumsConfig.xml [junit4] 2> 2497058 T10985 oascc.SolrZkClient.makePath makePath: /configs/conf1/enumsConfig.xml [junit4] 2> 2497065 T10985 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\open-exchange-rates.json to /configs/conf1/open-exchange-rates.json [junit4] 2> 2497065 T10985 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json [junit4] 2> 2497075 T10985 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 2497075 T10985 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 2497082 T10985 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\old_synonyms.txt to /configs/conf1/old_synonyms.txt [junit4] 2> 2497082 T10985 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt [junit4] 2> 2497088 T10985 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\synonyms.txt to /configs/conf1/synonyms.txt [junit4] 2> 2497089 T10985 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt [junit4] 2> 2498693 T10985 oas.SolrTestCaseJ4.writeCoreProperties Writing core.properties file to C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.BasicDistributedZk2Test 50B89A8CE6089DDA-001\control-001\cores\collection1 [junit4] 2> 2498697 T10985 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 2498710 T10985 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:52215 [junit4] 2> 2498711 T10985 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@c387f44 [junit4] 2> 2498711 T10985 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 2498711 T10985 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.BasicDistributedZk2Test 50B89A8CE6089DDA-001\control-001 [junit4] 2> 2498711 T10985 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.BasicDistributedZk2Test 50B89A8CE6089DDA-001\control-001\' [junit4] 2> 2498752 T10985 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.BasicDistributedZk2Test 50B89A8CE6089DDA-001\control-001\solr.xml [junit4] 2> 2498758 T10985 oasc.CorePropertiesLocator.<init> Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.BasicDistributedZk2Test 50B89A8CE6089DDA-001\control-001\cores [junit4] 2> 2498758 T10985 oasc.CoreContainer.<init> New CoreContainer 934565209 [junit4] 2> 2498760 T10985 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.BasicDistributedZk2Test 50B89A8CE6089DDA-001\control-001\] [junit4] 2> 2498761 T10985 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 2498761 T10985 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: [junit4] 2> 2498761 T10985 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 2498761 T10985 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 2498761 T10985 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000 [junit4] 2> 2498761 T10985 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 2498761 T10985 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 2498763 T10985 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 2498763 T10985 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 2498763 T10985 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 2498763 T10985 oashc.HttpShardHandlerFactory.getParameter Setting useRetries to: false [junit4] 2> 2498763 T10985 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 2498763 T10985 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 2498763 T10985 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 2498765 T10985 oasc.CoreContainer.load Host Name: 127.0.0.1 [junit4] 2> 2498765 T10985 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:52208/solr [junit4] 2> 2498765 T10985 oasc.ZkController.checkChrootPath zkHost includes chroot [junit4] 2> 2498765 T10985 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 2498767 T10985 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 2498769 T11008 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@7ee5e584 name:ZooKeeperConnection Watcher:127.0.0.1:52208 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2498770 T10985 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 2498770 T10985 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 2498775 T10985 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 2498777 T11011 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@28b4f92e name:ZooKeeperConnection Watcher:127.0.0.1:52208/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2498777 T10985 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 2498779 T10985 oascc.SolrZkClient.makePath makePath: /overseer/queue [junit4] 2> 2498783 T10985 oascc.SolrZkClient.makePath makePath: /overseer/collection-queue-work [junit4] 2> 2498787 T10985 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-running [junit4] 2> 2498789 T10985 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-completed [junit4] 2> 2498793 T10985 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-failure [junit4] 2> 2498797 T10985 oascc.SolrZkClient.makePath makePath: /live_nodes [junit4] 2> 2498799 T10985 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:52215__z%2Fj [junit4] 2> 2498800 T10985 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:52215__z%2Fj [junit4] 2> 2498804 T10985 oascc.SolrZkClient.makePath makePath: /overseer_elect [junit4] 2> 2498809 T10985 oascc.SolrZkClient.makePath makePath: /overseer_elect/election [junit4] 2> 2498813 T10985 oasc.Overseer.close Overseer (id=null) closing [junit4] 2> 2498815 T10985 oasc.OverseerElectionContext.runLeaderProcess I am going to be the leader 127.0.0.1:52215__z%2Fj [junit4] 2> 2498815 T10985 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader [junit4] 2> 2498818 T10985 oasc.Overseer.start Overseer (id=93331075684564995-127.0.0.1:52215__z%2Fj-n_0000000000) starting [junit4] 2> 2498822 T10985 oascc.SolrZkClient.makePath makePath: /overseer/queue-work [junit4] 2> 2498834 T10985 oasc.OverseerAutoReplicaFailoverThread.<init> Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=30000 autoReplicaFailoverBadNodeExpiration=60000 [junit4] 2> 2498835 T11013 oasc.OverseerCollectionProcessor.run Process current queue of collection creations [junit4] 2> 2498836 T10985 oascc.SolrZkClient.makePath makePath: /clusterstate.json [junit4] 2> 2498839 T10985 oascc.SolrZkClient.makePath makePath: /aliases.json [junit4] 2> 2498840 T10985 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 2498846 T11012 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue [junit4] 2> 2498847 T10985 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.BasicDistributedZk2Test 50B89A8CE6089DDA-001\control-001\cores [junit4] 2> 2498849 T10985 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.BasicDistributedZk2Test 50B89A8CE6089DDA-001\control-001\cores\collection1\ [junit4] 2> 2498850 T10985 oasc.CorePropertiesLocator.discover Found 1 core d [...truncated too long message...] rollerTest, NumericFieldsTest, SoftAutoCommitTest, MultiThreadedOCPTest, SpatialFilterTest, OverriddenZkACLAndCredentialsProvidersTest, NoCacheHeaderTest, TestMiniSolrCloudClusterSSL, TestSurroundQueryParser, XsltUpdateRequestHandlerTest, RollingRestartTest, LukeRequestHandlerTest, SolrIndexConfigTest, CachingDirectoryFactoryTest, TestCollectionAPI, DistributedFacetPivotLongTailTest, CollectionsAPIDistributedZkTest, DirectUpdateHandlerOptimizeTest, TestCloudInspectUtil, TestSolrConfigHandler, DocValuesTest, TestZkChroot, TestReloadAndDeleteDocs, TestPerFieldSimilarity, SpellCheckComponentTest, TestSolr4Spatial, TestBM25SimilarityFactory, UpdateRequestProcessorFactoryTest, TestQueryUtils, TestHighFrequencyDictionaryFactory, PrimUtilsTest, TestRemoteStreaming, CustomCollectionTest, TestJmxMonitoredMap, TermsComponentTest, DistributedMLTComponentTest, TestExactSharedStatsCache, TestFastLRUCache, DistributedFacetPivotSmallAdvancedTest, TestCustomSort, TestHashPartitioner, DateRangeFieldTest, DefaultValueUpdateProcessorTest, SolrTestCaseJ4Test, StandardRequestHandlerTest, TestTrie, AutoCommitTest, DistributedQueueTest, TestFoldingMultitermQuery, SimpleMLTQParserTest, CloudMLTQParserTest, SolrRequestParserTest, TestMaxScoreQueryParser, UUIDFieldTest, URLClassifyProcessorTest, TestSchemaNameResource, TestFaceting, TestCloudManagedSchema, SimpleCollectionCreateDeleteTest, InfoHandlerTest, TestSweetSpotSimilarityFactory, ResponseHeaderTest, FileUtilsTest, TestRandomMergePolicy, TestSchemaVersionResource, ClusterStateUpdateTest, ConnectionManagerTest, FileBasedSpellCheckerTest, TestDynamicFieldCollectionResource, DistributedTermsComponentTest, EchoParamsTest, IndexBasedSpellCheckerTest, TestImplicitCoreProperties, TestSearcherReuse, FieldAnalysisRequestHandlerTest, MBeansHandlerTest, SortByFunctionTest, HdfsChaosMonkeySafeLeaderTest, DistributedSuggestComponentTest, ExternalCollectionsTest, TestFuzzyAnalyzedSuggestions, ShowFileRequestHandlerTest, AsyncMigrateRouteKeyTest, SearchHandlerTest, DirectSolrConnectionTest, TestFastOutputStream, TestPostingsSolrHighlighter, DateFieldTest, TestAtomicUpdateErrorCases, HdfsWriteToMultipleCollectionsTest, CursorMarkTest, TestPseudoReturnFields, TestReplicationHandlerBackup, TestFastWriter, FieldMutatingUpdateProcessorTest, DistributedIntervalFacetingTest, TestManagedStopFilterFactory, TestIBSimilarityFactory, TestUpdate, DisMaxRequestHandlerTest, BadCopyFieldTest, PolyFieldTest, SSLMigrationTest, TestCollationField, SuggesterTSTTest, MigrateRouteKeyTest, SaslZkACLProviderTest, TestSolrQueryParserDefaultOperatorResource, UUIDUpdateProcessorFallbackTest, TestFunctionQuery, BasicDistributedZkTest, RAMDirectoryFactoryTest, HttpPartitionTest, HighlighterTest, DistributedFacetPivotLargeTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestDefaultStatsCache, TestBlendedInfixSuggestions, NotRequiredUniqueKeyTest, TestRebalanceLeaders, BasicFunctionalityTest, BufferStoreTest, OutOfBoxZkACLAndCredentialsProvidersTest, TestReplicationHandler, VMParamsZkACLAndCredentialsProvidersTest, TestQuerySenderListener, ConvertedLegacyTest, TestFileDictionaryLookup, SimpleFacetsTest, TestCoreDiscovery, TestManagedSchemaDynamicFieldResource, TestLMDirichletSimilarityFactory, SuggesterTest, TestJmxIntegration, ParsingFieldUpdateProcessorsTest, TestSchemaManager, XmlUpdateRequestHandlerTest, TestPHPSerializedResponseWriter, TestPhraseSuggestions, AddSchemaFieldsUpdateProcessorFactoryTest, TriLevelCompositeIdRoutingTest, SystemInfoHandlerTest, OverseerStatusTest, TestSerializedLuceneMatchVersion, LeaderInitiatedRecoveryOnCommitTest, TestSolr4Spatial2, TestCopyFieldCollectionResource, CoreMergeIndexesAdminHandlerTest, TestDocBasedVersionConstraints, FullSolrCloudDistribCmdsTest, SyncSliceTest, PreAnalyzedFieldTest, TestNoOpRegenerator, OpenExchangeRatesOrgProviderTest, DocumentBuilderTest, TermVectorComponentDistributedTest, CSVRequestHandlerTest, TestFieldSortValues, TestBlobHandler, AtomicUpdatesTest, JsonLoaderTest, TestSolrJ, TestCodecSupport, BasicZkTest, TestCollapseQParserPlugin, AnalysisAfterCoreReloadTest, TestManagedSchemaFieldTypeResource, DistribJoinFromCollectionTest, CurrencyFieldXmlFileTest, OpenCloseCoreStressTest, TestDynamicFieldResource, PreAnalyzedUpdateProcessorTest, TestSimpleQParserPlugin, CollectionsAPIAsyncDistributedZkTest, EnumFieldTest, TestBinaryResponseWriter, OverseerCollectionProcessorTest, TestIntervalFaceting, TestStressRecovery, DistanceFunctionTest, RegexBoostProcessorTest, TestRealTimeGet, TestUtils, StatsComponentTest, DistributedQueryComponentCustomSortTest, TestCharFilters, TestSolrDeletionPolicy2, IndexSchemaRuntimeFieldTest, SignatureUpdateProcessorFactoryTest, TestJoin, LeaderElectionIntegrationTest, TestRecovery, HdfsRecoveryZkTest, ResourceLoaderTest, TestCSVLoader, PingRequestHandlerTest, TestInitParams, CoreAdminHandlerTest, TestQueryTypes, TestShardHandlerFactory, TestFiltering, TestInfoStreamLogging, ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test, OverseerTest, ShardRoutingTest, RecoveryZkTest, TestRandomFaceting, LeaderElectionTest, ZkSolrClientTest, TestRandomDVFaceting, ZkCLITest, ShardRoutingCustomTest, TestDistributedSearch, TestDistributedGrouping, DistributedSpellCheckComponentTest, TestStressReorder, TestReload, TestStressVersions, HardAutoCommitTest, TestRangeQuery, TestCoreContainer, SolrCoreTest, TestGroupingSearch, SolrCmdDistributorTest, QueryElevationComponentTest, BadIndexSchemaTest, TestSort, TestLazyCores] [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestLazyCores -Dtests.seed=50B89A8CE6089DDA -Dtests.slow=true -Dtests.locale=in -Dtests.timezone=Australia/Melbourne -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] ERROR 0.00s | TestLazyCores (suite) <<< [junit4] > Throwable #1: java.lang.AssertionError: ERROR: SolrIndexSearcher opens=51 closes=50 [junit4] > at __randomizedtesting.SeedInfo.seed([50B89A8CE6089DDA]:0) [junit4] > at org.apache.solr.SolrTestCaseJ4.endTrackingSearchers(SolrTestCaseJ4.java:466) [junit4] > at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:212) [junit4] > at java.lang.Thread.run(Thread.java:745)Throwable #2: com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.core.TestLazyCores: [junit4] > 1) Thread[id=13568, name=searcherExecutor-6793-thread-1, state=WAITING, group=TGRP-TestLazyCores] [junit4] > at sun.misc.Unsafe.park(Native Method) [junit4] > at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) [junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) [junit4] > at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) [junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) [junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) [junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] > at __randomizedtesting.SeedInfo.seed([50B89A8CE6089DDA]:0)Throwable #3: com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated: [junit4] > 1) Thread[id=13568, name=searcherExecutor-6793-thread-1, state=WAITING, group=TGRP-TestLazyCores] [junit4] > at sun.misc.Unsafe.park(Native Method) [junit4] > at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) [junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) [junit4] > at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) [junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) [junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) [junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] > at __randomizedtesting.SeedInfo.seed([50B89A8CE6089DDA]:0) [junit4] Completed in 141.07s, 7 tests, 1 failure, 2 errors <<< FAILURES! [...truncated 633 lines...] BUILD FAILED C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:529: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:477: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:61: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\extra-targets.xml:39: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build.xml:191: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\common-build.xml:508: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:1368: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:975: There were test failures: 466 suites, 1863 tests, 5 suite-level errors, 738 ignored (28 assumptions) Total time: 89 minutes 9 seconds Build step 'Invoke Ant' marked build as failure [description-setter] Description set: Java: 64bit/jdk1.8.0_31 -XX:-UseCompressedOops -XX:+UseG1GC Archiving artifacts Recording test results Email was triggered for: Failure - Any Sending email for trigger: Failure - Any
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org