Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-4.x/585/

3 tests failed.
REGRESSION:  
org.apache.solr.handler.TestReplicationHandler.doTestReplicateAfterCoreReload

Error Message:
expected:<[{indexVersion=1406477990053,generation=2,filelist=[_bta.fdt, 
_bta.fdx, _bta.fnm, _bta.si, _bta_Lucene41_0.doc, _bta_Lucene41_0.tim, 
_bta_Lucene41_0.tip, _bta_nrm.cfe, _bta_nrm.cfs, _nik.cfe, _nik.cfs, _nik.si, 
_yok.cfe, _yok.cfs, _yok.si, _yp3.cfe, _yp3.cfs, _yp3.si, _yp4.cfe, _yp4.cfs, 
_yp4.si, _yp5.cfe, _yp5.cfs, _yp5.si, _yp6.cfe, _yp6.cfs, _yp6.si, _yp7.cfe, 
_yp7.cfs, _yp7.si, _yp8.cfe, _yp8.cfs, _yp8.si, _yp9.cfe, _yp9.cfs, _yp9.si, 
_ypa.cfe, _ypa.cfs, _ypa.si, _ypu.cfe, _ypu.cfs, _ypu.si, _ypv.cfe, _ypv.cfs, 
_ypv.si, _ypw.cfe, _ypw.cfs, _ypw.si, _ypx.cfe, _ypx.cfs, _ypx.si, _ypy.cfe, 
_ypy.cfs, _ypy.si, segments_2]}]> but 
was:<[{indexVersion=1406477990053,generation=2,filelist=[_bta.fdt, _bta.fdx, 
_bta.fnm, _bta.si, _bta_Lucene41_0.doc, _bta_Lucene41_0.tim, 
_bta_Lucene41_0.tip, _bta_nrm.cfe, _bta_nrm.cfs, _nik.cfe, _nik.cfs, _nik.si, 
_yok.cfe, _yok.cfs, _yok.si, _yp3.cfe, _yp3.cfs, _yp3.si, _yp4.cfe, _yp4.cfs, 
_yp4.si, _yp5.cfe, _yp5.cfs, _yp5.si, _yp6.cfe, _yp6.cfs, _yp6.si, _yp7.cfe, 
_yp7.cfs, _yp7.si, _yp8.cfe, _yp8.cfs, _yp8.si, _yp9.cfe, _yp9.cfs, _yp9.si, 
_ypa.cfe, _ypa.cfs, _ypa.si, _ypu.cfe, _ypu.cfs, _ypu.si, _ypv.cfe, _ypv.cfs, 
_ypv.si, _ypw.cfe, _ypw.cfs, _ypw.si, _ypx.cfe, _ypx.cfs, _ypx.si, _ypy.cfe, 
_ypy.cfs, _ypy.si, segments_2]}, 
{indexVersion=1406477990053,generation=3,filelist=[_bta.fdt, _bta.fdx, 
_bta.fnm, _bta.si, _bta_Lucene41_0.doc, _bta_Lucene41_0.tim, 
_bta_Lucene41_0.tip, _bta_nrm.cfe, _bta_nrm.cfs, _nik.cfe, _nik.cfs, _nik.si, 
_ypc.cfe, _ypc.cfs, _ypc.si, _ypu.cfe, _ypu.cfs, _ypu.si, _ypv.cfe, _ypv.cfs, 
_ypv.si, _ypw.cfe, _ypw.cfs, _ypw.si, _ypx.cfe, _ypx.cfs, _ypx.si, _ypy.cfe, 
_ypy.cfs, _ypy.si, segments_3]}]>

Stack Trace:
java.lang.AssertionError: 
expected:<[{indexVersion=1406477990053,generation=2,filelist=[_bta.fdt, 
_bta.fdx, _bta.fnm, _bta.si, _bta_Lucene41_0.doc, _bta_Lucene41_0.tim, 
_bta_Lucene41_0.tip, _bta_nrm.cfe, _bta_nrm.cfs, _nik.cfe, _nik.cfs, _nik.si, 
_yok.cfe, _yok.cfs, _yok.si, _yp3.cfe, _yp3.cfs, _yp3.si, _yp4.cfe, _yp4.cfs, 
_yp4.si, _yp5.cfe, _yp5.cfs, _yp5.si, _yp6.cfe, _yp6.cfs, _yp6.si, _yp7.cfe, 
_yp7.cfs, _yp7.si, _yp8.cfe, _yp8.cfs, _yp8.si, _yp9.cfe, _yp9.cfs, _yp9.si, 
_ypa.cfe, _ypa.cfs, _ypa.si, _ypu.cfe, _ypu.cfs, _ypu.si, _ypv.cfe, _ypv.cfs, 
_ypv.si, _ypw.cfe, _ypw.cfs, _ypw.si, _ypx.cfe, _ypx.cfs, _ypx.si, _ypy.cfe, 
_ypy.cfs, _ypy.si, segments_2]}]> but 
was:<[{indexVersion=1406477990053,generation=2,filelist=[_bta.fdt, _bta.fdx, 
_bta.fnm, _bta.si, _bta_Lucene41_0.doc, _bta_Lucene41_0.tim, 
_bta_Lucene41_0.tip, _bta_nrm.cfe, _bta_nrm.cfs, _nik.cfe, _nik.cfs, _nik.si, 
_yok.cfe, _yok.cfs, _yok.si, _yp3.cfe, _yp3.cfs, _yp3.si, _yp4.cfe, _yp4.cfs, 
_yp4.si, _yp5.cfe, _yp5.cfs, _yp5.si, _yp6.cfe, _yp6.cfs, _yp6.si, _yp7.cfe, 
_yp7.cfs, _yp7.si, _yp8.cfe, _yp8.cfs, _yp8.si, _yp9.cfe, _yp9.cfs, _yp9.si, 
_ypa.cfe, _ypa.cfs, _ypa.si, _ypu.cfe, _ypu.cfs, _ypu.si, _ypv.cfe, _ypv.cfs, 
_ypv.si, _ypw.cfe, _ypw.cfs, _ypw.si, _ypx.cfe, _ypx.cfs, _ypx.si, _ypy.cfe, 
_ypy.cfs, _ypy.si, segments_2]}, 
{indexVersion=1406477990053,generation=3,filelist=[_bta.fdt, _bta.fdx, 
_bta.fnm, _bta.si, _bta_Lucene41_0.doc, _bta_Lucene41_0.tim, 
_bta_Lucene41_0.tip, _bta_nrm.cfe, _bta_nrm.cfs, _nik.cfe, _nik.cfs, _nik.si, 
_ypc.cfe, _ypc.cfs, _ypc.si, _ypu.cfe, _ypu.cfs, _ypu.si, _ypv.cfe, _ypv.cfs, 
_ypv.si, _ypw.cfe, _ypw.cfs, _ypw.si, _ypx.cfe, _ypx.cfs, _ypx.si, _ypy.cfe, 
_ypy.cfs, _ypy.si, segments_3]}]>
        at 
__randomizedtesting.SeedInfo.seed([E4FFCDCA8EC968BC:C128D6FAFE8166BF]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.failNotEquals(Assert.java:647)
        at org.junit.Assert.assertEquals(Assert.java:128)
        at org.junit.Assert.assertEquals(Assert.java:147)
        at 
org.apache.solr.handler.TestReplicationHandler.doTestReplicateAfterCoreReload(TestReplicationHandler.java:1190)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:606)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
        at 
org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
        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:43)
        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:
1 thread leaked from SUITE scope at 
org.apache.solr.handler.TestReplicationHandlerBackup:     1) Thread[id=31922, 
name=Thread-8018, state=RUNNABLE, group=TGRP-TestReplicationHandlerBackup]      
   at java.net.PlainSocketImpl.socketConnect(Native Method)         at 
java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:339)    
     at 
java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:200)
         at 
java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:182)      
   at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)         at 
java.net.Socket.connect(Socket.java:579)         at 
java.net.Socket.connect(Socket.java:528)         at 
sun.net.NetworkClient.doConnect(NetworkClient.java:180)         at 
sun.net.www.http.HttpClient.openServer(HttpClient.java:432)         at 
sun.net.www.http.HttpClient.openServer(HttpClient.java:527)         at 
sun.net.www.http.HttpClient.parseHTTP(HttpClient.java:652)         at 
sun.net.www.protocol.http.HttpURLConnection.getInputStream(HttpURLConnection.java:1323)
         at java.net.URL.openStream(URL.java:1037)         at 
org.apache.solr.handler.TestReplicationHandlerBackup$BackupThread.run(TestReplicationHandlerBackup.java:314)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE 
scope at org.apache.solr.handler.TestReplicationHandlerBackup: 
   1) Thread[id=31922, name=Thread-8018, state=RUNNABLE, 
group=TGRP-TestReplicationHandlerBackup]
        at java.net.PlainSocketImpl.socketConnect(Native Method)
        at 
java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:339)
        at 
java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:200)
        at 
java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:182)
        at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)
        at java.net.Socket.connect(Socket.java:579)
        at java.net.Socket.connect(Socket.java:528)
        at sun.net.NetworkClient.doConnect(NetworkClient.java:180)
        at sun.net.www.http.HttpClient.openServer(HttpClient.java:432)
        at sun.net.www.http.HttpClient.openServer(HttpClient.java:527)
        at sun.net.www.http.HttpClient.parseHTTP(HttpClient.java:652)
        at 
sun.net.www.protocol.http.HttpURLConnection.getInputStream(HttpURLConnection.java:1323)
        at java.net.URL.openStream(URL.java:1037)
        at 
org.apache.solr.handler.TestReplicationHandlerBackup$BackupThread.run(TestReplicationHandlerBackup.java:314)
        at __randomizedtesting.SeedInfo.seed([E4FFCDCA8EC968BC]:0)


FAILED:  
junit.framework.TestSuite.org.apache.solr.handler.TestReplicationHandlerBackup

Error Message:
There are still zombie threads that couldn't be terminated:    1) 
Thread[id=31922, name=Thread-8018, state=RUNNABLE, 
group=TGRP-TestReplicationHandlerBackup]         at 
java.net.PlainSocketImpl.socketConnect(Native Method)         at 
java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:339)    
     at 
java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:200)
         at 
java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:182)      
   at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)         at 
java.net.Socket.connect(Socket.java:579)         at 
java.net.Socket.connect(Socket.java:528)         at 
sun.net.NetworkClient.doConnect(NetworkClient.java:180)         at 
sun.net.www.http.HttpClient.openServer(HttpClient.java:432)         at 
sun.net.www.http.HttpClient.openServer(HttpClient.java:527)         at 
sun.net.www.http.HttpClient.parseHTTP(HttpClient.java:652)         at 
sun.net.www.protocol.http.HttpURLConnection.getInputStream(HttpURLConnection.java:1323)
         at java.net.URL.openStream(URL.java:1037)         at 
org.apache.solr.handler.TestReplicationHandlerBackup$BackupThread.run(TestReplicationHandlerBackup.java:314)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie 
threads that couldn't be terminated:
   1) Thread[id=31922, name=Thread-8018, state=RUNNABLE, 
group=TGRP-TestReplicationHandlerBackup]
        at java.net.PlainSocketImpl.socketConnect(Native Method)
        at 
java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:339)
        at 
java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:200)
        at 
java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:182)
        at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)
        at java.net.Socket.connect(Socket.java:579)
        at java.net.Socket.connect(Socket.java:528)
        at sun.net.NetworkClient.doConnect(NetworkClient.java:180)
        at sun.net.www.http.HttpClient.openServer(HttpClient.java:432)
        at sun.net.www.http.HttpClient.openServer(HttpClient.java:527)
        at sun.net.www.http.HttpClient.parseHTTP(HttpClient.java:652)
        at 
sun.net.www.protocol.http.HttpURLConnection.getInputStream(HttpURLConnection.java:1323)
        at java.net.URL.openStream(URL.java:1037)
        at 
org.apache.solr.handler.TestReplicationHandlerBackup$BackupThread.run(TestReplicationHandlerBackup.java:314)
        at __randomizedtesting.SeedInfo.seed([E4FFCDCA8EC968BC]:0)




Build Log:
[...truncated 12533 lines...]
   [junit4] Suite: org.apache.solr.handler.TestReplicationHandler
   [junit4]   2> Creating dataDir: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/init-core-data-001
   [junit4]   2> 4385109 T16350 oas.SolrTestCaseJ4.setUp ###Starting 
doTestDetails
   [junit4]   2> 4385124 T16350 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 4385130 T16350 oejs.AbstractConnector.doStart Started 
[email protected]:36483
   [junit4]   2> 4385130 T16350 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()
   [junit4]   2> 4385131 T16350 oasc.SolrResourceLoader.locateSolrHome JNDI not 
configured for solr (NoInitialContextEx)
   [junit4]   2> 4385131 T16350 oasc.SolrResourceLoader.locateSolrHome using 
system property solr.solr.home: 
./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001
   [junit4]   2> 4385131 T16350 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/'
   [junit4]   2> 4385175 T16350 oasc.ConfigSolr.fromFile Loading container 
configuration from 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/solr.xml
   [junit4]   2> 4385253 T16350 oasc.CoreContainer.<init> New CoreContainer 
248555160
   [junit4]   2> 4385254 T16350 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/]
   [junit4]   2> 4385255 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting socketTimeout to: 90000
   [junit4]   2> 4385256 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting urlScheme to: 
   [junit4]   2> 4385256 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting connTimeout to: 15000
   [junit4]   2> 4385256 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnectionsPerHost to: 20
   [junit4]   2> 4385257 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting corePoolSize to: 0
   [junit4]   2> 4385257 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting maximumPoolSize to: 2147483647
   [junit4]   2> 4385257 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting maxThreadIdleTime to: 5
   [junit4]   2> 4385258 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting sizeOfQueue to: -1
   [junit4]   2> 4385258 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting fairnessPolicy to: false
   [junit4]   2> 4385259 T16350 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=false
   [junit4]   2> 4385259 T16350 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 4385259 T16350 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 4385260 T16350 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 4385265 T16360 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/collection1/'
   [junit4]   2> 4385314 T16360 oasc.SolrConfig.<init> Using Lucene 
MatchVersion: LUCENE_4_10
   [junit4]   2> 4385356 T16360 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 4385357 T16360 oass.IndexSchema.readSchema Reading Solr Schema 
from schema.xml
   [junit4]   2> 4385363 T16360 oass.IndexSchema.readSchema [collection1] 
Schema name=test
   [junit4]   2> 4385380 T16360 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 4385381 T16360 oasc.CoreContainer.create Creating SolrCore 
'collection1' using configuration from instancedir 
./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/collection1/
   [junit4]   2> 4385382 T16360 oasc.SolrCore.initDirectoryFactory 
org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 4385382 T16360 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/collection1/,
 
dataDir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/collection1/data/
   [junit4]   2> 4385382 T16360 oasc.SolrCore.<init> JMX monitoring not 
detected for core: collection1
   [junit4]   2> 4385383 T16360 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/collection1/data
   [junit4]   2> 4385383 T16360 oasc.SolrCore.getNewIndexDir New index 
directory detected: old=null 
new=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/collection1/data/index/
   [junit4]   2> 4385383 T16360 oasc.SolrCore.initIndex WARN [collection1] Solr 
index directory 
'/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/collection1/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 4385384 T16360 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/collection1/data/index
   [junit4]   2> 4385384 T16360 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=18, maxMergeAtOnceExplicit=26, maxMergedSegmentMB=67.6337890625, 
floorSegmentMB=1.693359375, forceMergeDeletesPctAllowed=19.688060269334418, 
segmentsPerTier=11.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.5920792516815081
   [junit4]   2> 4385385 T16360 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2e402ab9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5e4a010d),segFN=segments_1,generation=1}
   [junit4]   2> 4385385 T16360 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 4385386 T16360 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 4385386 T16360 oasc.RequestHandlers.initHandlersFromConfig 
created standard: solr.StandardRequestHandler
   [junit4]   2> 4385387 T16360 oasc.RequestHandlers.initHandlersFromConfig 
created /replication: solr.ReplicationHandler
   [junit4]   2> 4385387 T16360 oasc.RequestHandlers.initHandlersFromConfig 
created defaults: solr.StandardRequestHandler
   [junit4]   2> 4385387 T16360 oasc.RequestHandlers.initHandlersFromConfig 
adding lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 4385387 T16360 oasc.RequestHandlers.initHandlersFromConfig 
created lazy: solr.StandardRequestHandler
   [junit4]   2> 4385388 T16360 oasc.RequestHandlers.initHandlersFromConfig 
created /update: solr.UpdateRequestHandler
   [junit4]   2> 4385406 T16360 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 4385409 T16360 oasu.CommitTracker.<init> Hard AutoCommit: 
disabled
   [junit4]   2> 4385409 T16360 oasu.CommitTracker.<init> Soft AutoCommit: 
disabled
   [junit4]   2> 4385409 T16360 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: 
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=9, 
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, 
calibrateSizeByDeletes=false, maxMergeDocs=2147483647, 
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8239541096061591]
   [junit4]   2> 4385410 T16360 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2e402ab9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5e4a010d),segFN=segments_1,generation=1}
   [junit4]   2> 4385410 T16360 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 4385410 T16360 oass.SolrIndexSearcher.<init> Opening 
Searcher@76f2320d[collection1] main
   [junit4]   2> 4385411 T16360 
oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage 
initialized to use dir: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/collection1/conf
   [junit4]   2> 4385411 T16360 oasr.RestManager.init Initializing RestManager 
with initArgs: 
{storageDir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/collection1/conf}
   [junit4]   2> 4385411 T16360 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using 
file:dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/collection1/conf
   [junit4]   2> 4385412 T16360 oasr.ManagedResource.reloadFromStorage WARN No 
stored data found for /rest/managed
   [junit4]   2> 4385413 T16360 oasr.ManagedResourceStorage$JsonStorage.store 
Saved JSON object to path _rest_managed.json using 
file:dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/collection1/conf
   [junit4]   2> 4385413 T16360 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 4385413 T16360 oash.ReplicationHandler.inform Replication 
enabled for following config files: schema.xml,xslt/dummy.xsl
   [junit4]   2> 4385414 T16360 oash.ReplicationHandler.inform Commits will be 
reserved for  10000
   [junit4]   2> 4385414 T16360 oasc.CoreContainer.registerCore registering 
core: collection1
   [junit4]   2> 4385414 T16361 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@76f2320d[collection1] 
main{StandardDirectoryReader(segments_1:1:nrt)}
   [junit4]   2> 4385414 T16350 oass.SolrDispatchFilter.init 
user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1
   [junit4]   2> 4385415 T16350 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init() done
   [junit4]   2> 4385428 T16350 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 4385433 T16350 oejs.AbstractConnector.doStart Started 
[email protected]:36484
   [junit4]   2> 4385433 T16350 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()
   [junit4]   2> 4385434 T16350 oasc.SolrResourceLoader.locateSolrHome JNDI not 
configured for solr (NoInitialContextEx)
   [junit4]   2> 4385434 T16350 oasc.SolrResourceLoader.locateSolrHome using 
system property solr.solr.home: 
./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002
   [junit4]   2> 4385434 T16350 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/'
   [junit4]   2> 4385451 T16350 oasc.ConfigSolr.fromFile Loading container 
configuration from 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/solr.xml
   [junit4]   2> 4385495 T16350 oasc.CoreContainer.<init> New CoreContainer 
1601195805
   [junit4]   2> 4385495 T16350 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/]
   [junit4]   2> 4385497 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting socketTimeout to: 90000
   [junit4]   2> 4385497 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting urlScheme to: 
   [junit4]   2> 4385497 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting connTimeout to: 15000
   [junit4]   2> 4385498 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnectionsPerHost to: 20
   [junit4]   2> 4385498 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting corePoolSize to: 0
   [junit4]   2> 4385498 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting maximumPoolSize to: 2147483647
   [junit4]   2> 4385499 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting maxThreadIdleTime to: 5
   [junit4]   2> 4385499 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting sizeOfQueue to: -1
   [junit4]   2> 4385499 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting fairnessPolicy to: false
   [junit4]   2> 4385500 T16350 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=false
   [junit4]   2> 4385500 T16350 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 4385501 T16350 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 4385501 T16350 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 4385506 T16372 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/collection1/'
   [junit4]   2> 4385555 T16372 oasc.SolrConfig.<init> Using Lucene 
MatchVersion: LUCENE_4_10
   [junit4]   2> 4385609 T16372 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 4385610 T16372 oass.IndexSchema.readSchema Reading Solr Schema 
from schema.xml
   [junit4]   2> 4385616 T16372 oass.IndexSchema.readSchema [collection1] 
Schema name=test
   [junit4]   2> 4385628 T16372 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 4385629 T16372 oasc.CoreContainer.create Creating SolrCore 
'collection1' using configuration from instancedir 
./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/collection1/
   [junit4]   2> 4385630 T16372 oasc.SolrCore.initDirectoryFactory 
org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 4385630 T16372 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/collection1/,
 
dataDir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/collection1/data/
   [junit4]   2> 4385630 T16372 oasc.SolrCore.<init> JMX monitoring not 
detected for core: collection1
   [junit4]   2> 4385631 T16372 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/collection1/data
   [junit4]   2> 4385631 T16372 oasc.SolrCore.getNewIndexDir New index 
directory detected: old=null 
new=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/collection1/data/index/
   [junit4]   2> 4385631 T16372 oasc.SolrCore.initIndex WARN [collection1] Solr 
index directory 
'/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/collection1/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 4385633 T16372 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/collection1/data/index
   [junit4]   2> 4385633 T16372 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=18, maxMergeAtOnceExplicit=26, maxMergedSegmentMB=67.6337890625, 
floorSegmentMB=1.693359375, forceMergeDeletesPctAllowed=19.688060269334418, 
segmentsPerTier=11.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.5920792516815081
   [junit4]   2> 4385634 T16372 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@76d9fe9d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@71e35a33),segFN=segments_1,generation=1}
   [junit4]   2> 4385635 T16372 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 4385635 T16372 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 4385636 T16372 oasc.RequestHandlers.initHandlersFromConfig 
created standard: solr.StandardRequestHandler
   [junit4]   2> 4385636 T16372 oasc.RequestHandlers.initHandlersFromConfig 
created defaults: solr.StandardRequestHandler
   [junit4]   2> 4385636 T16372 oasc.RequestHandlers.initHandlersFromConfig 
adding lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 4385636 T16372 oasc.RequestHandlers.initHandlersFromConfig 
created lazy: solr.StandardRequestHandler
   [junit4]   2> 4385637 T16372 oasc.RequestHandlers.initHandlersFromConfig 
created /update: solr.UpdateRequestHandler
   [junit4]   2> 4385637 T16372 oasc.RequestHandlers.initHandlersFromConfig 
created /replication: solr.ReplicationHandler
   [junit4]   2> 4385639 T16372 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 4385641 T16372 oasu.CommitTracker.<init> Hard AutoCommit: 
disabled
   [junit4]   2> 4385641 T16372 oasu.CommitTracker.<init> Soft AutoCommit: 
disabled
   [junit4]   2> 4385642 T16372 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: 
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=9, 
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, 
calibrateSizeByDeletes=false, maxMergeDocs=2147483647, 
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8239541096061591]
   [junit4]   2> 4385642 T16372 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@76d9fe9d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@71e35a33),segFN=segments_1,generation=1}
   [junit4]   2> 4385643 T16372 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 4385643 T16372 oass.SolrIndexSearcher.<init> Opening 
Searcher@542a0e5a[collection1] main
   [junit4]   2> 4385643 T16372 
oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage 
initialized to use dir: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/collection1/conf
   [junit4]   2> 4385644 T16372 oasr.RestManager.init Initializing RestManager 
with initArgs: 
{storageDir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/collection1/conf}
   [junit4]   2> 4385644 T16372 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using 
file:dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/collection1/conf
   [junit4]   2> 4385645 T16372 oasr.ManagedResource.reloadFromStorage WARN No 
stored data found for /rest/managed
   [junit4]   2> 4385645 T16372 oasr.ManagedResourceStorage$JsonStorage.store 
Saved JSON object to path _rest_managed.json using 
file:dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/collection1/conf
   [junit4]   2> 4385646 T16372 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 4385646 T16372 oash.SnapPuller.startExecutorService Poll 
Scheduled at an interval of 1000ms
   [junit4]   2> 4385647 T16372 oasc.CoreContainer.registerCore registering 
core: collection1
   [junit4]   2> 4385647 T16373 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@542a0e5a[collection1] 
main{StandardDirectoryReader(segments_1:1:nrt)}
   [junit4]   2> 4385647 T16350 oass.SolrDispatchFilter.init 
user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1
   [junit4]   2> 4385648 T16350 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init() done
   [junit4]   2> ASYNC  NEW_CORE C9906 name=collection1 
org.apache.solr.core.SolrCore@3ca433db
   [junit4]   2> 4385651 T16353 C9906 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/select params={sort=id+desc&version=2&q=*:*&wt=javabin} 
hits=0 status=0 QTime=1 
   [junit4]   2> 4385654 T16353 C9906 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={_trace=getDetails&qt=/replication&command=details&version=2&wt=javabin} 
status=0 QTime=0 
   [junit4]   2> 4385659 T16354 C9906 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={qt=/replication&slave=false&command=details&version=2&wt=javabin} 
status=0 QTime=0 
   [junit4]   2> ASYNC  NEW_CORE C9907 name=collection1 
org.apache.solr.core.SolrCore@1966442d
   [junit4]   2> 4385660 T16365 C9907 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={_trace=getDetails&qt=/replication&command=details&version=2&wt=javabin} 
status=0 QTime=4 
   [junit4]   2> 4385663 T16353 C9906 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[0]} 
0 0
   [junit4]   2> 4385666 T16353 C9906 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 4385667 T16353 C9906 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2e402ab9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5e4a010d),segFN=segments_1,generation=1}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2e402ab9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5e4a010d),segFN=segments_2,generation=2}
   [junit4]   2> 4385669 T16353 C9906 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 2
   [junit4]   2> 4385671 T16353 C9906 oass.SolrIndexSearcher.<init> Opening 
Searcher@422aca31[collection1] main
   [junit4]   2> 4385671 T16353 C9906 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 4385671 T16361 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@422aca31[collection1] 
main{StandardDirectoryReader(segments_2:3:nrt _0(4.10):c1)}
   [junit4]   2> 4385672 T16353 C9906 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update 
params={waitSearcher=true&version=2&softCommit=false&commit=true&wt=javabin} 
{commit=} 0 6
   [junit4]   2> 4385721 T16376 oash.SnapPuller.<init> WARN 'masterUrl' must be 
specified without the /replication suffix
   [junit4]   2> 4385723 T16376 oash.SnapPuller.<init>  No value set for 
'pollInterval'. Timer Task not started.
   [junit4]   2> 4385726 T16354 C9906 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={qt=/replication&command=indexversion&version=2&wt=javabin} status=0 
QTime=0 
   [junit4]   2> 4385727 T16376 oash.SnapPuller.fetchLatestIndex Master's 
generation: 2
   [junit4]   2> 4385727 T16376 oash.SnapPuller.fetchLatestIndex Slave's 
generation: 1
   [junit4]   2> 4385727 T16376 oash.SnapPuller.fetchLatestIndex Starting 
replication process
   [junit4]   2> 4385732 T16354 C9906 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={qt=/replication&command=filelist&version=2&generation=2&wt=javabin} 
status=0 QTime=2 
   [junit4]   2> 4385732 T16376 oash.SnapPuller.fetchLatestIndex Number of 
files in latest index in master: 4
   [junit4]   2> 4385733 T16376 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/collection1/data/index.20140727120919782
   [junit4]   2> 4385733 T16376 oasu.DefaultSolrCoreState.closeIndexWriter 
Closing IndexWriter...
   [junit4]   2> 4385733 T16376 oasu.DefaultSolrCoreState.closeIndexWriter 
Waiting until IndexWriter is unused... core=collection1
   [junit4]   2> 4385734 T16376 oasu.DefaultSolrCoreState.rollbackIndexWriter 
Rollback old IndexWriter... core=collection1
   [junit4]   2> 4385734 T16376 oash.SnapPuller.fetchLatestIndex Starting 
download to MockDirectoryWrapper(RAMDirectory@27b3a72 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f171dfe) 
fullCopy=false
   [junit4]   2> 4385737 T16354 C9906 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={qt=/replication&command=filecontent&checksum=true&generation=2&wt=filestream&file=_0.cfe}
 status=0 QTime=0 
   [junit4]   2> 4385741 T16354 C9906 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={qt=/replication&command=filecontent&checksum=true&generation=2&wt=filestream&file=_0.si}
 status=0 QTime=0 
   [junit4]   2> 4385744 T16354 C9906 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={qt=/replication&command=filecontent&checksum=true&generation=2&wt=filestream&file=segments_2}
 status=0 QTime=0 
   [junit4]   2> 4385748 T16354 C9906 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={qt=/replication&command=filecontent&checksum=true&generation=2&wt=filestream&file=_0.cfs}
 status=0 QTime=0 
   [junit4]   2> 4385748 T16376 oash.SnapPuller.fetchLatestIndex Total time 
taken for download : 0 secs
   [junit4]   2> 4385750 T16376 oasu.DefaultSolrCoreState.openIndexWriter 
Creating new IndexWriter...
   [junit4]   2> 4385750 T16376 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.MockRandomMergePolicy: 
org.apache.lucene.index.MockRandomMergePolicy@191825
   [junit4]   2> 4385751 T16376 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@76d9fe9d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@71e35a33),segFN=segments_1,generation=1}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@76d9fe9d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@71e35a33),segFN=segments_2,generation=2}
   [junit4]   2> 4385753 T16376 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 2
   [junit4]   2> 4385753 T16376 oasu.DefaultSolrCoreState.openIndexWriter New 
IndexWriter is ready to be used.
   [junit4]   2> 4385754 T16376 oass.SolrIndexSearcher.<init> Opening 
Searcher@433a3fe2[collection1] main
   [junit4]   2> 4385754 T16373 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@433a3fe2[collection1] 
main{StandardDirectoryReader(segments_2:3:nrt _0(4.10):c1)}
   [junit4]   2> 4385755 T16376 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/collection1/data/index.20140727120919782
 
[CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/collection1/data/index.20140727120919782;done=true>>]
   [junit4]   2> 4385755 T16376 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/collection1/data/index.20140727120919782
   [junit4]   2> 4385756 T16366 C9907 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={masterUrl=http://127.0.0.1:36483/solr/replication&command=fetchindex&wait=true}
 status=0 QTime=35 
   [junit4]   2> 4385766 T16354 C9906 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={qt=/replication&slave=false&command=details&version=2&wt=javabin} 
status=0 QTime=0 
   [junit4]   2> 4385766 T16365 C9907 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={_trace=getDetails&qt=/replication&command=details&version=2&wt=javabin} 
status=0 QTime=2 
   [junit4]   2> 4385769 T16353 C9906 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[1]} 
0 0
   [junit4]   2> 4385773 T16353 C9906 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 4385775 T16353 C9906 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2e402ab9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5e4a010d),segFN=segments_2,generation=2}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2e402ab9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5e4a010d),segFN=segments_3,generation=3}
   [junit4]   2> 4385775 T16353 C9906 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 3
   [junit4]   2> 4385776 T16353 C9906 oass.SolrIndexSearcher.<init> Opening 
Searcher@5c29df30[collection1] main
   [junit4]   2> 4385776 T16353 C9906 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 4385776 T16361 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@5c29df30[collection1] 
main{StandardDirectoryReader(segments_3:5:nrt _0(4.10):c1 _1(4.10):c1)}
   [junit4]   2> 4385777 T16353 C9906 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update 
params={waitSearcher=true&version=2&softCommit=false&commit=true&wt=javabin} 
{commit=} 0 4
   [junit4]   2> 4385778 T16379 oash.SnapPuller.<init> WARN 'masterUrl' must be 
specified without the /replication suffix
   [junit4]   2> 4385779 T16379 oash.SnapPuller.<init>  No value set for 
'pollInterval'. Timer Task not started.
   [junit4]   2> 4385781 T16354 C9906 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={qt=/replication&command=indexversion&version=2&wt=javabin} status=0 
QTime=0 
   [junit4]   2> 4385781 T16379 oash.SnapPuller.fetchLatestIndex Master's 
generation: 3
   [junit4]   2> 4385781 T16379 oash.SnapPuller.fetchLatestIndex Slave's 
generation: 2
   [junit4]   2> 4385782 T16379 oash.SnapPuller.fetchLatestIndex Starting 
replication process
   [junit4]   2> 4385784 T16354 C9906 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={qt=/replication&command=filelist&version=2&generation=3&wt=javabin} 
status=0 QTime=0 
   [junit4]   2> 4385785 T16379 oash.SnapPuller.fetchLatestIndex Number of 
files in latest index in master: 7
   [junit4]   2> 4385785 T16379 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/collection1/data/index.20140727120919834
   [junit4]   2> 4385787 T16379 oasu.DefaultSolrCoreState.closeIndexWriter 
Closing IndexWriter...
   [junit4]   2> 4385787 T16379 oasu.DefaultSolrCoreState.closeIndexWriter 
Waiting until IndexWriter is unused... core=collection1
   [junit4]   2> 4385788 T16379 oasu.DefaultSolrCoreState.rollbackIndexWriter 
Rollback old IndexWriter... core=collection1
   [junit4]   2> 4385789 T16379 oash.SnapPuller.fetchLatestIndex Starting 
download to MockDirectoryWrapper(RAMDirectory@12661766 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@16d95102) 
fullCopy=false
   [junit4]   2> 4385789 T16379 oash.SnapPuller.downloadIndexFiles Skipping 
download for _0.cfe because it already exists
   [junit4]   2> 4385792 T16354 C9906 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={qt=/replication&command=filecontent&checksum=true&generation=3&wt=filestream&file=_1.cfs}
 status=0 QTime=0 
   [junit4]   2> 4385796 T16354 C9906 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={qt=/replication&command=filecontent&checksum=true&generation=3&wt=filestream&file=_1.cfe}
 status=0 QTime=0 
   [junit4]   2> 4385799 T16354 C9906 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={qt=/replication&command=filecontent&checksum=true&generation=3&wt=filestream&file=segments_3}
 status=0 QTime=0 
   [junit4]   2> 4385799 T16379 oash.SnapPuller.downloadIndexFiles Skipping 
download for _0.si because it already exists
   [junit4]   2> 4385800 T16379 oash.SnapPuller.downloadIndexFiles Skipping 
download for _0.cfs because it already exists
   [junit4]   2> 4385802 T16354 C9906 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={qt=/replication&command=filecontent&checksum=true&generation=3&wt=filestream&file=_1.si}
 status=0 QTime=0 
   [junit4]   2> 4385802 T16379 oash.SnapPuller.fetchLatestIndex Total time 
taken for download : 0 secs
   [junit4]   2> 4385804 T16379 oasu.DefaultSolrCoreState.openIndexWriter 
Creating new IndexWriter...
   [junit4]   2> 4385804 T16379 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.MockRandomMergePolicy: 
org.apache.lucene.index.MockRandomMergePolicy@780b21e4
   [junit4]   2> 4385805 T16379 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@76d9fe9d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@71e35a33),segFN=segments_2,generation=2}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@76d9fe9d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@71e35a33),segFN=segments_3,generation=3}
   [junit4]   2> 4385806 T16379 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 3
   [junit4]   2> 4385806 T16379 oasu.DefaultSolrCoreState.openIndexWriter New 
IndexWriter is ready to be used.
   [junit4]   2> 4385807 T16379 oass.SolrIndexSearcher.<init> Opening 
Searcher@54f1656a[collection1] main
   [junit4]   2> 4385807 T16373 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@54f1656a[collection1] 
main{StandardDirectoryReader(segments_3:5:nrt _0(4.10):c1 _1(4.10):c1)}
   [junit4]   2> 4385808 T16379 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/collection1/data/index.20140727120919834
 
[CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/collection1/data/index.20140727120919834;done=true>>]
   [junit4]   2> 4385808 T16379 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/collection1/data/index.20140727120919834
   [junit4]   2> 4385808 T16366 C9907 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={masterUrl=http://127.0.0.1:36483/solr/replication&command=fetchindex&wait=true}
 status=0 QTime=30 
   [junit4]   2> 4385813 T16354 C9906 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={qt=/replication&slave=false&command=details&version=2&wt=javabin} 
status=0 QTime=0 
   [junit4]   2> 4385814 T16365 C9907 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={_trace=getDetails&qt=/replication&command=details&version=2&wt=javabin} 
status=0 QTime=3 
   [junit4]   2> 4385816 T16353 C9906 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[2]} 
0 0
   [junit4]   2> 4385819 T16353 C9906 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 4385821 T16353 C9906 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=3
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2e402ab9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5e4a010d),segFN=segments_2,generation=2}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2e402ab9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5e4a010d),segFN=segments_3,generation=3}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2e402ab9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5e4a010d),segFN=segments_4,generation=4}
   [junit4]   2> 4385821 T16353 C9906 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 4
   [junit4]   2> 4385822 T16353 C9906 oass.SolrIndexSearcher.<init> Opening 
Searcher@10e0c2[collection1] main
   [junit4]   2> 4385822 T16353 C9906 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 4385822 T16361 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@10e0c2[collection1] 
main{StandardDirectoryReader(segments_4:7:nrt _0(4.10):c1 _1(4.10):c1 
_2(4.10):c1)}
   [junit4]   2> 4385823 T16353 C9906 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update 
params={waitSearcher=true&version=2&softCommit=false&commit=true&wt=javabin} 
{commit=} 0 4
   [junit4]   2> 4385824 T16381 oash.SnapPuller.<init> WARN 'masterUrl' must be 
specified without the /replication suffix
   [junit4]   2> 4385825 T16381 oash.SnapPuller.<init>  No value set for 
'pollInterval'. Timer Task not started.
   [junit4]   2> 4385827 T16354 C9906 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={qt=/replication&command=indexversion&version=2&wt=javabin} status=0 
QTime=0 
   [junit4]   2> 4385827 T16381 oash.SnapPuller.fetchLatestIndex Master's 
generation: 4
   [junit4]   2> 4385827 T16381 oash.SnapPuller.fetchLatestIndex Slave's 
generation: 3
   [junit4]   2> 4385828 T16381 oash.SnapPuller.fetchLatestIndex Starting 
replication process
   [junit4]   2> 4385831 T16354 C9906 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={qt=/replication&command=filelist&version=2&generation=4&wt=javabin} 
status=0 QTime=0 
   [junit4]   2> 4385832 T16381 oash.SnapPuller.fetchLatestIndex Number of 
files in latest index in master: 10
   [junit4]   2> 4385832 T16381 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/collection1/data/index.20140727120919881
   [junit4]   2> 4385833 T16381 oasu.DefaultSolrCoreState.closeIndexWriter 
Closing IndexWriter...
   [junit4]   2> 4385833 T16381 oasu.DefaultSolrCoreState.closeIndexWriter 
Waiting until IndexWriter is unused... core=collection1
   [junit4]   2> 4385833 T16381 oasu.DefaultSolrCoreState.rollbackIndexWriter 
Rollback old IndexWriter... core=collection1
   [junit4]   2> 4385835 T16381 oash.SnapPuller.fetchLatestIndex Starting 
download to MockDirectoryWrapper(RAMDirectory@500b9d3b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3390947e) 
fullCopy=false
   [junit4]   2> 4385838 T16354 C9906 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={qt=/replication&command=filecontent&checksum=true&generation=4&wt=filestream&file=_2.si}
 status=0 QTime=0 
   [junit4]   2> 4385839 T16381 oash.SnapPuller.downloadIndexFiles Skipping 
download for _0.cfe because it already exists
   [junit4]   2> 4385839 T16381 oash.SnapPuller.downloadIndexFiles Skipping 
download for _1.cfs because it already exists
   [junit4]   2> 4385839 T16381 oash.SnapPuller.downloadIndexFiles Skipping 
download for _1.cfe because it already exists
   [junit4]   2> 4385842 T16354 C9906 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={qt=/replication&command=filecontent&checksum=true&generation=4&wt=filestream&file=_2.cfe}
 status=0 QTime=0 
   [junit4]   2> 4385845 T16354 C9906 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={qt=/replication&command=filecontent&checksum=true&generation=4&wt=filestream&file=segments_4}
 status=0 QTime=0 
   [junit4]   2> 4385845 T16381 oash.SnapPuller.downloadIndexFiles Skipping 
download for _0.si because it already exists
   [junit4]   2> 4385846 T16381 oash.SnapPuller.downloadIndexFiles Skipping 
download for _0.cfs because it already exists
   [junit4]   2> 4385848 T16354 C9906 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={qt=/replication&command=filecontent&checksum=true&generation=4&wt=filestream&file=_2.cfs}
 status=0 QTime=0 
   [junit4]   2> 4385900 T16381 oash.SnapPuller.downloadIndexFiles Skipping 
download for _1.si because it already exists
   [junit4]   2> 4385901 T16381 oash.SnapPuller.fetchLatestIndex Total time 
taken for download : 0 secs
   [junit4]   2> 4385902 T16381 oasu.DefaultSolrCoreState.openIndexWriter 
Creating new IndexWriter...
   [junit4]   2> 4385903 T16381 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.MockRandomMergePolicy: 
org.apache.lucene.index.MockRandomMergePolicy@3c84c37a
   [junit4]   2> 4385904 T16381 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@76d9fe9d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@71e35a33),segFN=segments_3,generation=3}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@76d9fe9d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@71e35a33),segFN=segments_4,generation=4}
   [junit4]   2> 4385904 T16381 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 4
   [junit4]   2> 4385904 T16381 oasu.DefaultSolrCoreState.openIndexWriter New 
IndexWriter is ready to be used.
   [junit4]   2> 4385906 T16381 oass.SolrIndexSearcher.<init> Opening 
Searcher@1036b53[collection1] main
   [junit4]   2> 4385906 T16373 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1036b53[collection1] 
main{StandardDirectoryReader(segments_4:7:nrt _0(4.10):c1 _1(4.10):c1 
_2(4.10):c1)}
   [junit4]   2> 4385906 T16381 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/collection1/data/index.20140727120919881
 
[CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/collection1/data/index.20140727120919881;done=true>>]
   [junit4]   2> 4385907 T16381 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/collection1/data/index.20140727120919881
   [junit4]   2> 4385907 T16366 C9907 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={masterUrl=http://127.0.0.1:36483/solr/replication&command=fetchindex&wait=true}
 status=0 QTime=83 
   [junit4]   2> 4385923 T16350 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 4385929 T16350 oejs.AbstractConnector.doStart Started 
[email protected]:36489
   [junit4]   2> 4385930 T16350 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()
   [junit4]   2> 4385930 T16350 oasc.SolrResourceLoader.locateSolrHome JNDI not 
configured for solr (NoInitialContextEx)
   [junit4]   2> 4385930 T16350 oasc.SolrResourceLoader.locateSolrHome using 
system property solr.solr.home: 
./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-003
   [junit4]   2> 4385931 T16350 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-003/'
   [junit4]   2> 4385955 T16354 C9906 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={qt=/replication&command=indexversion&version=2&wt=javabin} status=0 
QTime=0 
   [junit4]   2> 4385956 T16374 oash.SnapPuller.fetchLatestIndex Slave in sync 
with master.
   [junit4]   2> 4385977 T16350 oasc.ConfigSolr.fromFile Loading container 
configuration from 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-003/solr.xml
   [junit4]   2> 4386058 T16350 oasc.CoreContainer.<init> New CoreContainer 
1726482995
   [junit4]   2> 4386058 T16350 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-003/]
   [junit4]   2> 4386060 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting socketTimeout to: 90000
   [junit4]   2> 4386060 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting urlScheme to: 
   [junit4]   2> 4386060 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting connTimeout to: 15000
   [junit4]   2> 4386061 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnectionsPerHost to: 20
   [junit4]   2> 4386061 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting corePoolSize to: 0
   [junit4]   2> 4386061 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting maximumPoolSize to: 2147483647
   [junit4]   2> 4386062 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting maxThreadIdleTime to: 5
   [junit4]   2> 4386062 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting sizeOfQueue to: -1
   [junit4]   2> 4386062 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting fairnessPolicy to: false
   [junit4]   2> 4386063 T16350 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=false
   [junit4]   2> 4386063 T16350 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 4386064 T16350 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 4386064 T16350 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 4386069 T16392 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-003/collection1/'
   [junit4]   2> 4386120 T16392 oasc.SolrConfig.<init> Using Lucene 
MatchVersion: LUCENE_4_10
   [junit4]   2> 4386162 T16392 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 4386163 T16392 oass.IndexSchema.readSchema Reading Solr Schema 
from schema.xml
   [junit4]   2> 4386169 T16392 oass.IndexSchema.readSchema [collection1] 
Schema name=test
   [junit4]   2> 4386186 T16392 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 4386187 T16392 oasc.CoreContainer.create Creating SolrCore 
'collection1' using configuration from instancedir 
./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-003/collection1/
   [junit4]   2> 4386188 T16392 oasc.SolrCore.initDirectoryFactory 
org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 4386188 T16392 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-003/collection1/,
 
dataDir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-003/collection1/data/
   [junit4]   2> 4386188 T16392 oasc.SolrCore.<init> JMX monitoring not 
detected for core: collection1
   [junit4]   2> 4386189 T16392 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-003/collection1/data
   [junit4]   2> 4386189 T16392 oasc.SolrCore.getNewIndexDir New index 
directory detected: old=null 
new=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-003/collection1/data/index/
   [junit4]   2> 4386189 T16392 oasc.SolrCore.initIndex WARN [collection1] Solr 
index directory 
'/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-003/collection1/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 4386190 T16392 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-003/collection1/data/index
   [junit4]   2> 4386190 T16392 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=18, maxMergeAtOnceExplicit=26, maxMergedSegmentMB=67.6337890625, 
floorSegmentMB=1.693359375, forceMergeDeletesPctAllowed=19.688060269334418, 
segmentsPerTier=11.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.5920792516815081
   [junit4]   2> 4386191 T16392 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@1e0e6a08 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@be33180),segFN=segments_1,generation=1}
   [junit4]   2> 4386191 T16392 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 4386192 T16392 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 4386193 T16392 oasc.RequestHandlers.initHandlersFromConfig 
created standard: solr.StandardRequestHandler
   [junit4]   2> 4386193 T16392 oasc.RequestHandlers.initHandlersFromConfig 
created defaults: solr.StandardRequestHandler
   [junit4]   2> 4386193 T16392 oasc.RequestHandlers.initHandlersFromConfig 
adding lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 4386193 T16392 oasc.RequestHandlers.initHandlersFromConfig 
created lazy: solr.StandardRequestHandler
   [junit4]   2> 4386193 T16392 oasc.RequestHandlers.initHandlersFromConfig 
created /update: solr.UpdateRequestHandler
   [junit4]   2> 4386194 T16392 oasc.RequestHandlers.initHandlersFromConfig 
created /replication: solr.ReplicationHandler
   [junit4]   2> 4386212 T16392 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 4386214 T16392 oasu.CommitTracker.<init> Hard AutoCommit: 
disabled
   [junit4]   2> 4386215 T16392 oasu.CommitTracker.<init> Soft AutoCommit: 
disabled
   [junit4]   2> 4386215 T16392 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: 
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=9, 
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, 
calibrateSizeByDeletes=false, maxMergeDocs=2147483647, 
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8239541096061591]
   [junit4]   2> 4386216 T16392 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@1e0e6a08 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@be33180),segFN=segments_1,generation=1}
   [junit4]   2> 4386216 T16392 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 4386216 T16392 oass.SolrIndexSearcher.<init> Opening 
Searcher@b696276[collection1] main
   [junit4]   2> 4386217 T16392 
oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage 
initialized to use dir: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-003/collection1/conf
   [junit4]   2> 4386217 T16392 oasr.RestManager.init Initializing RestManager 
with initArgs: 
{storageDir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-003/collection1/conf}
   [junit4]   2> 4386217 T16392 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using 
file:dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-003/collection1/conf
   [junit4]   2> 4386218 T16392 oasr.ManagedResource.reloadFromStorage WARN No 
stored data found for /rest/managed
   [junit4]   2> 4386218 T16392 oasr.ManagedResourceStorage$JsonStorage.store 
Saved JSON object to path _rest_managed.json using 
file:dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-003/collection1/conf
   [junit4]   2> 4386219 T16392 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 4386219 T16392 oash.SnapPuller.<init> WARN 'masterUrl' must be 
specified without the /replication suffix
   [junit4]   2> 4386219 T16392 oash.SnapPuller.<init>  No value set for 
'pollInterval'. Timer Task not started.
   [junit4]   2> 4386220 T16392 oash.ReplicationHandler.inform Replication 
enabled for following config files: schema.xml
   [junit4]   2> 4386220 T16392 oash.ReplicationHandler.inform Commits will be 
reserved for  10000
   [junit4]   2> 4386220 T16392 oasc.CoreContainer.registerCore registering 
core: collection1
   [junit4]   2> 4386220 T16393 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@b696276[collection1] 
main{StandardDirectoryReader(segments_1:1:nrt)}
   [junit4]   2> 4386221 T16350 oass.SolrDispatchFilter.init 
user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1
   [junit4]   2> 4386221 T16350 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init() done
   [junit4]   2> 4386227 T16355 C9906 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={qt=/replication&slave=false&command=details&version=2&wt=javabin} 
status=0 QTime=0 
   [junit4]   2> ASYNC  NEW_CORE C9908 name=collection1 
org.apache.solr.core.SolrCore@698ce178
   [junit4]   2> 4386227 T16385 C9908 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={_trace=getDetails&qt=/replication&command=details&version=2&wt=javabin} 
status=0 QTime=4 
   [junit4]   2> 4386228 T16350 oasc.CoreContainer.shutdown Shutting down 
CoreContainer instance=1726482995
   [junit4]   2> 4386230 T16350 oasc.SolrCore.close [collection1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@698ce178
   [junit4]   2> 4386230 T16350 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=0,autocommits=0,soft 
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
   [junit4]   2> 4386231 T16350 oasu.SolrCoreState.decrefSolrCoreState Closing 
SolrCoreState
   [junit4]   2> 4386231 T16350 oasu.DefaultSolrCoreState.closeIndexWriter 
SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 4386232 T16350 oasu.DefaultSolrCoreState.closeIndexWriter 
closing IndexWriter with IndexWriterCloser
   [junit4]   2> 4386232 T16350 oasc.SolrCore.closeSearcher [collection1] 
Closing main searcher on request.
   [junit4]   2> 4386233 T16350 oasc.CachingDirectoryFactory.close Closing 
MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 4386233 T16350 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-003/collection1/data
 
[CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-003/collection1/data;done=false>>]
   [junit4]   2> 4386234 T16350 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-003/collection1/data
   [junit4]   2> 4386234 T16350 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-003/collection1/data/index
 
[CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-003/collection1/data/index;done=false>>]
   [junit4]   2> 4386234 T16350 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-003/collection1/data/index
   [junit4]   2> 4386235 T16350 oejsh.ContextHandler.doStop stopped 
o.e.j.s.ServletContextHandler{/solr,null}
   [junit4]   2> 4386954 T16354 C9906 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={qt=/replication&command=indexversion&version=2&wt=javabin} status=0 
QTime=0 
   [junit4]   2> 4386955 T16374 oash.SnapPuller.fetchLatestIndex Slave in sync 
with master.
   [junit4]   2> 4387955 T16354 C9906 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={qt=/replication&command=indexversion&version=2&wt=javabin} status=0 
QTime=0 
   [junit4]   2> 4387955 T16374 oash.SnapPuller.fetchLatestIndex Slave in sync 
with master.
   [junit4]   2> 4388956 T16354 C9906 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={qt=/replication&command=indexversion&version=2&wt=javabin} status=0 
QTime=0 
   [junit4]   2> 4388956 T16374 oash.SnapPuller.fetchLatestIndex Slave in sync 
with master.
   [junit4]   2> 4389955 T16354 C9906 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={qt=/replication&command=indexversion&version=2&wt=javabin} status=0 
QTime=0 
   [junit4]   2> 4389956 T16374 oash.SnapPuller.fetchLatestIndex Slave in sync 
with master.
   [junit4]   2> 4390956 T16354 C9906 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={qt=/replication&command=indexversion&version=2&wt=javabin} status=0 
QTime=0 
   [junit4]   2> 4390956 T16374 oash.SnapPuller.fetchLatestIndex Slave in sync 
with master.
   [junit4]   2> 4391238 T16350 oas.SolrTestCaseJ4.tearDown ###Ending 
doTestDetails
   [junit4]   2> 4391238 T16350 oasc.CoreContainer.shutdown Shutting down 
CoreContainer instance=248555160
   [junit4]   2> 4391241 T16350 oasc.SolrCore.close [collection1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@3ca433db
   [junit4]   2> 4391241 T16350 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=3,autocommits=0,soft 
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=3,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
   [junit4]   2> 4391244 T16350 oasu.SolrCoreState.decrefSolrCoreState Closing 
SolrCoreState
   [junit4]   2> 4391245 T16350 oasu.DefaultSolrCoreState.closeIndexWriter 
SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 4391245 T16350 oasu.DefaultSolrCoreState.closeIndexWriter 
closing IndexWriter with IndexWriterCloser
   [junit4]   2> 4391248 T16350 oasc.SolrCore.closeSearcher [collection1] 
Closing main searcher on request.
   [junit4]   2> 4391249 T16350 oasc.CachingDirectoryFactory.close Closing 
MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 4391249 T16350 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/collection1/data
 
[CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/collection1/data;done=false>>]
   [junit4]   2> 4391249 T16350 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/collection1/data
   [junit4]   2> 4391250 T16350 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/collection1/data/index
 
[CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/collection1/data/index;done=false>>]
   [junit4]   2> 4391250 T16350 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/collection1/data/index
   [junit4]   2> 4391251 T16350 oejsh.ContextHandler.doStop stopped 
o.e.j.s.ServletContextHandler{/solr,null}
   [junit4]   2> 4396245 T16350 oasc.CoreContainer.shutdown Shutting down 
CoreContainer instance=1601195805
   [junit4]   2> 4396247 T16350 oasc.SolrCore.close [collection1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@1966442d
   [junit4]   2> 4406954 T16374 oash.SnapPuller.fetchLatestIndex ERROR Master 
at: http://127.0.0.1:36483/solr is not available. Index fetch failed. 
Exception: IOException occured when talking to server at: 
http://127.0.0.1:36483/solr
   [junit4]   2> 4406957 T16350 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=0,autocommits=0,soft 
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
   [junit4]   2> 4406957 T16350 oasu.SolrCoreState.decrefSolrCoreState Closing 
SolrCoreState
   [junit4]   2> 4406958 T16350 oasu.DefaultSolrCoreState.closeIndexWriter 
SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 4406958 T16350 oasu.DefaultSolrCoreState.closeIndexWriter 
closing IndexWriter with IndexWriterCloser
   [junit4]   2> 4406960 T16350 oasc.SolrCore.closeSearcher [collection1] 
Closing main searcher on request.
   [junit4]   2> 4406961 T16350 oasc.CachingDirectoryFactory.close Closing 
MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 4406961 T16350 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/collection1/data
 
[CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/collection1/data;done=false>>]
   [junit4]   2> 4406962 T16350 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/collection1/data
   [junit4]   2> 4406962 T16350 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/collection1/data/index
 
[CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/collection1/data/index;done=false>>]
   [junit4]   2> 4406962 T16350 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-002/collection1/data/index
   [junit4]   2> 4406963 T16350 oejsh.ContextHandler.doStop stopped 
o.e.j.s.ServletContextHandler{/solr,null}
   [junit4]   2> 4411271 T16350 oas.SolrTestCaseJ4.setUp ###Starting 
doTestReplicateAfterStartupWithNoActivity
   [junit4]   2> 4411286 T16350 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 4411291 T16350 oejs.AbstractConnector.doStart Started 
[email protected]:36495
   [junit4]   2> 4411292 T16350 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()
   [junit4]   2> 4411292 T16350 oasc.SolrResourceLoader.locateSolrHome JNDI not 
configured for solr (NoInitialContextEx)
   [junit4]   2> 4411292 T16350 oasc.SolrResourceLoader.locateSolrHome using 
system property solr.solr.home: 
./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001
   [junit4]   2> 4411293 T16350 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/'
   [junit4]   2> 4411336 T16350 oasc.ConfigSolr.fromFile Loading container 
configuration from 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/solr.xml
   [junit4]   2> 4411429 T16350 oasc.CoreContainer.<init> New CoreContainer 
1715233452
   [junit4]   2> 4411430 T16350 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/]
   [junit4]   2> 4411431 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting socketTimeout to: 90000
   [junit4]   2> 4411431 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting urlScheme to: 
   [junit4]   2> 4411432 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting connTimeout to: 15000
   [junit4]   2> 4411432 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnectionsPerHost to: 20
   [junit4]   2> 4411432 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting corePoolSize to: 0
   [junit4]   2> 4411433 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting maximumPoolSize to: 2147483647
   [junit4]   2> 4411433 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting maxThreadIdleTime to: 5
   [junit4]   2> 4411433 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting sizeOfQueue to: -1
   [junit4]   2> 4411434 T16350 oashc.HttpShardHandlerFactory.getParameter 
Setting fairnessPolicy to: false
   [junit4]   2> 4411434 T16350 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=false
   [junit4]   2> 4411435 T16350 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 4411435 T16350 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 4411435 T16350 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 4411440 T16404 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/collection1/'
   [junit4]   2> 4411490 T16404 oasc.SolrConfig.<init> Using Lucene 
MatchVersion: LUCENE_4_10
   [junit4]   2> 4411532 T16404 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 4411532 T16404 oass.IndexSchema.readSchema Reading Solr Schema 
from schema.xml
   [junit4]   2> 4411539 T16404 oass.IndexSchema.readSchema [collection1] 
Schema name=test
   [junit4]   2> 4411556 T16404 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 4411557 T16404 oasc.CoreContainer.create Creating SolrCore 
'collection1' using configuration from instancedir 
./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/collection1/
   [junit4]   2> 4411558 T16404 oasc.SolrCore.initDirectoryFactory 
org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 4411558 T16404 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/collection1/,
 
dataDir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/collection1/data/
   [junit4]   2> 4411558 T16404 oasc.SolrCore.<init> JMX monitoring not 
detected for core: collection1
   [junit4]   2> 4411559 T16404 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/collection1/data
   [junit4]   2> 4411559 T16404 oasc.SolrCore.getNewIndexDir New index 
directory detected: old=null 
new=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/collection1/data/index/
   [junit4]   2> 4411559 T16404 oasc.SolrCore.initIndex WARN [collection1] Solr 
index directory 
'/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/collection1/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 4411560 T16404 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/collection1/data/index
   [junit4]   2> 4411560 T16404 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=18, maxMergeAtOnceExplicit=26, maxMergedSegmentMB=67.6337890625, 
floorSegmentMB=1.693359375, forceMergeDeletesPctAllowed=19.688060269334418, 
segmentsPerTier=11.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.5920792516815081
   [junit4]   2> 4411561 T16404 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@794627d4 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4368d6a4),segFN=segments_1,generation=1}
   [junit4]   2> 4411561 T16404 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 4411562 T16404 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 4411562 T16404 oasc.RequestHandlers.initHandlersFromConfig 
created standard: solr.StandardRequestHandler
   [junit4]   2> 4411563 T16404 oasc.RequestHandlers.initHandlersFromConfig 
created /replication: solr.ReplicationHandler
   [junit4]   2> 4411563 T16404 oasc.RequestHandlers.initHandlersFromConfig 
created defaults: solr.StandardRequestHandler
   [junit4]   2> 4411563 T16404 oasc.RequestHandlers.initHandlersFromConfig 
adding lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 4411563 T16404 oasc.RequestHandlers.initHandlersFromConfig 
created lazy: solr.StandardRequestHandler
   [junit4]   2> 4411564 T16404 oasc.RequestHandlers.initHandlersFromConfig 
created /update: solr.UpdateRequestHandler
   [junit4]   2> 4411582 T16404 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 4411585 T16404 oasu.CommitTracker.<init> Hard AutoCommit: 
disabled
   [junit4]   2> 4411585 T16404 oasu.CommitTracker.<init> Soft AutoCommit: 
disabled
   [junit4]   2> 4411585 T16404 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: 
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=9, 
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, 
calibrateSizeByDeletes=false, maxMergeDocs=2147483647, 
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8239541096061591]
   [junit4]   2> 4411586 T16404 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@794627d4 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4368d6a4),segFN=segments_1,generation=1}
   [junit4]   2> 4411586 T16404 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 4411586 T16404 oass.SolrIndexSearcher.<init> Opening 
Searcher@c13b75b[collection1] main
   [junit4]   2> 4411587 T16404 
oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage 
initialized to use dir: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/collection1/conf
   [junit4]   2> 4411587 T16404 oasr.RestManager.init Initializing RestManager 
with initArgs: 
{storageDir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/collection1/conf}
   [junit4]   2> 4411587 T16404 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using 
file:dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/collection1/conf
   [junit4]   2> 4411588 T16404 oasr.ManagedResource.reloadFromStorage WARN No 
stored data found for /rest/managed
   [junit4]   2> 4411589 T16404 oasr.ManagedResourceStorage$JsonStorage.store 
Saved JSON object to path _rest_managed.json using 
file:dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J1/./solr.handler.TestReplicationHandler-E4FFCDCA8EC968BC-001/solr-instance-001/collection1/conf
   [junit4]   2> 4411589 T16404 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 4411589 T16404 oash.ReplicationHandler.inform Replication 
enabled for following config files: schema.xml,xslt/dummy.xsl
   [junit4]   2> 4411589 T16404 oash.ReplicationHandler.inform Commits will be 
reserved for  10000
   [junit4]   2> 4411590 T16404 oasc.CoreContainer.registerCore registering 
core: collection1
   [junit4]   2> 4411590 T16405 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@c13b75b[collection1] 
main{StandardDirectoryReader(segments_1:1:nrt)}
   [junit4]   2> 4411590 T16350 oas

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

ieldUpdateProcessorsTest, TestMiniSolrCloudCluster, 
TestBlendedInfixSuggestions, ResponseLogComponentTest, 
SpellPossibilityIteratorTest, AnalyticsQueryTest, BlockCacheTest, 
OverseerRolesTest, TestCodecSupport, ReplicationFactorTest, 
ClusterStateUpdateTest, DocValuesMultiTest, EnumFieldTest, 
TestDistributedSearch, UnloadDistributedZkTest, 
CoreMergeIndexesAdminHandlerTest, TestLMJelinekMercerSimilarityFactory, 
ExternalFileFieldSortTest, TestFastOutputStream, InfoHandlerTest, TestSort, 
TestManagedSchema, TestDocBasedVersionConstraints, ShardSplitTest, 
TestStressUserVersions, TestShardHandlerFactory, TestDistribDocBasedVersion, 
CachingDirectoryFactoryTest, SuggesterTest, PingRequestHandlerTest, 
TestCollationFieldDocValues, TestFuzzyAnalyzedSuggestions, 
DistributedExpandComponentTest, CustomCollectionTest, 
DeleteInactiveReplicaTest, TestManagedSchemaFieldResource, 
TestFreeTextSuggestions, DeleteReplicaTest, TestHighFrequencyDictionaryFactory, 
ReturnFieldsTest, HdfsBasicDistributedZkTest, 
TestSolrQueryParserDefaultOperatorResource, TestRangeQuery, 
TestCopyFieldCollectionResource, TestSurroundQueryParser, 
WordBreakSolrSpellCheckerTest, SpellCheckCollatorTest, DocValuesMissingTest, 
TestSearchPerf, TestStressRecovery, TestReload, TestConfig, BasicZkTest, 
LeaderElectionTest, ZkSolrClientTest, TestZkChroot, ZkCLITest, 
ShardRoutingCustomTest, AutoCommitTest, TestDistributedGrouping, TestFaceting, 
TestHashPartitioner, DistributedSpellCheckComponentTest, 
TermVectorComponentDistributedTest, ZkControllerTest, TestStressReorder, 
TestMultiCoreConfBootstrap, TestStressVersions, HardAutoCommitTest, 
SimpleFacetsTest, TestSolr4Spatial, SpellCheckComponentTest, 
TestGroupingSearch, PeerSyncTest, BadIndexSchemaTest, TestFunctionQuery, 
BasicFunctionalityTest, TestLazyCores, DirectUpdateHandlerTest, TestBadConfig, 
OverseerCollectionProcessorTest, ShowFileRequestHandlerTest, 
CurrencyFieldOpenExchangeTest, SimplePostToolTest, TestCoreDiscovery, 
AnalysisAfterCoreReloadTest, SuggesterFSTTest, CoreAdminHandlerTest, 
SolrRequestParserTest, TestFoldingMultitermQuery, SuggesterTSTTest, 
SuggesterWFSTTest, NoCacheHeaderTest, SchemaVersionSpecificBehaviorTest, 
SolrCoreCheckLockOnStartupTest, FieldMutatingUpdateProcessorTest, 
TestAtomicUpdateErrorCases, QueryEqualityTest, DefaultValueUpdateProcessorTest, 
StatelessScriptUpdateProcessorFactoryTest, SortByFunctionTest, 
TestSolrDeletionPolicy1, DebugComponentTest, 
DocumentAnalysisRequestHandlerTest, TestQueryTypes, PrimitiveFieldTypeTest, 
FileBasedSpellCheckerTest, XmlUpdateRequestHandlerTest, 
MoreLikeThisHandlerTest, RequiredFieldsTest, FieldAnalysisRequestHandlerTest, 
TestSolrQueryParser, LoggingHandlerTest, SolrPluginUtilsTest, IndexSchemaTest, 
TestJmxIntegration, TestAnalyzedSuggestions, TestPartialUpdateDeduplication, 
TestPHPSerializedResponseWriter, CSVRequestHandlerTest, TestComponentsName, 
CoreContainerCoreInitFailuresTest, TestBinaryResponseWriter, TestLFUCache, 
HighlighterConfigTest, SOLR749Test, TestQuerySenderListener, 
AlternateDirectoryTest, TestSolrIndexConfig, TestQuerySenderNoQuery, 
SolrIndexConfigTest, BadComponentTest, TestSolrDeletionPolicy2, MultiTermTest, 
TestDocSet, TestBinaryField, NumericFieldsTest, MinimalSchemaTest, 
TestElisionMultitermQuery, TestSolrCoreProperties, TestPostingsSolrHighlighter, 
NotRequiredUniqueKeyTest, TestCharFilters, SynonymTokenizerTest, 
TestXIncludeConfig, EchoParamsTest, TestDFRSimilarityFactory, TestNumberUtils, 
TestIBSimilarityFactory, TestBM25SimilarityFactory, 
TestDefaultSimilarityFactory, TestFastWriter, LegacyHTMLStripCharFilterTest, 
TestJmxMonitoredMap, TimeZoneUtilsTest, ResourceLoaderTest, 
OpenExchangeRatesOrgProviderTest, URLClassifyProcessorTest, PluginInfoTest, 
DateMathParserTest, ChaosMonkeyNothingIsSafeTest, TestSolrXMLSerializer, 
TestSystemIdResolver, TestSuggestSpellingConverter, DateFieldTest, 
RAMDirectoryFactoryTest, TestSolrJ, TestUtils, ZkNodePropsTest, SliceStateTest, 
SystemInfoHandlerTest, UUIDFieldTest, TestRTGBase, CursorPagingTest, 
SolrTestCaseJ4Test, TestDistributedMissingSort, TestTolerantSearch, 
AliasIntegrationTest, ConnectionManagerTest, DeleteShardTest, 
DistribCursorPagingTest, HttpPartitionTest, MigrateRouteKeyTest, 
TestShortCircuitedRequests, HdfsChaosMonkeySafeLeaderTest, HdfsRecoveryZkTest, 
HdfsSyncSliceTest, HdfsWriteToMultipleCollectionsTest, StressHdfsTest, 
TestInfoStreamLogging, TestNRTOpen, TestReloadAndDeleteDocs, TestSolrXml, 
TestSolrXmlPersistence, TestReplicationHandlerBackup]
   [junit4]   2> NOTE: download the large Jenkins line-docs file by running 
'ant get-jenkins-line-docs' in the lucene directory.
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestReplicationHandlerBackup -Dtests.seed=E4FFCDCA8EC968BC 
-Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true 
-Dtests.linedocsfile=/home/hudson/lucene-data/enwiki.random.lines.txt 
-Dtests.locale=sr_BA_#Latn -Dtests.timezone=America/Edmonton 
-Dtests.file.encoding=US-ASCII
   [junit4] ERROR   0.00s J0 | TestReplicationHandlerBackup (suite) <<<
   [junit4]    > Throwable #1: 
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE 
scope at org.apache.solr.handler.TestReplicationHandlerBackup: 
   [junit4]    >    1) Thread[id=31922, name=Thread-8018, state=RUNNABLE, 
group=TGRP-TestReplicationHandlerBackup]
   [junit4]    >         at java.net.PlainSocketImpl.socketConnect(Native 
Method)
   [junit4]    >         at 
java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:339)
   [junit4]    >         at 
java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:200)
   [junit4]    >         at 
java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:182)
   [junit4]    >         at 
java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)
   [junit4]    >         at java.net.Socket.connect(Socket.java:579)
   [junit4]    >         at java.net.Socket.connect(Socket.java:528)
   [junit4]    >         at 
sun.net.NetworkClient.doConnect(NetworkClient.java:180)
   [junit4]    >         at 
sun.net.www.http.HttpClient.openServer(HttpClient.java:432)
   [junit4]    >         at 
sun.net.www.http.HttpClient.openServer(HttpClient.java:527)
   [junit4]    >         at 
sun.net.www.http.HttpClient.parseHTTP(HttpClient.java:652)
   [junit4]    >         at 
sun.net.www.protocol.http.HttpURLConnection.getInputStream(HttpURLConnection.java:1323)
   [junit4]    >         at java.net.URL.openStream(URL.java:1037)
   [junit4]    >         at 
org.apache.solr.handler.TestReplicationHandlerBackup$BackupThread.run(TestReplicationHandlerBackup.java:314)
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([E4FFCDCA8EC968BC]:0)Throwable #2: 
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie 
threads that couldn't be terminated:
   [junit4]    >    1) Thread[id=31922, name=Thread-8018, state=RUNNABLE, 
group=TGRP-TestReplicationHandlerBackup]
   [junit4]    >         at java.net.PlainSocketImpl.socketConnect(Native 
Method)
   [junit4]    >         at 
java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:339)
   [junit4]    >         at 
java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:200)
   [junit4]    >         at 
java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:182)
   [junit4]    >         at 
java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)
   [junit4]    >         at java.net.Socket.connect(Socket.java:579)
   [junit4]    >         at java.net.Socket.connect(Socket.java:528)
   [junit4]    >         at 
sun.net.NetworkClient.doConnect(NetworkClient.java:180)
   [junit4]    >         at 
sun.net.www.http.HttpClient.openServer(HttpClient.java:432)
   [junit4]    >         at 
sun.net.www.http.HttpClient.openServer(HttpClient.java:527)
   [junit4]    >         at 
sun.net.www.http.HttpClient.parseHTTP(HttpClient.java:652)
   [junit4]    >         at 
sun.net.www.protocol.http.HttpURLConnection.getInputStream(HttpURLConnection.java:1323)
   [junit4]    >         at java.net.URL.openStream(URL.java:1037)
   [junit4]    >         at 
org.apache.solr.handler.TestReplicationHandlerBackup$BackupThread.run(TestReplicationHandlerBackup.java:314)
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([E4FFCDCA8EC968BC]:0)
   [junit4] Completed on J0 in 30.12s, 1 test, 2 errors <<< FAILURES!

[...truncated 135 lines...]
BUILD FAILED
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/build.xml:474:
 The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/build.xml:447:
 The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/build.xml:45:
 The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/extra-targets.xml:37:
 The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build.xml:189:
 The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/common-build.xml:496:
 The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/lucene/common-build.xml:1299:
 The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/lucene/common-build.xml:923:
 There were test failures: 410 suites, 1702 tests, 2 suite-level errors, 1 
failure, 136 ignored (8 assumptions)

Total time: 246 minutes 18 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Sending artifact delta relative to Lucene-Solr-NightlyTests-4.x #582
Archived 3 artifacts
Archive block size is 32768
Received 0 blocks and 687356687 bytes
Compression is 0.0%
Took 1 min 48 sec
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure


---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to