lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Apache Jenkins Server <jenk...@builds.apache.org>
Subject [JENKINS] Lucene-Solr-Tests-4.x-java7 - Build # 1028 - Failure
Date Thu, 28 Feb 2013 10:13:13 GMT
Build: https://builds.apache.org/job/Lucene-Solr-Tests-4.x-java7/1028/

1 tests failed.
REGRESSION:  org.apache.solr.handler.TestReplicationHandler.doTestSnapPullWithMasterUrl

Error Message:
expected:<null> but was:<[0][id][0]:4!=3>

Stack Trace:
java.lang.AssertionError: expected:<null> but was:<[0][id][0]:4!=3>
	at __randomizedtesting.SeedInfo.seed([674A679EF03CD7E2:FC0CC1EFE34C82AC]: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.doTestSnapPullWithMasterUrl(TestReplicationHandler.java:617)
	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:601)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
	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:70)
	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:358)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
	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 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:70)
	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:358)
	at java.lang.Thread.run(Thread.java:722)




Build Log:
[...truncated 9076 lines...]
[junit4:junit4] Suite: org.apache.solr.handler.TestReplicationHandler
[junit4:junit4]   2> 4 T1585 oas.SolrTestCaseJ4.setUp ###Starting doTestIndexAndConfigAliasReplication
[junit4:junit4]   2> 18 T1585 oejs.Server.doStart jetty-8.1.8.v20121106
[junit4:junit4]   2> 23 T1585 oejs.AbstractConnector.doStart Started SocketConnector@127.0.0.1:42825
[junit4:junit4]   2> 23 T1585 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 24 T1585 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 24 T1585 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master
[junit4:junit4]   2> 25 T1585 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/solr.xml
[junit4:junit4]   2> 25 T1585 oasc.CoreContainer.<init> New CoreContainer 1947149638
[junit4:junit4]   2> 26 T1585 oasc.CoreContainer$Initializer.initialize no solr.xml file found - using default
[junit4:junit4]   2> 27 T1585 oasc.CoreContainer.load Loading CoreContainer using Solr Home: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/'
[junit4:junit4]   2> 27 T1585 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/'
[junit4:junit4]   2> 89 T1585 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 90 T1585 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 91 T1585 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 91 T1585 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 92 T1585 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 92 T1585 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 93 T1585 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 93 T1585 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 93 T1585 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 94 T1585 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 116 T1585 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 141 T1595 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1
[junit4:junit4]   2> 143 T1595 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/'
[junit4:junit4]   2> 235 T1595 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_42
[junit4:junit4]   2> 294 T1595 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 295 T1595 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 299 T1595 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 323 T1595 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 325 T1595 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/, dataDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data/
[junit4:junit4]   2> 325 T1595 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4:junit4]   2> 325 T1595 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 327 T1595 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data forceNew:false
[junit4:junit4]   2> 328 T1595 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data
[junit4:junit4]   2> 328 T1595 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data/index/
[junit4:junit4]   2> 329 T1595 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 329 T1595 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data/index forceNew:false
[junit4:junit4]   2> 330 T1595 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@35d2b35b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@d23e223),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 331 T1595 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 331 T1595 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data/index
[junit4:junit4]   2> 332 T1595 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 332 T1595 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 333 T1595 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 333 T1595 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 333 T1595 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 333 T1595 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 348 T1595 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 352 T1595 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data
[junit4:junit4]   2> 353 T1595 oass.SolrIndexSearcher.<init> Opening Searcher@431cc736 main
[junit4:junit4]   2> 353 T1595 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 354 T1595 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 355 T1595 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4:junit4]   2> 355 T1595 oash.ReplicationHandler.inform Commits will be reserved for  10000
[junit4:junit4]   2> 355 T1595 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 356 T1596 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@431cc736 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 356 T1585 oass.SolrDispatchFilter.init user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1
[junit4:junit4]   2> 357 T1585 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 358 T1585 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 381 T1585 oejs.Server.doStart jetty-8.1.8.v20121106
[junit4:junit4]   2> 385 T1585 oejs.AbstractConnector.doStart Started SocketConnector@127.0.0.1:42826
[junit4:junit4]   2> 385 T1585 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 386 T1585 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 386 T1585 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave
[junit4:junit4]   2> 387 T1585 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/solr.xml
[junit4:junit4]   2> 387 T1585 oasc.CoreContainer.<init> New CoreContainer 1966855563
[junit4:junit4]   2> 388 T1585 oasc.CoreContainer$Initializer.initialize no solr.xml file found - using default
[junit4:junit4]   2> 388 T1585 oasc.CoreContainer.load Loading CoreContainer using Solr Home: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/'
[junit4:junit4]   2> 389 T1585 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/'
[junit4:junit4]   2> 411 T1585 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 411 T1585 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 412 T1585 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 412 T1585 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 413 T1585 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 413 T1585 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 414 T1585 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 414 T1585 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 415 T1585 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 415 T1585 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 432 T1585 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 458 T1606 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1
[junit4:junit4]   2> 459 T1606 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/'
[junit4:junit4]   2> 502 T1606 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_42
[junit4:junit4]   2> 557 T1606 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 557 T1606 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 561 T1606 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 580 T1606 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 581 T1606 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/, dataDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/
[junit4:junit4]   2> 582 T1606 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4:junit4]   2> 582 T1606 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 584 T1606 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data forceNew:false
[junit4:junit4]   2> 584 T1606 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data
[junit4:junit4]   2> 584 T1606 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index/
[junit4:junit4]   2> 585 T1606 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 586 T1606 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index forceNew:false
[junit4:junit4]   2> 587 T1606 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@7a72fdba lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1d545074),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 587 T1606 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 587 T1606 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index
[junit4:junit4]   2> 588 T1606 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 589 T1606 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 589 T1606 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 589 T1606 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 590 T1606 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 590 T1606 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 592 T1606 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 595 T1606 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data
[junit4:junit4]   2> 595 T1606 oass.SolrIndexSearcher.<init> Opening Searcher@694c41bf main
[junit4:junit4]   2> 596 T1606 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 596 T1606 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 601 T1606 oash.SnapPuller.startExecutorService Poll Scheduled at an interval of 1000ms
[junit4:junit4]   2> 601 T1606 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 601 T1607 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@694c41bf main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 602 T1585 oass.SolrDispatchFilter.init user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1
[junit4:junit4]   2> 602 T1585 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 603 T1585 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> ASYNC  NEW_CORE C95 name=collection1 org.apache.solr.core.SolrCore@41fe4ceb
[junit4:junit4]   2> 621 T1588 C95 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=1 
[junit4:junit4]   2> 625 T1588 C95 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data
[junit4:junit4]   2> 626 T1588 C95 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@35d2b35b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@d23e223),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 627 T1588 C95 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 628 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0]} 0 4
[junit4:junit4]   2> 630 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1]} 0 0
[junit4:junit4]   2> 633 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[2]} 0 0
[junit4:junit4]   2> 636 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[3]} 0 0
[junit4:junit4]   2> 639 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[4]} 0 0
[junit4:junit4]   2> 642 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[5]} 0 0
[junit4:junit4]   2> 645 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[6]} 0 0
[junit4:junit4]   2> 648 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[7]} 0 0
[junit4:junit4]   2> 651 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[8]} 0 0
[junit4:junit4]   2> 653 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[9]} 0 0
[junit4:junit4]   2> 656 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[10]} 0 0
[junit4:junit4]   2> 659 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[11]} 0 0
[junit4:junit4]   2> 661 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[12]} 0 0
[junit4:junit4]   2> 664 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[13]} 0 0
[junit4:junit4]   2> 667 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[14]} 0 0
[junit4:junit4]   2> 670 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[15]} 0 0
[junit4:junit4]   2> 673 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[16]} 0 0
[junit4:junit4]   2> 676 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[17]} 0 0
[junit4:junit4]   2> 679 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[18]} 0 0
[junit4:junit4]   2> 682 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[19]} 0 0
[junit4:junit4]   2> 685 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[20]} 0 0
[junit4:junit4]   2> 688 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[21]} 0 0
[junit4:junit4]   2> 691 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[22]} 0 0
[junit4:junit4]   2> 694 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[23]} 0 0
[junit4:junit4]   2> 697 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[24]} 0 0
[junit4:junit4]   2> 700 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[25]} 0 0
[junit4:junit4]   2> 703 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[26]} 0 0
[junit4:junit4]   2> 706 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[27]} 0 0
[junit4:junit4]   2> 709 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[28]} 0 0
[junit4:junit4]   2> 712 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[29]} 0 0
[junit4:junit4]   2> 715 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[30]} 0 0
[junit4:junit4]   2> 718 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[31]} 0 0
[junit4:junit4]   2> 721 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[32]} 0 0
[junit4:junit4]   2> 728 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[33]} 0 0
[junit4:junit4]   2> 730 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[34]} 0 0
[junit4:junit4]   2> 732 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[35]} 0 0
[junit4:junit4]   2> 735 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[36]} 0 0
[junit4:junit4]   2> 737 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[37]} 0 0
[junit4:junit4]   2> 740 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[38]} 0 0
[junit4:junit4]   2> 742 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[39]} 0 0
[junit4:junit4]   2> 745 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[40]} 0 0
[junit4:junit4]   2> 747 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[41]} 0 0
[junit4:junit4]   2> 749 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[42]} 0 0
[junit4:junit4]   2> 751 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[43]} 0 0
[junit4:junit4]   2> 754 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[44]} 0 0
[junit4:junit4]   2> 756 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[45]} 0 0
[junit4:junit4]   2> 759 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[46]} 0 0
[junit4:junit4]   2> 761 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[47]} 0 0
[junit4:junit4]   2> 764 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[48]} 0 0
[junit4:junit4]   2> 766 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[49]} 0 0
[junit4:junit4]   2> 769 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[50]} 0 0
[junit4:junit4]   2> 771 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[51]} 0 0
[junit4:junit4]   2> 773 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[52]} 0 0
[junit4:junit4]   2> 776 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[53]} 0 0
[junit4:junit4]   2> 778 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[54]} 0 0
[junit4:junit4]   2> 781 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[55]} 0 0
[junit4:junit4]   2> 783 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[56]} 0 0
[junit4:junit4]   2> 785 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[57]} 0 0
[junit4:junit4]   2> 788 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[58]} 0 0
[junit4:junit4]   2> 790 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[59]} 0 0
[junit4:junit4]   2> 793 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[60]} 0 0
[junit4:junit4]   2> 795 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[61]} 0 0
[junit4:junit4]   2> 798 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[62]} 0 0
[junit4:junit4]   2> 800 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[63]} 0 0
[junit4:junit4]   2> 802 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[64]} 0 0
[junit4:junit4]   2> 804 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[65]} 0 0
[junit4:junit4]   2> 807 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[66]} 0 0
[junit4:junit4]   2> 809 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[67]} 0 0
[junit4:junit4]   2> 812 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[68]} 0 0
[junit4:junit4]   2> 814 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[69]} 0 0
[junit4:junit4]   2> 817 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[70]} 0 0
[junit4:junit4]   2> 819 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[71]} 0 0
[junit4:junit4]   2> 821 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[72]} 0 0
[junit4:junit4]   2> 823 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[73]} 0 0
[junit4:junit4]   2> 826 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[74]} 0 0
[junit4:junit4]   2> 828 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[75]} 0 0
[junit4:junit4]   2> 831 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[76]} 0 0
[junit4:junit4]   2> 833 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[77]} 0 0
[junit4:junit4]   2> 835 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[78]} 0 0
[junit4:junit4]   2> 838 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[79]} 0 0
[junit4:junit4]   2> 840 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[80]} 0 0
[junit4:junit4]   2> 843 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[81]} 0 0
[junit4:junit4]   2> 845 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[82]} 0 0
[junit4:junit4]   2> 848 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[83]} 0 0
[junit4:junit4]   2> 850 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[84]} 0 0
[junit4:junit4]   2> 853 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[85]} 0 0
[junit4:junit4]   2> 855 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[86]} 0 0
[junit4:junit4]   2> 858 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[87]} 0 0
[junit4:junit4]   2> 860 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[88]} 0 0
[junit4:junit4]   2> 863 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[89]} 0 0
[junit4:junit4]   2> 865 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[90]} 0 0
[junit4:junit4]   2> 868 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[91]} 0 0
[junit4:junit4]   2> 870 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[92]} 0 0
[junit4:junit4]   2> 873 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[93]} 0 0
[junit4:junit4]   2> 875 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[94]} 0 0
[junit4:junit4]   2> 878 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[95]} 0 0
[junit4:junit4]   2> 880 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[96]} 0 0
[junit4:junit4]   2> 883 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[97]} 0 0
[junit4:junit4]   2> 886 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[98]} 0 0
[junit4:junit4]   2> 889 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[99]} 0 0
[junit4:junit4]   2> 891 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[100]} 0 0
[junit4:junit4]   2> 894 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[101]} 0 0
[junit4:junit4]   2> 896 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[102]} 0 0
[junit4:junit4]   2> 899 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[103]} 0 0
[junit4:junit4]   2> 901 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[104]} 0 0
[junit4:junit4]   2> 903 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[105]} 0 0
[junit4:junit4]   2> 905 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[106]} 0 0
[junit4:junit4]   2> 908 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[107]} 0 0
[junit4:junit4]   2> 911 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[108]} 0 0
[junit4:junit4]   2> 914 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[109]} 0 0
[junit4:junit4]   2> 917 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[110]} 0 0
[junit4:junit4]   2> 920 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[111]} 0 0
[junit4:junit4]   2> 923 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[112]} 0 0
[junit4:junit4]   2> 926 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[113]} 0 0
[junit4:junit4]   2> 928 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[114]} 0 0
[junit4:junit4]   2> 931 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[115]} 0 0
[junit4:junit4]   2> 933 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[116]} 0 0
[junit4:junit4]   2> 936 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[117]} 0 0
[junit4:junit4]   2> 938 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[118]} 0 0
[junit4:junit4]   2> 941 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[119]} 0 0
[junit4:junit4]   2> 943 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[120]} 0 0
[junit4:junit4]   2> 945 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[121]} 0 0
[junit4:junit4]   2> 948 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[122]} 0 0
[junit4:junit4]   2> 951 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[123]} 0 0
[junit4:junit4]   2> 954 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[124]} 0 0
[junit4:junit4]   2> 957 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[125]} 0 0
[junit4:junit4]   2> 960 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[126]} 0 0
[junit4:junit4]   2> 963 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[127]} 0 0
[junit4:junit4]   2> 967 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[128]} 0 1
[junit4:junit4]   2> 967 T1589 C95 REQ [collection1] webapp=/solr path=/replication params={command=indexversion&qt=/replication&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 969 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[129]} 0 0
[junit4:junit4]   2> 972 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[130]} 0 0
[junit4:junit4]   2> 975 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[131]} 0 0
[junit4:junit4]   2> 978 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[132]} 0 0
[junit4:junit4]   2> 981 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[133]} 0 0
[junit4:junit4]   2> 984 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[134]} 0 0
[junit4:junit4]   2> 987 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[135]} 0 0
[junit4:junit4]   2> 990 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[136]} 0 0
[junit4:junit4]   2> 993 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[137]} 0 0
[junit4:junit4]   2> 996 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[138]} 0 0
[junit4:junit4]   2> 999 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[139]} 0 0
[junit4:junit4]   2> 1002 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[140]} 0 0
[junit4:junit4]   2> 1005 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[141]} 0 0
[junit4:junit4]   2> 1008 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[142]} 0 0
[junit4:junit4]   2> 1011 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[143]} 0 0
[junit4:junit4]   2> 1013 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[144]} 0 0
[junit4:junit4]   2> 1016 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[145]} 0 0
[junit4:junit4]   2> 1018 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[146]} 0 0
[junit4:junit4]   2> 1021 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[147]} 0 0
[junit4:junit4]   2> 1023 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[148]} 0 0
[junit4:junit4]   2> 1025 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[149]} 0 0
[junit4:junit4]   2> 1028 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[150]} 0 0
[junit4:junit4]   2> 1030 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[151]} 0 0
[junit4:junit4]   2> 1033 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[152]} 0 0
[junit4:junit4]   2> 1035 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[153]} 0 0
[junit4:junit4]   2> 1038 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[154]} 0 0
[junit4:junit4]   2> 1040 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[155]} 0 0
[junit4:junit4]   2> 1043 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[156]} 0 0
[junit4:junit4]   2> 1045 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[157]} 0 0
[junit4:junit4]   2> 1048 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[158]} 0 0
[junit4:junit4]   2> 1050 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[159]} 0 0
[junit4:junit4]   2> 1053 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[160]} 0 0
[junit4:junit4]   2> 1055 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[161]} 0 0
[junit4:junit4]   2> 1057 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[162]} 0 0
[junit4:junit4]   2> 1060 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[163]} 0 0
[junit4:junit4]   2> 1063 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[164]} 0 0
[junit4:junit4]   2> 1066 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[165]} 0 0
[junit4:junit4]   2> 1069 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[166]} 0 0
[junit4:junit4]   2> 1072 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[167]} 0 0
[junit4:junit4]   2> 1075 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[168]} 0 0
[junit4:junit4]   2> 1078 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[169]} 0 0
[junit4:junit4]   2> 1081 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[170]} 0 0
[junit4:junit4]   2> 1083 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[171]} 0 0
[junit4:junit4]   2> 1086 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[172]} 0 0
[junit4:junit4]   2> 1089 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[173]} 0 0
[junit4:junit4]   2> 1091 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[174]} 0 0
[junit4:junit4]   2> 1094 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[175]} 0 0
[junit4:junit4]   2> 1096 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[176]} 0 0
[junit4:junit4]   2> 1099 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[177]} 0 0
[junit4:junit4]   2> 1102 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[178]} 0 0
[junit4:junit4]   2> 1104 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[179]} 0 0
[junit4:junit4]   2> 1107 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[180]} 0 0
[junit4:junit4]   2> 1110 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[181]} 0 0
[junit4:junit4]   2> 1113 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[182]} 0 0
[junit4:junit4]   2> 1116 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[183]} 0 0
[junit4:junit4]   2> 1119 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[184]} 0 0
[junit4:junit4]   2> 1121 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[185]} 0 0
[junit4:junit4]   2> 1124 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[186]} 0 0
[junit4:junit4]   2> 1126 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[187]} 0 0
[junit4:junit4]   2> 1129 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[188]} 0 0
[junit4:junit4]   2> 1131 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[189]} 0 0
[junit4:junit4]   2> 1133 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[190]} 0 0
[junit4:junit4]   2> 1136 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[191]} 0 0
[junit4:junit4]   2> 1138 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[192]} 0 0
[junit4:junit4]   2> 1141 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[193]} 0 0
[junit4:junit4]   2> 1143 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[194]} 0 0
[junit4:junit4]   2> 1146 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[195]} 0 0
[junit4:junit4]   2> 1148 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[196]} 0 0
[junit4:junit4]   2> 1151 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[197]} 0 0
[junit4:junit4]   2> 1153 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[198]} 0 0
[junit4:junit4]   2> 1155 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[199]} 0 0
[junit4:junit4]   2> 1158 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[200]} 0 0
[junit4:junit4]   2> 1160 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[201]} 0 0
[junit4:junit4]   2> 1163 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[202]} 0 0
[junit4:junit4]   2> 1165 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[203]} 0 0
[junit4:junit4]   2> 1167 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[204]} 0 0
[junit4:junit4]   2> 1169 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[205]} 0 0
[junit4:junit4]   2> 1172 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[206]} 0 0
[junit4:junit4]   2> 1174 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[207]} 0 0
[junit4:junit4]   2> 1177 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[208]} 0 0
[junit4:junit4]   2> 1179 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[209]} 0 0
[junit4:junit4]   2> 1182 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[210]} 0 0
[junit4:junit4]   2> 1184 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[211]} 0 0
[junit4:junit4]   2> 1187 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[212]} 0 0
[junit4:junit4]   2> 1189 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[213]} 0 0
[junit4:junit4]   2> 1191 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[214]} 0 0
[junit4:junit4]   2> 1193 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[215]} 0 0
[junit4:junit4]   2> 1196 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[216]} 0 0
[junit4:junit4]   2> 1198 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[217]} 0 0
[junit4:junit4]   2> 1201 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[218]} 0 0
[junit4:junit4]   2> 1203 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[219]} 0 0
[junit4:junit4]   2> 1206 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[220]} 0 0
[junit4:junit4]   2> 1209 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[221]} 0 0
[junit4:junit4]   2> 1212 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[222]} 0 0
[junit4:junit4]   2> 1215 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[223]} 0 0
[junit4:junit4]   2> 1218 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[224]} 0 0
[junit4:junit4]   2> 1221 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[225]} 0 0
[junit4:junit4]   2> 1223 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[226]} 0 0
[junit4:junit4]   2> 1226 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[227]} 0 0
[junit4:junit4]   2> 1229 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[228]} 0 0
[junit4:junit4]   2> 1231 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[229]} 0 0
[junit4:junit4]   2> 1234 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[230]} 0 0
[junit4:junit4]   2> 1236 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[231]} 0 0
[junit4:junit4]   2> 1238 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[232]} 0 0
[junit4:junit4]   2> 1241 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[233]} 0 0
[junit4:junit4]   2> 1243 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[234]} 0 0
[junit4:junit4]   2> 1246 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[235]} 0 0
[junit4:junit4]   2> 1248 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[236]} 0 0
[junit4:junit4]   2> 1251 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[237]} 0 0
[junit4:junit4]   2> 1253 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[238]} 0 0
[junit4:junit4]   2> 1256 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[239]} 0 0
[junit4:junit4]   2> 1258 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[240]} 0 0
[junit4:junit4]   2> 1261 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[241]} 0 0
[junit4:junit4]   2> 1264 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[242]} 0 0
[junit4:junit4]   2> 1266 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[243]} 0 0
[junit4:junit4]   2> 1269 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[244]} 0 0
[junit4:junit4]   2> 1271 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[245]} 0 0
[junit4:junit4]   2> 1273 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[246]} 0 0
[junit4:junit4]   2> 1276 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[247]} 0 0
[junit4:junit4]   2> 1278 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[248]} 0 0
[junit4:junit4]   2> 1280 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[249]} 0 0
[junit4:junit4]   2> 1283 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[250]} 0 0
[junit4:junit4]   2> 1286 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[251]} 0 0
[junit4:junit4]   2> 1289 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[252]} 0 0
[junit4:junit4]   2> 1292 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[253]} 0 0
[junit4:junit4]   2> 1295 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[254]} 0 0
[junit4:junit4]   2> 1298 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[255]} 0 0
[junit4:junit4]   2> 1301 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[256]} 0 0
[junit4:junit4]   2> 1304 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[257]} 0 0
[junit4:junit4]   2> 1307 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[258]} 0 0
[junit4:junit4]   2> 1310 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[259]} 0 0
[junit4:junit4]   2> 1313 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[260]} 0 0
[junit4:junit4]   2> 1316 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[261]} 0 0
[junit4:junit4]   2> 1319 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[262]} 0 0
[junit4:junit4]   2> 1322 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[263]} 0 0
[junit4:junit4]   2> 1325 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[264]} 0 0
[junit4:junit4]   2> 1328 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[265]} 0 0
[junit4:junit4]   2> 1331 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[266]} 0 0
[junit4:junit4]   2> 1334 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[267]} 0 0
[junit4:junit4]   2> 1337 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[268]} 0 0
[junit4:junit4]   2> 1340 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[269]} 0 0
[junit4:junit4]   2> 1343 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[270]} 0 0
[junit4:junit4]   2> 1346 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[271]} 0 0
[junit4:junit4]   2> 1349 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[272]} 0 0
[junit4:junit4]   2> 1352 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[273]} 0 0
[junit4:junit4]   2> 1355 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[274]} 0 0
[junit4:junit4]   2> 1358 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[275]} 0 0
[junit4:junit4]   2> 1361 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[276]} 0 0
[junit4:junit4]   2> 1364 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[277]} 0 0
[junit4:junit4]   2> 1367 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[278]} 0 0
[junit4:junit4]   2> 1370 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[279]} 0 0
[junit4:junit4]   2> 1373 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[280]} 0 0
[junit4:junit4]   2> 1376 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[281]} 0 0
[junit4:junit4]   2> 1379 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[282]} 0 0
[junit4:junit4]   2> 1382 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[283]} 0 0
[junit4:junit4]   2> 1385 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[284]} 0 0
[junit4:junit4]   2> 1388 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[285]} 0 0
[junit4:junit4]   2> 1391 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[286]} 0 0
[junit4:junit4]   2> 1394 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[287]} 0 0
[junit4:junit4]   2> 1397 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[288]} 0 0
[junit4:junit4]   2> 1400 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[289]} 0 0
[junit4:junit4]   2> 1403 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[290]} 0 0
[junit4:junit4]   2> 1406 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[291]} 0 0
[junit4:junit4]   2> 1409 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[292]} 0 0
[junit4:junit4]   2> 1412 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[293]} 0 0
[junit4:junit4]   2> 1415 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[294]} 0 0
[junit4:junit4]   2> 1418 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[295]} 0 0
[junit4:junit4]   2> 1421 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[296]} 0 0
[junit4:junit4]   2> 1424 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[297]} 0 0
[junit4:junit4]   2> 1427 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[298]} 0 0
[junit4:junit4]   2> 1430 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[299]} 0 0
[junit4:junit4]   2> 1433 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[300]} 0 0
[junit4:junit4]   2> 1436 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[301]} 0 0
[junit4:junit4]   2> 1439 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[302]} 0 0
[junit4:junit4]   2> 1442 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[303]} 0 0
[junit4:junit4]   2> 1445 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[304]} 0 0
[junit4:junit4]   2> 1448 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[305]} 0 0
[junit4:junit4]   2> 1451 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[306]} 0 0
[junit4:junit4]   2> 1454 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[307]} 0 0
[junit4:junit4]   2> 1457 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[308]} 0 0
[junit4:junit4]   2> 1460 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[309]} 0 0
[junit4:junit4]   2> 1463 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[310]} 0 0
[junit4:junit4]   2> 1466 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[311]} 0 0
[junit4:junit4]   2> 1469 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[312]} 0 0
[junit4:junit4]   2> 1472 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[313]} 0 0
[junit4:junit4]   2> 1475 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[314]} 0 0
[junit4:junit4]   2> 1478 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[315]} 0 0
[junit4:junit4]   2> 1481 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[316]} 0 0
[junit4:junit4]   2> 1484 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[317]} 0 0
[junit4:junit4]   2> 1487 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[318]} 0 0
[junit4:junit4]   2> 1490 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[319]} 0 0
[junit4:junit4]   2> 1493 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[320]} 0 0
[junit4:junit4]   2> 1496 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[321]} 0 0
[junit4:junit4]   2> 1499 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[322]} 0 0
[junit4:junit4]   2> 1502 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[323]} 0 0
[junit4:junit4]   2> 1505 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[324]} 0 0
[junit4:junit4]   2> 1508 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[325]} 0 0
[junit4:junit4]   2> 1511 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[326]} 0 0
[junit4:junit4]   2> 1514 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[327]} 0 0
[junit4:junit4]   2> 1517 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[328]} 0 0
[junit4:junit4]   2> 1520 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[329]} 0 0
[junit4:junit4]   2> 1523 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[330]} 0 0
[junit4:junit4]   2> 1526 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[331]} 0 0
[junit4:junit4]   2> 1529 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[332]} 0 0
[junit4:junit4]   2> 1532 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[333]} 0 0
[junit4:junit4]   2> 1535 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[334]} 0 0
[junit4:junit4]   2> 1538 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[335]} 0 0
[junit4:junit4]   2> 1541 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[336]} 0 0
[junit4:junit4]   2> 1544 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[337]} 0 0
[junit4:junit4]   2> 1547 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[338]} 0 0
[junit4:junit4]   2> 1550 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[339]} 0 0
[junit4:junit4]   2> 1553 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[340]} 0 0
[junit4:junit4]   2> 1556 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[341]} 0 0
[junit4:junit4]   2> 1559 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[342]} 0 0
[junit4:junit4]   2> 1562 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[343]} 0 0
[junit4:junit4]   2> 1565 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[344]} 0 0
[junit4:junit4]   2> 1568 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[345]} 0 0
[junit4:junit4]   2> 1571 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[346]} 0 0
[junit4:junit4]   2> 1574 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[347]} 0 0
[junit4:junit4]   2> 1577 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[348]} 0 0
[junit4:junit4]   2> 1580 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[349]} 0 0
[junit4:junit4]   2> 1583 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[350]} 0 0
[junit4:junit4]   2> 1586 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[351]} 0 0
[junit4:junit4]   2> 1589 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[352]} 0 0
[junit4:junit4]   2> 1592 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[353]} 0 0
[junit4:junit4]   2> 1595 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[354]} 0 0
[junit4:junit4]   2> 1598 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[355]} 0 0
[junit4:junit4]   2> 1601 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[356]} 0 0
[junit4:junit4]   2> 1604 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[357]} 0 0
[junit4:junit4]   2> 1607 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[358]} 0 0
[junit4:junit4]   2> 1610 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[359]} 0 0
[junit4:junit4]   2> 1613 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[360]} 0 0
[junit4:junit4]   2> 1616 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[361]} 0 0
[junit4:junit4]   2> 1619 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[362]} 0 0
[junit4:junit4]   2> 1622 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[363]} 0 0
[junit4:junit4]   2> 1625 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[364]} 0 0
[junit4:junit4]   2> 1628 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[365]} 0 0
[junit4:junit4]   2> 1631 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[366]} 0 0
[junit4:junit4]   2> 1634 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[367]} 0 0
[junit4:junit4]   2> 1637 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[368]} 0 0
[junit4:junit4]   2> 1640 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[369]} 0 0
[junit4:junit4]   2> 1643 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[370]} 0 0
[junit4:junit4]   2> 1646 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[371]} 0 0
[junit4:junit4]   2> 1649 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[372]} 0 0
[junit4:junit4]   2> 1652 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[373]} 0 0
[junit4:junit4]   2> 1655 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[374]} 0 0
[junit4:junit4]   2> 1658 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[375]} 0 0
[junit4:junit4]   2> 1661 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[376]} 0 0
[junit4:junit4]   2> 1664 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[377]} 0 0
[junit4:junit4]   2> 1667 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[378]} 0 0
[junit4:junit4]   2> 1670 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[379]} 0 0
[junit4:junit4]   2> 1673 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[380]} 0 0
[junit4:junit4]   2> 1676 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[381]} 0 0
[junit4:junit4]   2> 1679 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[382]} 0 0
[junit4:junit4]   2> 1682 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[383]} 0 0
[junit4:junit4]   2> 1685 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[384]} 0 0
[junit4:junit4]   2> 1688 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[385]} 0 0
[junit4:junit4]   2> 1691 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[386]} 0 0
[junit4:junit4]   2> 1694 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[387]} 0 0
[junit4:junit4]   2> 1697 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[388]} 0 0
[junit4:junit4]   2> 1700 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[389]} 0 0
[junit4:junit4]   2> 1703 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[390]} 0 0
[junit4:junit4]   2> 1706 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[391]} 0 0
[junit4:junit4]   2> 1709 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[392]} 0 0
[junit4:junit4]   2> 1712 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[393]} 0 0
[junit4:junit4]   2> 1715 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[394]} 0 0
[junit4:junit4]   2> 1718 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[395]} 0 0
[junit4:junit4]   2> 1721 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[396]} 0 0
[junit4:junit4]   2> 1724 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[397]} 0 0
[junit4:junit4]   2> 1727 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[398]} 0 0
[junit4:junit4]   2> 1730 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[399]} 0 0
[junit4:junit4]   2> 1733 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[400]} 0 0
[junit4:junit4]   2> 1736 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[401]} 0 0
[junit4:junit4]   2> 1739 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[402]} 0 0
[junit4:junit4]   2> 1742 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[403]} 0 0
[junit4:junit4]   2> 1745 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[404]} 0 0
[junit4:junit4]   2> 1748 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[405]} 0 0
[junit4:junit4]   2> 1751 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[406]} 0 0
[junit4:junit4]   2> 1754 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[407]} 0 0
[junit4:junit4]   2> 1757 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[408]} 0 0
[junit4:junit4]   2> 1760 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[409]} 0 0
[junit4:junit4]   2> 1763 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[410]} 0 0
[junit4:junit4]   2> 1766 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[411]} 0 0
[junit4:junit4]   2> 1769 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[412]} 0 0
[junit4:junit4]   2> 1772 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[413]} 0 0
[junit4:junit4]   2> 1775 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[414]} 0 0
[junit4:junit4]   2> 1778 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[415]} 0 0
[junit4:junit4]   2> 1781 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[416]} 0 0
[junit4:junit4]   2> 1784 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[417]} 0 0
[junit4:junit4]   2> 1787 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[418]} 0 0
[junit4:junit4]   2> 1790 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[419]} 0 0
[junit4:junit4]   2> 1793 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[420]} 0 0
[junit4:junit4]   2> 1796 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[421]} 0 0
[junit4:junit4]   2> 1799 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[422]} 0 0
[junit4:junit4]   2> 1802 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[423]} 0 0
[junit4:junit4]   2> 1805 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[424]} 0 0
[junit4:junit4]   2> 1808 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[425]} 0 0
[junit4:junit4]   2> 1811 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[426]} 0 0
[junit4:junit4]   2> 1814 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[427]} 0 0
[junit4:junit4]   2> 1817 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[428]} 0 0
[junit4:junit4]   2> 1820 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[429]} 0 0
[junit4:junit4]   2> 1823 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[430]} 0 0
[junit4:junit4]   2> 1826 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[431]} 0 0
[junit4:junit4]   2> 1829 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[432]} 0 0
[junit4:junit4]   2> 1832 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[433]} 0 0
[junit4:junit4]   2> 1835 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[434]} 0 0
[junit4:junit4]   2> 1838 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[435]} 0 0
[junit4:junit4]   2> 1841 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[436]} 0 0
[junit4:junit4]   2> 1844 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[437]} 0 0
[junit4:junit4]   2> 1847 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[438]} 0 0
[junit4:junit4]   2> 1850 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[439]} 0 0
[junit4:junit4]   2> 1853 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[440]} 0 0
[junit4:junit4]   2> 1856 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[441]} 0 0
[junit4:junit4]   2> 1859 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[442]} 0 0
[junit4:junit4]   2> 1862 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[443]} 0 0
[junit4:junit4]   2> 1865 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[444]} 0 0
[junit4:junit4]   2> 1868 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[445]} 0 0
[junit4:junit4]   2> 1871 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[446]} 0 0
[junit4:junit4]   2> 1874 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[447]} 0 0
[junit4:junit4]   2> 1877 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[448]} 0 0
[junit4:junit4]   2> 1880 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[449]} 0 0
[junit4:junit4]   2> 1883 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[450]} 0 0
[junit4:junit4]   2> 1886 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[451]} 0 0
[junit4:junit4]   2> 1889 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[452]} 0 0
[junit4:junit4]   2> 1892 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[453]} 0 0
[junit4:junit4]   2> 1895 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[454]} 0 0
[junit4:junit4]   2> 1898 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[455]} 0 0
[junit4:junit4]   2> 1901 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[456]} 0 0
[junit4:junit4]   2> 1904 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[457]} 0 0
[junit4:junit4]   2> 1907 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[458]} 0 0
[junit4:junit4]   2> 1910 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[459]} 0 0
[junit4:junit4]   2> 1913 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[460]} 0 0
[junit4:junit4]   2> 1916 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[461]} 0 0
[junit4:junit4]   2> 1919 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[462]} 0 0
[junit4:junit4]   2> 1922 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[463]} 0 0
[junit4:junit4]   2> 1925 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[464]} 0 0
[junit4:junit4]   2> 1928 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[465]} 0 0
[junit4:junit4]   2> 1931 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[466]} 0 0
[junit4:junit4]   2> 1934 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[467]} 0 0
[junit4:junit4]   2> 1937 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[468]} 0 0
[junit4:junit4]   2> 1940 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[469]} 0 0
[junit4:junit4]   2> 1943 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[470]} 0 0
[junit4:junit4]   2> 1946 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[471]} 0 0
[junit4:junit4]   2> 1949 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[472]} 0 0
[junit4:junit4]   2> 1952 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[473]} 0 0
[junit4:junit4]   2> 1955 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[474]} 0 0
[junit4:junit4]   2> 1958 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[475]} 0 0
[junit4:junit4]   2> 1961 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[476]} 0 0
[junit4:junit4]   2> 1964 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[477]} 0 0
[junit4:junit4]   2> 1967 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[478]} 0 0
[junit4:junit4]   2> 1968 T1589 C95 REQ [collection1] webapp=/solr path=/replication params={command=indexversion&qt=/replication&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 1970 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[479]} 0 0
[junit4:junit4]   2> 1973 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[480]} 0 0
[junit4:junit4]   2> 1976 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[481]} 0 0
[junit4:junit4]   2> 1979 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[482]} 0 0
[junit4:junit4]   2> 1982 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[483]} 0 0
[junit4:junit4]   2> 1985 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[484]} 0 0
[junit4:junit4]   2> 1988 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[485]} 0 0
[junit4:junit4]   2> 1991 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[486]} 0 0
[junit4:junit4]   2> 1994 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[487]} 0 0
[junit4:junit4]   2> 1997 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[488]} 0 0
[junit4:junit4]   2> 2000 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[489]} 0 0
[junit4:junit4]   2> 2003 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[490]} 0 0
[junit4:junit4]   2> 2006 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[491]} 0 0
[junit4:junit4]   2> 2009 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[492]} 0 0
[junit4:junit4]   2> 2012 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[493]} 0 0
[junit4:junit4]   2> 2015 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[494]} 0 0
[junit4:junit4]   2> 2018 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[495]} 0 0
[junit4:junit4]   2> 2021 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[496]} 0 0
[junit4:junit4]   2> 2024 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[497]} 0 0
[junit4:junit4]   2> 2027 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[498]} 0 0
[junit4:junit4]   2> 2030 T1588 C95 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   2> 2041 T1588 C95 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@35d2b35b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@d23e223),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@35d2b35b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@d23e223),segFN=segments_2,generation=2,filenames=[_0_Lucene40_0.tim, _0.fnm, _0_Lucene40_0.frq, _0_nrm.cfe, segments_2, _0.fdx, _0_nrm.cfs, _0.si, _0.fdt, _0_Lucene40_0.tip]
[junit4:junit4]   2> 2041 T1588 C95 oasc.SolrDeletionPolicy.updateCommits newest commit = 2[_0_Lucene40_0.tim, _0.fnm, _0_Lucene40_0.frq, _0_nrm.cfe, segments_2, _0.fdx, _0_nrm.cfs, _0.si, _0.fdt, _0_Lucene40_0.tip]
[junit4:junit4]   2> 2043 T1588 C95 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data
[junit4:junit4]   2> 2044 T1588 C95 oass.SolrIndexSearcher.<init> Opening Searcher@75c7e249 main
[junit4:junit4]   2> 2044 T1588 C95 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 2045 T1596 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@75c7e249 main{StandardDirectoryReader(segments_2:3 _0(4.2):C499)}
[junit4:junit4]   2> 2045 T1596 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data/index
[junit4:junit4]   2> 2045 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 15
[junit4:junit4]   2> 2048 T1588 C95 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=499 status=0 QTime=0 
[junit4:junit4]   2> ASYNC  NEW_CORE C96 name=collection1 org.apache.solr.core.SolrCore@22f01dd3
[junit4:junit4]   2> 2157 T1599 C96 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=1 
[junit4:junit4]   2> 2260 T1599 C96 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 2364 T1599 C96 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 2469 T1599 C96 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 2572 T1599 C96 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 2676 T1599 C96 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 2780 T1599 C96 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 2884 T1599 C96 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 2967 T1589 C95 REQ [collection1] webapp=/solr path=/replication params={command=indexversion&qt=/replication&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 2968 T1608 oash.SnapPuller.fetchLatestIndex Master's generation: 2
[junit4:junit4]   2> 2969 T1608 oash.SnapPuller.fetchLatestIndex Slave's generation: 1
[junit4:junit4]   2> 2969 T1608 oash.SnapPuller.fetchLatestIndex Starting replication process
[junit4:junit4]   2> 2971 T1589 C95 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data
[junit4:junit4]   2> 2972 T1589 C95 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data/index
[junit4:junit4]   2> 2980 T1589 C95 REQ [collection1] webapp=/solr path=/replication params={command=filelist&qt=/replication&wt=javabin&generation=2&version=2} status=0 QTime=9 
[junit4:junit4]   2> 2981 T1608 oash.SnapPuller.fetchLatestIndex Number of files in latest index in master: 10
[junit4:junit4]   2> 2983 T1608 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index.20130228065945017 forceNew:false
[junit4:junit4]   2> 2984 T1608 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data
[junit4:junit4]   2> 2984 T1608 oash.SnapPuller.fetchLatestIndex Starting download to MockDirWrapper(RateLimitedDirectoryWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/index3857038591tmp lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@479d0d9c; maxCacheMB=0.8935546875 maxMergeSizeMB=0.4619140625))) fullCopy=false
[junit4:junit4]   2> 2987 T1589 C95 REQ [collection1] webapp=/solr path=/replication params={file=_0_Lucene40_0.tim&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0 
[junit4:junit4]   2> 2988 T1599 C96 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 2992 T1589 C95 REQ [collection1] webapp=/solr path=/replication params={file=_0.fnm&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0 
[junit4:junit4]   2> 3003 T1589 C95 REQ [collection1] webapp=/solr path=/replication params={file=_0_Lucene40_0.frq&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0 
[junit4:junit4]   2> 3007 T1589 C95 REQ [collection1] webapp=/solr path=/replication params={file=_0_nrm.cfe&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0 
[junit4:junit4]   2> 3011 T1589 C95 REQ [collection1] webapp=/solr path=/replication params={file=segments_2&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0 
[junit4:junit4]   2> 3016 T1589 C95 REQ [collection1] webapp=/solr path=/replication params={file=_0.fdx&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0 
[junit4:junit4]   2> 3020 T1589 C95 REQ [collection1] webapp=/solr path=/replication params={file=_0_nrm.cfs&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0 
[junit4:junit4]   2> 3024 T1589 C95 REQ [collection1] webapp=/solr path=/replication params={file=_0.si&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0 
[junit4:junit4]   2> 3028 T1589 C95 REQ [collection1] webapp=/solr path=/replication params={file=_0.fdt&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0 
[junit4:junit4]   2> 3032 T1589 C95 REQ [collection1] webapp=/solr path=/replication params={file=_0_Lucene40_0.tip&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0 
[junit4:junit4]   2> 3033 T1608 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index
[junit4:junit4]   2> 3033 T1608 oash.SnapPuller.fetchLatestIndex Total time taken for download : 0 secs
[junit4:junit4]   2> 3041 T1608 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data
[junit4:junit4]   2> 3042 T1608 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data
[junit4:junit4]   2> 3043 T1608 oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter...
[junit4:junit4]   2> 3043 T1608 oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused... core=collection1
[junit4:junit4]   2> 3043 T1608 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data
[junit4:junit4]   2> 3045 T1608 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@7a72fdba lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1d545074),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@7a72fdba lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1d545074),segFN=segments_2,generation=2,filenames=[_0_Lucene40_0.tim, _0.fnm, _0_Lucene40_0.frq, _0_nrm.cfe, segments_2, _0.fdx, _0_nrm.cfs, _0.si, _0.fdt, _0_Lucene40_0.tip]
[junit4:junit4]   2> 3045 T1608 oasc.SolrDeletionPolicy.updateCommits newest commit = 2[_0_Lucene40_0.tim, _0.fnm, _0_Lucene40_0.frq, _0_nrm.cfe, segments_2, _0.fdx, _0_nrm.cfs, _0.si, _0.fdt, _0_Lucene40_0.tip]
[junit4:junit4]   2> 3046 T1608 oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used.
[junit4:junit4]   2> 3046 T1608 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data
[junit4:junit4]   2> 3047 T1608 oass.SolrIndexSearcher.<init> Opening Searcher@79ee08b8 main
[junit4:junit4]   2> 3047 T1607 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@79ee08b8 main{StandardDirectoryReader(segments_2:3:nrt _0(4.2):C499)}
[junit4:junit4]   2> 3048 T1607 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index
[junit4:junit4]   2> 3048 T1608 oash.SnapPuller.fetchLatestIndex removing temporary index download directory files MockDirWrapper(RateLimitedDirectoryWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/index3857038591tmp lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@479d0d9c; maxCacheMB=0.8935546875 maxMergeSizeMB=0.4619140625)))
[junit4:junit4]   2> 3049 T1608 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index.20130228065945017
[junit4:junit4]   2> 3049 T1608 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index
[junit4:junit4]   2> 3093 T1599 C96 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=499 status=0 QTime=1 
[junit4:junit4]   2> 3196 T1588 C95 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4]   2> 3197 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:*} 0 1
[junit4:junit4]   2> 3200 T1588 C95 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   2> 3201 T1588 C95 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=3
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@35d2b35b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@d23e223),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@35d2b35b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@d23e223),segFN=segments_2,generation=2,filenames=[_0_Lucene40_0.tim, _0.fnm, _0_Lucene40_0.frq, _0_nrm.cfe, segments_2, _0.fdx, _0_nrm.cfs, _0.si, _0.fdt, _0_Lucene40_0.tip]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@35d2b35b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@d23e223),segFN=segments_3,generation=3,filenames=[segments_3]
[junit4:junit4]   2> 3201 T1588 C95 oasc.SolrDeletionPolicy.updateCommits newest commit = 3[segments_3]
[junit4:junit4]   2> 3202 T1588 C95 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data
[junit4:junit4]   2> 3203 T1588 C95 oass.SolrIndexSearcher.<init> Opening Searcher@661a4ee main
[junit4:junit4]   2> 3203 T1588 C95 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 3203 T1596 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@661a4ee main{StandardDirectoryReader(segments_3:4)}
[junit4:junit4]   2> 3204 T1596 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data/index
[junit4:junit4]   2> 3204 T1588 C95 UPDATE [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 4
[junit4:junit4]   2> 3218 T1585 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1947149638
[junit4:junit4]   2> 3219 T1585 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@41fe4ceb
[junit4:junit4]   2> 3220 T1585 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=2,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=499,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0}
[junit4:junit4]   2> 3221 T1585 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 3221 T1585 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 3222 T1585 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 3223 T1585 C95 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data/index
[junit4:junit4]   2> 3224 T1585 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 3224 T1585 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data/index
[junit4:junit4]   2> 3225 T1585 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data
[junit4:junit4]   2> 3225 T1585 oasc.CachingDirectoryFactory.closeDirectory Closing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data
[junit4:junit4]   2> 3226 T1585 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data/index
[junit4:junit4]   2> 3226 T1585 oasc.CachingDirectoryFactory.closeDirectory Closing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data/index
[junit4:junit4]   2> 3227 T1585 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4]   2> 3279 T1585 oejs.Server.doStart jetty-8.1.8.v20121106
[junit4:junit4]   2> 3282 T1585 oejs.AbstractConnector.doStart Started SocketConnector@127.0.0.1:42837
[junit4:junit4]   2> 3283 T1585 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 3283 T1585 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 3284 T1585 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master
[junit4:junit4]   2> 3284 T1585 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/solr.xml
[junit4:junit4]   2> 3285 T1585 oasc.CoreContainer.<init> New CoreContainer 464455355
[junit4:junit4]   2> 3285 T1585 oasc.CoreContainer$Initializer.initialize no solr.xml file found - using default
[junit4:junit4]   2> 3286 T1585 oasc.CoreContainer.load Loading CoreContainer using Solr Home: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/'
[junit4:junit4]   2> 3286 T1585 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/'
[junit4:junit4]   2> 3355 T1585 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 3356 T1585 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 3356 T1585 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 3356 T1585 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 3357 T1585 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 3357 T1585 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 3358 T1585 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 3358 T1585 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 3359 T1585 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 3359 T1585 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 3384 T1585 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 3411 T1619 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1
[junit4:junit4]   2> 3412 T1619 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/'
[junit4:junit4]   2> 3458 T1619 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_42
[junit4:junit4]   2> 3517 T1619 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 3517 T1619 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 3521 T1619 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 3545 T1619 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 3547 T1619 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/, dataDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data/
[junit4:junit4]   2> 3547 T1619 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4:junit4]   2> 3547 T1619 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 3549 T1619 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data forceNew:false
[junit4:junit4]   2> 3550 T1619 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data
[junit4:junit4]   2> 3550 T1619 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data/index/
[junit4:junit4]   2> 3551 T1619 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 3552 T1619 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data/index forceNew:false
[junit4:junit4]   2> 3553 T1619 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@63af018f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@48c1944e),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 3553 T1619 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 3554 T1619 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data/index
[junit4:junit4]   2> 3555 T1619 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 3555 T1619 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 3555 T1619 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 3556 T1619 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 3556 T1619 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 3556 T1619 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 3571 T1619 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 3574 T1619 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data
[junit4:junit4]   2> 3574 T1619 oass.SolrIndexSearcher.<init> Opening Searcher@20ee3cce main
[junit4:junit4]   2> 3575 T1619 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 3575 T1619 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 3575 T1619 oash.ReplicationHandler.inform Replication enabled for following config files: schema-replication2.xml:schema.xml
[junit4:junit4]   2> 3576 T1619 oash.ReplicationHandler.inform Commits will be reserved for  10000
[junit4:junit4]   2> 3576 T1619 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 3576 T1620 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@20ee3cce main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 3576 T1585 oass.SolrDispatchFilter.init user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1
[junit4:junit4]   2> 3577 T1585 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 3578 T1585 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 3596 T1585 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1966855563
[junit4:junit4]   2> 3597 T1585 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@22f01dd3
[junit4:junit4]   2> 3598 T1585 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:junit4]   2> 3598 T1585 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 3599 T1585 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 3599 T1585 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 3600 T1585 C96 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index
[junit4:junit4]   2> 3601 T1585 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 3602 T1585 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index
[junit4:junit4]   2> 3602 T1585 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index.20130228065945017
[junit4:junit4]   2> 3603 T1585 oasc.CachingDirectoryFactory.closeDirectory Closing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index.20130228065945017
[junit4:junit4]   2> 3603 T1585 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index
[junit4:junit4]   2> 3604 T1585 oasc.CachingDirectoryFactory.closeDirectory Closing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index
[junit4:junit4]   2> 3604 T1585 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data
[junit4:junit4]   2> 3605 T1585 oasc.CachingDirectoryFactory.closeDirectory Closing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data
[junit4:junit4]   2> 3605 T1585 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4]   2> 3658 T1585 oejs.Server.doStart jetty-8.1.8.v20121106
[junit4:junit4]   2> 3661 T1585 oejs.AbstractConnector.doStart Started SocketConnector@127.0.0.1:42838
[junit4:junit4]   2> 3662 T1585 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 3662 T1585 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 3662 T1585 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave
[junit4:junit4]   2> 3663 T1585 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/solr.xml
[junit4:junit4]   2> 3663 T1585 oasc.CoreContainer.<init> New CoreContainer 1234005540
[junit4:junit4]   2> 3664 T1585 oasc.CoreContainer$Initializer.initialize no solr.xml file found - using default
[junit4:junit4]   2> 3665 T1585 oasc.CoreContainer.load Loading CoreContainer using Solr Home: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/'
[junit4:junit4]   2> 3665 T1585 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/'
[junit4:junit4]   2> 3687 T1585 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 3688 T1585 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 3688 T1585 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 3689 T1585 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 3689 T1585 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 3690 T1585 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 3690 T1585 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 3691 T1585 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 3691 T1585 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 3692 T1585 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 3711 T1585 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 3739 T1630 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1
[junit4:junit4]   2> 3740 T1630 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/'
[junit4:junit4]   2> 3784 T1630 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_42
[junit4:junit4]   2> 3872 T1630 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 3873 T1630 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 3876 T1630 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 3895 T1630 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 3897 T1630 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/, dataDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/
[junit4:junit4]   2> 3897 T1630 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4:junit4]   2> 3897 T1630 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 3899 T1630 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data forceNew:false
[junit4:junit4]   2> 3899 T1630 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data
[junit4:junit4]   2> 3900 T1630 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index/
[junit4:junit4]   2> 3900 T1630 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 3901 T1630 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index forceNew:false
[junit4:junit4]   2> 3902 T1630 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@1cab6b8 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5b4809cb),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 3903 T1630 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 3903 T1630 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index
[junit4:junit4]   2> 3904 T1630 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 3904 T1630 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 3905 T1630 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 3905 T1630 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 3905 T1630 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 3905 T1630 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 3907 T1630 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 3911 T1630 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data
[junit4:junit4]   2> 3911 T1630 oass.SolrIndexSearcher.<init> Opening Searcher@7ecd15b4 main
[junit4:junit4]   2> 3912 T1630 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 3912 T1630 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 3912 T1630 oash.SnapPuller.startExecutorService Poll Scheduled at an interval of 1000ms
[junit4:junit4]   2> 3913 T1630 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 3913 T1631 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7ecd15b4 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 3913 T1585 oass.SolrDispatchFilter.init user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1
[junit4:junit4]   2> 3914 T1585 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 3914 T1585 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> ASYNC  NEW_CORE C97 name=collection1 org.apache.solr.core.SolrCore@3ea76cda
[junit4:junit4]   2> 3934 T1623 C97 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4]   2> 3935 T1623 C97 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data
[junit4:junit4]   2> 3937 T1623 C97 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@1cab6b8 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5b4809cb),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 3937 T1623 C97 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 3938 T1623 C97 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:*} 0 4
[junit4:junit4]   2> 3941 T1623 C97 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   2> 3942 T1623 C97 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@1cab6b8 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5b4809cb),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@1cab6b8 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5b4809cb),segFN=segments_2,generation=2,filenames=[segments_2]
[junit4:junit4]   2> 3942 T1623 C97 oasc.SolrDeletionPolicy.updateCommits newest commit = 2[segments_2]
[junit4:junit4]   2> 3943 T1623 C97 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data
[junit4:junit4]   2> 3943 T1623 C97 oass.SolrIndexSearcher.<init> Opening Searcher@2efe4900 main
[junit4:junit4]   2> 3944 T1631 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2efe4900 main{StandardDirectoryReader(segments_2:2)}
[junit4:junit4]   2> 3944 T1623 C97 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 3944 T1631 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index
[junit4:junit4]   2> 3945 T1623 C97 UPDATE [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 4
[junit4:junit4]   2> ASYNC  NEW_CORE C98 name=collection1 org.apache.solr.core.SolrCore@74502ab7
[junit4:junit4]   2> 3955 T1612 C98 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data
[junit4:junit4]   2> 3957 T1612 C98 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@63af018f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@48c1944e),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 3958 T1612 C98 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 3959 T1612 C98 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[2000]} 0 4
[junit4:junit4]   2> 3962 T1612 C98 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   2> 3965 T1612 C98 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@63af018f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@48c1944e),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@63af018f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@48c1944e),segFN=segments_2,generation=2,filenames=[_0_Lucene40_0.tim, _0.fnm, _0_Lucene40_0.frq, _0_nrm.cfe, segments_2, _0.fdx, _0_nrm.cfs, _0.si, _0.fdt, _0_Lucene40_0.tip]
[junit4:junit4]   2> 3966 T1612 C98 oasc.SolrDeletionPolicy.updateCommits newest commit = 2[_0_Lucene40_0.tim, _0.fnm, _0_Lucene40_0.frq, _0_nrm.cfe, segments_2, _0.fdx, _0_nrm.cfs, _0.si, _0.fdt, _0_Lucene40_0.tip]
[junit4:junit4]   2> 3966 T1613 C98 REQ [collection1] webapp=/solr path=/replication params={command=indexversion&qt=/replication&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 3967 T1612 C98 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data
[junit4:junit4]   2> 3968 T1612 C98 oass.SolrIndexSearcher.<init> Opening Searcher@41ce2286 main
[junit4:junit4]   2> 3968 T1612 C98 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 3968 T1620 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@41ce2286 main{StandardDirectoryReader(segments_2:3 _0(4.2):C1)}
[junit4:junit4]   2> 3969 T1620 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data/index
[junit4:junit4]   2> 3969 T1612 C98 UPDATE [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 7
[junit4:junit4]   2> 3972 T1612 C98 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=1 status=0 QTime=0 
[junit4:junit4]   2> 4076 T1623 C97 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 4180 T1623 C97 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 4284 T1623 C97 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 4388 T1623 C97 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 4492 T1623 C97 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 4596 T1623 C97 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 4700 T1623 C97 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 4804 T1623 C97 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 4909 T1623 C97 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=1 
[junit4:junit4]   2> 4968 T1613 C98 REQ [collection1] webapp=/solr path=/replication params={command=indexversion&qt=/replication&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 4969 T1632 oash.SnapPuller.fetchLatestIndex Master's generation: 2
[junit4:junit4]   2> 4970 T1632 oash.SnapPuller.fetchLatestIndex Slave's generation: 2
[junit4:junit4]   2> 4970 T1632 oash.SnapPuller.fetchLatestIndex Starting replication process
[junit4:junit4]   2> 4972 T1613 C98 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data
[junit4:junit4]   2> 4973 T1613 C98 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data/index
[junit4:junit4]   2> 4974 T1613 C98 REQ [collection1] webapp=/solr path=/replication params={command=filelist&qt=/replication&wt=javabin&generation=2&version=2} status=0 QTime=2 
[junit4:junit4]   2> 4975 T1632 oash.SnapPuller.fetchLatestIndex Number of files in latest index in master: 10
[junit4:junit4]   2> 4977 T1632 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index.20130228065947012 forceNew:false
[junit4:junit4]   2> 4978 T1632 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data
[junit4:junit4]   2> 4978 T1632 oash.SnapPuller.fetchLatestIndex Starting download to MockDirWrapper(RateLimitedDirectoryWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/index3857038594tmp lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1c1063a4; maxCacheMB=0.8935546875 maxMergeSizeMB=0.4619140625))) fullCopy=true
[junit4:junit4]   2> 4981 T1613 C98 REQ [collection1] webapp=/solr path=/replication params={file=_0_Lucene40_0.tim&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0 
[junit4:junit4]   2> 4986 T1613 C98 REQ [collection1] webapp=/solr path=/replication params={file=_0.fnm&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0 
[junit4:junit4]   2> 5013 T1623 C97 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 5017 T1613 C98 REQ [collection1] webapp=/solr path=/replication params={file=_0_Lucene40_0.frq&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0 
[junit4:junit4]   2> 5047 T1613 C98 REQ [collection1] webapp=/solr path=/replication params={file=_0_nrm.cfe&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0 
[junit4:junit4]   2> 5052 T1613 C98 REQ [collection1] webapp=/solr path=/replication params={file=segments_2&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0 
[junit4:junit4]   2> 5068 T1613 C98 REQ [collection1] webapp=/solr path=/replication params={file=_0.fdx&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0 
[junit4:junit4]   2> 5102 T1613 C98 REQ [collection1] webapp=/solr path=/replication params={file=_0_nrm.cfs&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0 
[junit4:junit4]   2> 5118 T1623 C97 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=1 
[junit4:junit4]   2> 5152 T1613 C98 REQ [collection1] webapp=/solr path=/replication params={file=_0.si&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0 
[junit4:junit4]   2> 5158 T1613 C98 REQ [collection1] webapp=/solr path=/replication params={file=_0.fdt&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0 
[junit4:junit4]   2> 5171 T1613 C98 REQ [collection1] webapp=/solr path=/replication params={file=_0_Lucene40_0.tip&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0 
[junit4:junit4]   2> 5172 T1632 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index
[junit4:junit4]   2> 5172 T1632 oash.SnapPuller.fetchLatestIndex Total time taken for download : 0 secs
[junit4:junit4]   2> 5173 T1632 oash.SnapPuller.downloadConfFiles Starting download of configuration files from master: [{alias=schema.xml, name=schema-replication2.xml, checksum=1505963717, size=1634}]
[junit4:junit4]   2> 5188 T1613 C98 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&wt=filestream&cf=schema-replication2.xml&qt=/replication&generation=2} status=0 QTime=5 
[junit4:junit4]   2> 5199 T1632 oash.SnapPuller.modifyIndexProps New index installed. Updating index properties... index=index.20130228065947012
[junit4:junit4]   2> 5200 T1632 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data
[junit4:junit4]   2> 5200 T1632 oash.SnapPuller.fetchLatestIndex Configuration files are modified, core will be reloaded
[junit4:junit4]   2> 5201 T1632 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data
[junit4:junit4]   2> 5202 T1632 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data
[junit4:junit4]   2> 5207 T1634 oasc.CoreContainer.reload Reloading SolrCore 'collection1' using instanceDir: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1
[junit4:junit4]   2> 5208 T1632 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index.20130228065947012
[junit4:junit4]   2> 5208 T1632 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index
[junit4:junit4]   2> 5208 T1634 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/'
[junit4:junit4]   2> 5208 T1632 oasc.SolrException.log SEVERE SnapPull failed :org.apache.solr.common.SolrException: Index fetch failed : 
[junit4:junit4]   2> 		at org.apache.solr.handler.SnapPuller.fetchLatestIndex(SnapPuller.java:479)
[junit4:junit4]   2> 		at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:281)
[junit4:junit4]   2> 		at org.apache.solr.handler.SnapPuller$1.run(SnapPuller.java:223)
[junit4:junit4]   2> 		at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
[junit4:junit4]   2> 		at java.util.concurrent.FutureTask$Sync.innerRunAndReset(FutureTask.java:351)
[junit4:junit4]   2> 		at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:178)
[junit4:junit4]   2> 		at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:178)
[junit4:junit4]   2> 		at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
[junit4:junit4]   2> 		at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110)
[junit4:junit4]   2> 		at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603)
[junit4:junit4]   2> 		at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 	Caused by: java.lang.IllegalArgumentException: Unknown directory: null {MockDirWrapper(RateLimitedDirectoryWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/index3857038594tmp lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1c1063a4; maxCacheMB=0.8935546875 maxMergeSizeMB=0.4619140625)))=CachedDir<<MockDirWrapper(RateLimitedDirectoryWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/index3857038594tmp lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1c1063a4; maxCacheMB=0.8935546875 maxMergeSizeMB=0.4619140625)));refCount=1;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index.20130228065947012;done=false>>, MockDirWrapper(RateLimitedDirectoryWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/index3857038593tmp lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@417a7108; maxCacheMB=0.8935546875 maxMergeSizeMB=0.4619140625)))=CachedDir<<MockDirWrapper(RateLimitedDirectoryWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/index3857038593tmp lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@417a7108; maxCacheMB=0.8935546875 maxMergeSizeMB=0.4619140625)));refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data;done=false>>, MockDirWrapper(org.apache.lucene.store.RAMDirectory@1cab6b8 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5b4809cb)=CachedDir<<MockDirWrapper(org.apache.lucene.store.RAMDirectory@1cab6b8 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5b4809cb);refCount=3;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index;done=false>>}
[junit4:junit4]   2> 		at org.apache.solr.core.CachingDirectoryFactory.addCloseListener(CachingDirectoryFactory.java:87)
[junit4:junit4]   2> 		at org.apache.solr.handler.SnapPuller.fetchLatestIndex(SnapPuller.java:437)
[junit4:junit4]   2> 		... 10 more
[junit4:junit4]   2> 	
[junit4:junit4]   2> 5221 T1623 C97 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 5280 T1634 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_42
[junit4:junit4]   2> 5325 T1623 C97 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 5333 T1634 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 5334 T1634 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 5338 T1634 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 5359 T1634 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 5362 T1634 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data
[junit4:junit4]   2> 5362 T1634 oasc.SolrCore.getNewIndexDir New index directory detected: old=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index/ new=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index.20130228065947012
[junit4:junit4]   2> 5362 T1634 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/, dataDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/
[junit4:junit4]   2> 5363 T1634 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4:junit4]   2> 5363 T1634 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data
[junit4:junit4]   2> 5363 T1634 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index.20130228065947012
[junit4:junit4]   2> 5364 T1634 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index.20130228065947012
[junit4:junit4]   2> 5365 T1634 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 5365 T1634 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 5365 T1634 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 5366 T1634 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 5366 T1634 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 5366 T1634 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 5379 T1634 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 5382 T1634 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data
[junit4:junit4]   2> 5388 T1634 oass.SolrIndexSearcher.<init> Opening Searcher@302a72fd main
[junit4:junit4]   2> 5389 T1634 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 5389 T1634 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 5389 T1634 oash.SnapPuller.startExecutorService Poll Scheduled at an interval of 1000ms
[junit4:junit4]   2> 5390 T1634 oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter...
[junit4:junit4]   2> 5390 T1635 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@302a72fd main{StandardDirectoryReader(segments_2:3 _0(4.2):C1)}
[junit4:junit4]   2> 5390 T1634 oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused... core=collection1
[junit4:junit4]   2> 5390 T1634 oasu.DefaultSolrCoreState.newIndexWriter Closing old IndexWriter... core=collection1
[junit4:junit4]   2> 5391 T1634 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index
[junit4:junit4]   2> 5391 T1634 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data
[junit4:junit4]   2> 5395 T1634 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/index3857038594tmp lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1c1063a4; maxCacheMB=0.8935546875 maxMergeSizeMB=0.4619140625))),segFN=segments_2,generation=2,filenames=[_0_Lucene40_0.tim, _0.fnm, _0_Lucene40_0.frq, _0_nrm.cfe, segments_2, _0.fdx, _0_nrm.cfs, _0.si, _0.fdt, _0_Lucene40_0.tip]
[junit4:junit4]   2> 5395 T1634 oasc.SolrDeletionPolicy.updateCommits newest commit = 2[_0_Lucene40_0.tim, _0.fnm, _0_Lucene40_0.frq, _0_nrm.cfe, segments_2, _0.fdx, _0_nrm.cfs, _0.si, _0.fdt, _0_Lucene40_0.tip]
[junit4:junit4]   2> 5396 T1634 oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used.
[junit4:junit4]   2> 5396 T1634 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data
[junit4:junit4]   2> 5429 T1623 C97 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 5449 T1634 oass.SolrIndexSearcher.<init> Opening Searcher@6b933760 main
[junit4:junit4]   2> 5449 T1634 oasc.CoreContainer.registerCore replacing core: collection1
[junit4:junit4]   2> 5449 T1635 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6b933760 main{StandardDirectoryReader(segments_2:3:nrt _0(4.2):C1)}
[junit4:junit4]   2> 5449 T1634 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@3ea76cda
[junit4:junit4]   2> 5450 T1635 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index.20130228065947012
[junit4:junit4]   2> 5450 T1634 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0}
[junit4:junit4]   2> 5451 T1634 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 5451 T1634 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index
[junit4:junit4]   2> ASYNC  NEW_CORE C99 name=collection1 org.apache.solr.core.SolrCore@e18b6cd
[junit4:junit4]   2> 5538 T1623 C99 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=1 status=0 QTime=0 
[junit4:junit4]   2> 5643 T1623 C99 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=1 status=0 QTime=0 
[junit4:junit4]   2> 5748 T1623 C99 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[2000]} 0 2
[junit4:junit4]   2> 5751 T1623 C99 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   2> 5778 T1623 C99 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/index3857038594tmp lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1c1063a4; maxCacheMB=0.8935546875 maxMergeSizeMB=0.4619140625))),segFN=segments_2,generation=2,filenames=[_0_Lucene40_0.tim, _0.fnm, _0_Lucene40_0.frq, _0_nrm.cfe, segments_2, _0.fdx, _0_nrm.cfs, _0.si, _0.fdt, _0_Lucene40_0.tip]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/index3857038594tmp lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1c1063a4; maxCacheMB=0.8935546875 maxMergeSizeMB=0.4619140625))),segFN=segments_3,generation=3,filenames=[_1_Lucene40_0.tim, _1.fdx, _1_nrm.cfs, _1.fdt, _1.si, _1_Lucene40_0.frq, _1.fnm, segments_3, _1_Lucene40_0.tip, _1_nrm.cfe]
[junit4:junit4]   2> 5779 T1623 C99 oasc.SolrDeletionPolicy.updateCommits newest commit = 3[_1_Lucene40_0.tim, _1.fdx, _1_nrm.cfs, _1.fdt, _1.si, _1_Lucene40_0.frq, _1.fnm, segments_3, _1_Lucene40_0.tip, _1_nrm.cfe]
[junit4:junit4]   2> 5783 T1623 C99 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data
[junit4:junit4]   2> 5787 T1623 C99 oass.SolrIndexSearcher.<init> Opening Searcher@7119ce7e main
[junit4:junit4]   2> 5788 T1623 C99 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 5788 T1635 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7119ce7e main{StandardDirectoryReader(segments_3:7:nrt _1(4.2):C1)}
[junit4:junit4]   2> 5790 T1635 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index.20130228065947012
[junit4:junit4]   2> 5790 T1623 C99 UPDATE [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 39
[junit4:junit4]   2> 5793 T1623 C99 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=1 status=0 QTime=0 
[junit4:junit4]   2> 5895 T1585 oas.SolrTestCaseJ4.tearDown ###Ending doTestIndexAndConfigAliasReplication
[junit4:junit4]   2> 5896 T1585 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=464455355
[junit4:junit4]   2> 5897 T1585 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@74502ab7
[junit4:junit4]   2> 5897 T1585 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=1,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4:junit4]   2> 5898 T1585 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 5899 T1585 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 5899 T1585 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 5901 T1585 C98 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data/index
[junit4:junit4]   2> 5901 T1585 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 5902 T1585 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data/index
[junit4:junit4]   2> 5902 T1585 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data
[junit4:junit4]   2> 5903 T1585 oasc.CachingDirectoryFactory.closeDirectory Closing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data
[junit4:junit4]   2> 5903 T1585 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data/index
[junit4:junit4]   2> 5904 T1585 oasc.CachingDirectoryFactory.closeDirectory Closing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582041/master/collection1/data/index
[junit4:junit4]   2> 5904 T1585 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4]   2> 5957 T1585 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1234005540
[junit4:junit4]   2> 5958 T1585 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@e18b6cd
[junit4:junit4]   2> 5959 T1585 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=1,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4:junit4]   2> 5959 T1585 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 5960 T1585 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 5960 T1585 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 5961 T1585 C99 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index.20130228065947012
[junit4:junit4]   2> 5962 T1585 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 5963 T1585 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index.20130228065947012
[junit4:junit4]   2> 5963 T1585 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index.20130228065947012
[junit4:junit4]   2> 5963 T1585 oasc.CachingDirectoryFactory.closeDirectory Closing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index.20130228065947012
[junit4:junit4]   2> 5964 T1585 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data
[junit4:junit4]   2> 5964 T1585 oasc.CachingDirectoryFactory.closeDirectory Closing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data
[junit4:junit4]   2> 5965 T1585 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index
[junit4:junit4]   2> 5965 T1585 oasc.CachingDirectoryFactory.closeDirectory Closing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045582406/slave/collection1/data/index
[junit4:junit4]   2> 5966 T1585 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4]   2> 6033 T1585 oas.SolrTestCaseJ4.setUp ###Starting doTestBackup
[junit4:junit4]   2> 6045 T1585 oejs.Server.doStart jetty-8.1.8.v20121106
[junit4:junit4]   2> 6048 T1585 oejs.AbstractConnector.doStart Started SocketConnector@127.0.0.1:42849
[junit4:junit4]   2> 6049 T1585 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 6049 T1585 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 6050 T1585 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master
[junit4:junit4]   2> 6050 T1585 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/solr.xml
[junit4:junit4]   2> 6051 T1585 oasc.CoreContainer.<init> New CoreContainer 431807891
[junit4:junit4]   2> 6051 T1585 oasc.CoreContainer$Initializer.initialize no solr.xml file found - using default
[junit4:junit4]   2> 6052 T1585 oasc.CoreContainer.load Loading CoreContainer using Solr Home: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/'
[junit4:junit4]   2> 6052 T1585 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/'
[junit4:junit4]   2> 6110 T1585 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 6111 T1585 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 6111 T1585 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 6112 T1585 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 6112 T1585 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 6113 T1585 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 6113 T1585 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 6114 T1585 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 6114 T1585 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 6115 T1585 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 6135 T1585 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 6160 T1646 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/collection1
[junit4:junit4]   2> 6161 T1646 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/collection1/'
[junit4:junit4]   2> 6204 T1646 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_42
[junit4:junit4]   2> 6257 T1646 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 6258 T1646 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 6262 T1646 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 6285 T1646 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 6287 T1646 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/collection1/, dataDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/collection1/data/
[junit4:junit4]   2> 6287 T1646 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4:junit4]   2> 6288 T1646 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 6289 T1646 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/collection1/data forceNew:false
[junit4:junit4]   2> 6290 T1646 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/collection1/data
[junit4:junit4]   2> 6290 T1646 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/collection1/data/index/
[junit4:junit4]   2> 6291 T1646 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/collection1/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 6291 T1646 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/collection1/data/index forceNew:false
[junit4:junit4]   2> 6293 T1646 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@48b7ee22 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5b1794c4),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 6293 T1646 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 6293 T1646 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/collection1/data/index
[junit4:junit4]   2> 6294 T1646 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 6295 T1646 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 6295 T1646 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 6295 T1646 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 6295 T1646 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 6296 T1646 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 6314 T1646 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 6318 T1646 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/collection1/data
[junit4:junit4]   2> 6318 T1646 oass.SolrIndexSearcher.<init> Opening Searcher@1200edc5 main
[junit4:junit4]   2> 6319 T1646 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 6319 T1646 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 6319 T1646 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4:junit4]   2> 6320 T1646 oash.ReplicationHandler.inform Commits will be reserved for  10000
[junit4:junit4]   2> 6320 T1646 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 6320 T1647 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1200edc5 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 6320 T1585 oass.SolrDispatchFilter.init user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1
[junit4:junit4]   2> 6321 T1585 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 6322 T1585 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 6352 T1585 oejs.Server.doStart jetty-8.1.8.v20121106
[junit4:junit4]   2> 6357 T1585 oejs.AbstractConnector.doStart Started SocketConnector@127.0.0.1:42850
[junit4:junit4]   2> 6358 T1585 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 6358 T1585 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 6359 T1585 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588375/slave
[junit4:junit4]   2> 6360 T1585 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588375/slave/solr.xml
[junit4:junit4]   2> 6361 T1585 oasc.CoreContainer.<init> New CoreContainer 1774789117
[junit4:junit4]   2> 6362 T1585 oasc.CoreContainer$Initializer.initialize no solr.xml file found - using default
[junit4:junit4]   2> 6362 T1585 oasc.CoreContainer.load Loading CoreContainer using Solr Home: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588375/slave/'
[junit4:junit4]   2> 6363 T1585 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588375/slave/'
[junit4:junit4]   2> 6395 T1585 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 6396 T1585 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 6397 T1585 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 6398 T1585 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 6398 T1585 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 6399 T1585 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 6400 T1585 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 6401 T1585 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 6401 T1585 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 6402 T1585 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 6430 T1585 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 6469 T1657 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588375/slave/collection1
[junit4:junit4]   2> 6470 T1657 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588375/slave/collection1/'
[junit4:junit4]   2> 6519 T1657 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_42
[junit4:junit4]   2> 6579 T1657 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 6580 T1657 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 6584 T1657 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 6605 T1657 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 6607 T1657 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588375/slave/collection1/, dataDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588375/slave/collection1/data/
[junit4:junit4]   2> 6607 T1657 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4:junit4]   2> 6607 T1657 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 6609 T1657 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588375/slave/collection1/data forceNew:false
[junit4:junit4]   2> 6610 T1657 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588375/slave/collection1/data
[junit4:junit4]   2> 6610 T1657 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588375/slave/collection1/data/index/
[junit4:junit4]   2> 6611 T1657 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588375/slave/collection1/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 6611 T1657 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588375/slave/collection1/data/index forceNew:false
[junit4:junit4]   2> 6613 T1657 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@7f7b74a4 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4d82c213),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 6613 T1657 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 6613 T1657 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588375/slave/collection1/data/index
[junit4:junit4]   2> 6614 T1657 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 6615 T1657 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 6615 T1657 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 6615 T1657 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 6616 T1657 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 6616 T1657 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 6618 T1657 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 6622 T1657 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588375/slave/collection1/data
[junit4:junit4]   2> 6622 T1657 oass.SolrIndexSearcher.<init> Opening Searcher@78331f27 main
[junit4:junit4]   2> 6623 T1657 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 6623 T1657 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 6623 T1657 oash.SnapPuller.startExecutorService Poll Scheduled at an interval of 1000ms
[junit4:junit4]   2> 6624 T1657 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 6624 T1658 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@78331f27 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 6624 T1585 oass.SolrDispatchFilter.init user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1
[junit4:junit4]   2> 6625 T1585 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 6626 T1585 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 6644 T1585 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=431807891
[junit4:junit4]   2> 6645 T1585 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@785db77d
[junit4:junit4]   2> 6646 T1585 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:junit4]   2> 6647 T1585 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 6648 T1585 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 6649 T1585 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 6649 T1585 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 6650 T1585 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/collection1/data/index
[junit4:junit4]   2> 6651 T1585 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/collection1/data/index
[junit4:junit4]   2> 6652 T1585 oasc.CachingDirectoryFactory.closeDirectory Closing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/collection1/data/index
[junit4:junit4]   2> 6653 T1585 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/collection1/data
[junit4:junit4]   2> 6653 T1585 oasc.CachingDirectoryFactory.closeDirectory Closing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/collection1/data
[junit4:junit4]   2> 6654 T1585 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4]   2> 6712 T1585 oejs.Server.doStart jetty-8.1.8.v20121106
[junit4:junit4]   2> 6792 T1585 oejs.AbstractConnector.doStart Started SocketConnector@127.0.0.1:42851
[junit4:junit4]   2> 6793 T1585 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 6793 T1585 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 6794 T1585 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master
[junit4:junit4]   2> 6794 T1585 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/solr.xml
[junit4:junit4]   2> 6795 T1585 oasc.CoreContainer.<init> New CoreContainer 141942920
[junit4:junit4]   2> 6795 T1585 oasc.CoreContainer$Initializer.initialize no solr.xml file found - using default
[junit4:junit4]   2> 6795 T1585 oasc.CoreContainer.load Loading CoreContainer using Solr Home: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/'
[junit4:junit4]   2> 6796 T1585 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/'
[junit4:junit4]   2> 6818 T1585 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 6819 T1585 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 6819 T1585 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 6820 T1585 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 6820 T1585 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 6821 T1585 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 6821 T1585 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 6822 T1585 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 6822 T1585 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 6823 T1585 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 6840 T1585 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 6879 T1669 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/collection1
[junit4:junit4]   2> 6880 T1669 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/collection1/'
[junit4:junit4]   2> 6926 T1669 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_42
[junit4:junit4]   2> 6986 T1669 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 6986 T1669 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 6990 T1669 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 7011 T1669 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 7012 T1669 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/collection1/, dataDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/collection1/data/
[junit4:junit4]   2> 7013 T1669 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4:junit4]   2> 7013 T1669 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 7015 T1669 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/collection1/data forceNew:false
[junit4:junit4]   2> 7016 T1669 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/collection1/data
[junit4:junit4]   2> 7016 T1669 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/collection1/data/index/
[junit4:junit4]   2> 7016 T1669 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/collection1/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 7017 T1669 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/collection1/data/index forceNew:false
[junit4:junit4]   2> 7018 T1669 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@2b17b5a9 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@616b6449),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 7019 T1669 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 7019 T1669 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/collection1/data/index
[junit4:junit4]   2> 7020 T1669 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 7021 T1669 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 7021 T1669 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 7023 T1669 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 7027 T1669 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045588069/master/collection1/data
[junit4:junit4]   2> 7027 T1669 oass.SolrIndexSearcher.<init> Opening Searcher@a845241 main
[junit4:junit4]   2> 7028 T1669 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 7028 T1669 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 7028 T1669 oash.ReplicationHandler.inform Replication enabled for following config files: schema-replication2.xml:schema.xml
[junit4:junit4]   2> 7029 T1669 oash.ReplicationHandler.inform Commits will be reserved for  10000
[junit4:junit4]   2> 7029 T1669 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 7029 T1670 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@a845241 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 7029 T1585 oass.SolrDispatchFilter.init user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1
[junit4:junit4]   2> 7030 T1585 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 7030 T1585 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> ASYNC  NEW_CORE C100 name=collection1 org.apache.solr.core.SolrCore@67091d9a
[junit4:junit4]   2> 7049 T1662 C100 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4]   2> 7050 T1662 C100 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apach

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

cks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=492,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4:junit4]   2> 50688 T1585 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 50689 T1585 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 50689 T1585 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 50691 T1585 C123 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045630412/master/collection1/data/index
[junit4:junit4]   2> 50692 T1585 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 50692 T1585 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045630412/master/collection1/data/index
[junit4:junit4]   2> 50693 T1585 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045630412/master/collection1/data
[junit4:junit4]   2> 50693 T1585 oasc.CachingDirectoryFactory.closeDirectory Closing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045630412/master/collection1/data
[junit4:junit4]   2> 50694 T1585 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045630412/master/collection1/data/index
[junit4:junit4]   2> 50694 T1585 oasc.CachingDirectoryFactory.closeDirectory Closing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045630412/master/collection1/data/index
[junit4:junit4]   2> 50695 T1585 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4]   2> 50747 T1585 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1458244632
[junit4:junit4]   2> 50748 T1585 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@73ce6764
[junit4:junit4]   2> 50748 T1585 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=5,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=5,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4:junit4]   2> 50749 T1585 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 50750 T1585 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 50750 T1585 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 50752 T1585 C124 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045630701/slave/collection1/data/index
[junit4:junit4]   2> 50753 T1585 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 50753 T1585 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045630701/slave/collection1/data/index
[junit4:junit4]   2> 50754 T1585 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045630701/slave/collection1/data/index
[junit4:junit4]   2> 50754 T1585 oasc.CachingDirectoryFactory.closeDirectory Closing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045630701/slave/collection1/data/index
[junit4:junit4]   2> 50755 T1585 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045630701/slave/collection1/data
[junit4:junit4]   2> 50755 T1585 oasc.CachingDirectoryFactory.closeDirectory Closing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1362045630701/slave/collection1/data
[junit4:junit4]   2> 50756 T1585 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4]   2> 50817 T1585 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4:junit4]   2> 50821 T1584 ccr.ThreadLeakControl.checkThreadLeaks WARNING Will linger awaiting termination of 1 leaked thread(s).
[junit4:junit4]   2> 65688 T2009 oash.SnapPuller.fetchLatestIndex SEVERE Master at: http://127.0.0.1:50950/solr is not available. Index fetch failed. Exception: org.apache.solr.client.solrj.SolrServerException: IOException occured when talking to server at: http://127.0.0.1:50950/solr
[junit4:junit4]   2> 65689 T2009 oasc.SolrException.log SEVERE SnapPull failed :java.lang.RuntimeException: Already closed
[junit4:junit4]   2> 		at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:238)
[junit4:junit4]   2> 		at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:223)
[junit4:junit4]   2> 		at org.apache.solr.handler.ReplicationHandler.loadReplicationProperties(ReplicationHandler.java:771)
[junit4:junit4]   2> 		at org.apache.solr.handler.SnapPuller.logReplicationTimeAndConfFiles(SnapPuller.java:546)
[junit4:junit4]   2> 		at org.apache.solr.handler.SnapPuller.fetchLatestIndex(SnapPuller.java:491)
[junit4:junit4]   2> 		at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:281)
[junit4:junit4]   2> 		at org.apache.solr.handler.ReplicationHandler$1.run(ReplicationHandler.java:186)
[junit4:junit4]   2> 	
[junit4:junit4]   2> NOTE: test params are: codec=Lucene40, sim=DefaultSimilarity, locale=de, timezone=America/Paramaribo
[junit4:junit4]   2> NOTE: FreeBSD 9.0-RELEASE amd64/Oracle Corporation 1.7.0_09 (64-bit)/cpus=16,threads=1,free=309568248,total=530579456
[junit4:junit4]   2> NOTE: All tests run in this JVM: [SolrCoreTest, TestPluginEnable, StatsComponentTest, TestBinaryField, TestMultiCoreConfBootstrap, TestHashPartitioner, TestSolrDeletionPolicy2, BasicFunctionalityTest, TimeZoneUtilsTest, OutputWriterTest, PeerSyncTest, TestDocumentBuilder, DocumentAnalysisRequestHandlerTest, LegacyHTMLStripCharFilterTest, TestZkChroot, StandardRequestHandlerTest, SliceStateUpdateTest, ConvertedLegacyTest, DOMUtilTest, TestPostingsSolrHighlighter, SpellingQueryConverterTest, DistributedQueryElevationComponentTest, TestBM25SimilarityFactory, HardAutoCommitTest, MultiTermTest, TestAnalyzedSuggestions, TestPropInject, LeaderElectionTest, BadIndexSchemaTest, TestCodecSupport, ZkNodePropsTest, TestRTGBase, SolrIndexSplitterTest, PrimUtilsTest, TestArbitraryIndexDir, TestSurroundQueryParser, TestCharFilters, TestRealTimeGet, BasicZkTest, TestRemoteStreaming, SignatureUpdateProcessorFactoryTest, TestElisionMultitermQuery, DirectUpdateHandlerTest, RecoveryZkTest, TestUpdate, AnalysisAfterCoreReloadTest, UpdateParamsTest, TestQuerySenderListener, SchemaVersionSpecificBehaviorTest, RequiredFieldsTest, TestJmxIntegration, IndexSchemaTest, TestUtils, TestSolrJ, TestDFRSimilarityFactory, PrimitiveFieldTypeTest, XsltUpdateRequestHandlerTest, ReturnFieldsTest, URLClassifyProcessorTest, TestSort, TestMergePolicyConfig, DirectSolrSpellCheckerTest, TestReload, TestDistributedGrouping, SliceStateTest, OverseerTest, FullSolrCloudDistribCmdsTest, TestReplicationHandler]
[junit4:junit4] Completed on J1 in 65.95s, 10 tests, 1 failure <<< FAILURES!

[...truncated 486 lines...]
BUILD FAILED
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/build.xml:381: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/build.xml:361: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/build.xml:39: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build.xml:183: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/common-build.xml:447: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/lucene/common-build.xml:1202: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/lucene/common-build.xml:865: There were test failures: 258 suites, 1078 tests, 1 failure, 22 ignored (4 assumptions)

Total time: 47 minutes 22 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure



Mime
View raw message