lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Policeman Jenkins Server <jenk...@thetaphi.de>
Subject [JENKINS] Lucene-Solr-trunk-MacOSX (64bit/jdk1.7.0) - Build # 347 - Failure!
Date Fri, 22 Mar 2013 19:18:36 GMT
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-MacOSX/347/
Java: 64bit/jdk1.7.0 -XX:+UseSerialGC

2 tests failed.
REGRESSION:  org.apache.solr.core.OpenCloseCoreStressTest.test30SecondsNew

Error Message:
Core 00005_core bad! expected:<36> but was:<28>

Stack Trace:
java.lang.AssertionError: Core 00005_core bad! expected:<36> but was:<28>
	at __randomizedtesting.SeedInfo.seed([A6DEFEB4500D83AD:C26BE26002CD7AE8]: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:472)
	at org.apache.solr.core.OpenCloseCoreStressTest.checkResults(OpenCloseCoreStressTest.java:303)
	at org.apache.solr.core.OpenCloseCoreStressTest.doStress(OpenCloseCoreStressTest.java:201)
	at org.apache.solr.core.OpenCloseCoreStressTest.test30SecondsNew(OpenCloseCoreStressTest.java:121)
	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)


REGRESSION:  org.apache.solr.handler.TestReplicationHandler.doTestIndexAndConfigReplication

Error Message:
expected:<0> but was:<1363978014972>

Stack Trace:
java.lang.AssertionError: expected:<0> but was:<1363978014972>
	at __randomizedtesting.SeedInfo.seed([A6DEFEB4500D83AD:B296A5E1730A3EB3]: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.assertVersions(TestReplicationHandler.java:834)
	at org.apache.solr.handler.TestReplicationHandler.doTestIndexAndConfigReplication(TestReplicationHandler.java:461)
	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 9031 lines...]
[junit4:junit4] Suite: org.apache.solr.handler.TestReplicationHandler
[junit4:junit4]   2> 0 T1689 oas.SolrTestCaseJ4.startTrackingSearchers WARNING startTrackingSearchers: numOpens=2 numCloses=2
[junit4:junit4]   2> 14 T1689 oas.SolrTestCaseJ4.setUp ###Starting doTestIndexAndConfigReplication
[junit4:junit4]   2> 26 T1689 oejs.Server.doStart jetty-8.1.8.v20121106
[junit4:junit4]   2> 32 T1689 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:49733
[junit4:junit4]   2> 33 T1689 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 34 T1689 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 34 T1689 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master
[junit4:junit4]   2> 35 T1689 oasc.CoreContainer$Initializer.initialize looking for solr config file: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master/solr.xml
[junit4:junit4]   2> 35 T1689 oasc.CoreContainer.<init> New CoreContainer 681218845
[junit4:junit4]   2> 36 T1689 oasc.CoreContainer$Initializer.initialize no solr.xml or solr.properties file found - using default old-style solr.xml
[junit4:junit4]   2> 37 T1689 oasc.CoreContainer.load Loading CoreContainer using Solr Home: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master/'
[junit4:junit4]   2> 37 T1689 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master/'
[junit4:junit4]   2> 81 T1689 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 82 T1689 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 83 T1689 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 83 T1689 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 84 T1689 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 84 T1689 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 85 T1689 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 85 T1689 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 86 T1689 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 86 T1689 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 102 T1689 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 125 T1699 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master/collection1
[junit4:junit4]   2> 126 T1699 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master/collection1/'
[junit4:junit4]   2> 163 T1699 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 241 T1699 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 242 T1699 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 247 T1699 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 268 T1699 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 270 T1699 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 271 T1699 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master/collection1/, dataDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master/collection1/data/
[junit4:junit4]   2> 271 T1699 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4:junit4]   2> 271 T1699 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 272 T1699 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master/collection1/data
[junit4:junit4]   2> 272 T1699 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master/collection1/data/index/
[junit4:junit4]   2> 273 T1699 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master/collection1/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 273 T1699 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master/collection1/data/index
[junit4:junit4]   2> 275 T1699 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@5dcdbfbe lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@57ee1ab0),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 275 T1699 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 277 T1699 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 277 T1699 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 278 T1699 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 278 T1699 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 278 T1699 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 279 T1699 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 281 T1699 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 284 T1699 oass.SolrIndexSearcher.<init> Opening Searcher@44d93a51 main
[junit4:junit4]   2> 285 T1699 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 286 T1699 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 287 T1699 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4:junit4]   2> 287 T1699 oash.ReplicationHandler.inform Commits will be reserved for  10000
[junit4:junit4]   2> 287 T1699 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 287 T1700 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@44d93a51 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 288 T1689 oass.SolrDispatchFilter.init user.dir=/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0
[junit4:junit4]   2> 289 T1689 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 289 T1689 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 304 T1689 oejs.Server.doStart jetty-8.1.8.v20121106
[junit4:junit4]   2> 309 T1689 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:49734
[junit4:junit4]   2> 310 T1689 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 310 T1689 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 311 T1689 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave
[junit4:junit4]   2> 313 T1689 oasc.CoreContainer$Initializer.initialize looking for solr config file: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/solr.xml
[junit4:junit4]   2> 313 T1689 oasc.CoreContainer.<init> New CoreContainer 1081758436
[junit4:junit4]   2> 314 T1689 oasc.CoreContainer$Initializer.initialize no solr.xml or solr.properties file found - using default old-style solr.xml
[junit4:junit4]   2> 315 T1689 oasc.CoreContainer.load Loading CoreContainer using Solr Home: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/'
[junit4:junit4]   2> 315 T1689 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/'
[junit4:junit4]   2> 342 T1689 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 342 T1689 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 343 T1689 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 343 T1689 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 344 T1689 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 344 T1689 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 345 T1689 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 345 T1689 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 346 T1689 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 346 T1689 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 358 T1689 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 380 T1711 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1
[junit4:junit4]   2> 381 T1711 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1/'
[junit4:junit4]   2> 430 T1711 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 499 T1711 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 500 T1711 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 505 T1711 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 523 T1711 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 525 T1711 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 525 T1711 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1/, dataDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1/data/
[junit4:junit4]   2> 526 T1711 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4:junit4]   2> 526 T1711 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 527 T1711 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1/data
[junit4:junit4]   2> 527 T1711 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1/data/index/
[junit4:junit4]   2> 527 T1711 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 528 T1711 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1/data/index
[junit4:junit4]   2> 529 T1711 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@5a22ec40 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@430cb16),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 529 T1711 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 531 T1711 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 531 T1711 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 531 T1711 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 532 T1711 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 532 T1711 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 532 T1711 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 540 T1711 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 543 T1711 oass.SolrIndexSearcher.<init> Opening Searcher@1a5a2625 main
[junit4:junit4]   2> 543 T1711 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 544 T1711 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 547 T1711 oash.SnapPuller.startExecutorService Poll Scheduled at an interval of 1000ms
[junit4:junit4]   2> 547 T1711 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 547 T1712 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1a5a2625 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 548 T1689 oass.SolrDispatchFilter.init user.dir=/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0
[junit4:junit4]   2> 549 T1689 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 550 T1689 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> ASYNC  NEW_CORE C116 name=collection1 org.apache.solr.core.SolrCore@22744e65
[junit4:junit4]   2> 568 T1694 C116 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=1 
[junit4:junit4]   2> 574 T1695 C116 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@5dcdbfbe lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@57ee1ab0),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 575 T1695 C116 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 577 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0]} 0 5
[junit4:junit4]   2> 582 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1]} 0 1
[junit4:junit4]   2> 588 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[2]} 0 1
[junit4:junit4]   2> 596 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[3]} 0 1
[junit4:junit4]   2> 602 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[4]} 0 1
[junit4:junit4]   2> 607 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[5]} 0 0
[junit4:junit4]   2> 612 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[6]} 0 0
[junit4:junit4]   2> 616 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[7]} 0 0
[junit4:junit4]   2> 620 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[8]} 0 0
[junit4:junit4]   2> 624 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[9]} 0 1
[junit4:junit4]   2> 629 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[10]} 0 1
[junit4:junit4]   2> 634 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[11]} 0 0
[junit4:junit4]   2> 638 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[12]} 0 1
[junit4:junit4]   2> 643 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[13]} 0 0
[junit4:junit4]   2> 646 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[14]} 0 0
[junit4:junit4]   2> 649 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[15]} 0 0
[junit4:junit4]   2> 657 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[16]} 0 1
[junit4:junit4]   2> 663 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[17]} 0 0
[junit4:junit4]   2> 667 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[18]} 0 0
[junit4:junit4]   2> 672 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[19]} 0 0
[junit4:junit4]   2> 676 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[20]} 0 1
[junit4:junit4]   2> 679 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[21]} 0 0
[junit4:junit4]   2> 683 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[22]} 0 0
[junit4:junit4]   2> 687 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[23]} 0 1
[junit4:junit4]   2> 693 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[24]} 0 0
[junit4:junit4]   2> 698 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[25]} 0 1
[junit4:junit4]   2> 702 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[26]} 0 1
[junit4:junit4]   2> 708 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[27]} 0 1
[junit4:junit4]   2> 713 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[28]} 0 1
[junit4:junit4]   2> 717 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[29]} 0 1
[junit4:junit4]   2> 721 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[30]} 0 1
[junit4:junit4]   2> 725 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[31]} 0 1
[junit4:junit4]   2> 729 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[32]} 0 0
[junit4:junit4]   2> 733 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[33]} 0 0
[junit4:junit4]   2> 738 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[34]} 0 0
[junit4:junit4]   2> 744 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[35]} 0 0
[junit4:junit4]   2> 749 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[36]} 0 0
[junit4:junit4]   2> 753 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[37]} 0 0
[junit4:junit4]   2> 758 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[38]} 0 1
[junit4:junit4]   2> 762 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[39]} 0 1
[junit4:junit4]   2> 767 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[40]} 0 1
[junit4:junit4]   2> 771 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[41]} 0 1
[junit4:junit4]   2> 776 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[42]} 0 1
[junit4:junit4]   2> 780 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[43]} 0 1
[junit4:junit4]   2> 784 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[44]} 0 1
[junit4:junit4]   2> 789 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[45]} 0 1
[junit4:junit4]   2> 794 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[46]} 0 1
[junit4:junit4]   2> 798 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[47]} 0 1
[junit4:junit4]   2> 803 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[48]} 0 1
[junit4:junit4]   2> 808 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[49]} 0 1
[junit4:junit4]   2> 812 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[50]} 0 1
[junit4:junit4]   2> 817 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[51]} 0 1
[junit4:junit4]   2> 822 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[52]} 0 1
[junit4:junit4]   2> 826 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[53]} 0 1
[junit4:junit4]   2> 831 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[54]} 0 1
[junit4:junit4]   2> 836 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[55]} 0 1
[junit4:junit4]   2> 840 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[56]} 0 1
[junit4:junit4]   2> 844 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[57]} 0 0
[junit4:junit4]   2> 848 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[58]} 0 0
[junit4:junit4]   2> 853 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[59]} 0 1
[junit4:junit4]   2> 857 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[60]} 0 1
[junit4:junit4]   2> 861 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[61]} 0 1
[junit4:junit4]   2> 865 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[62]} 0 0
[junit4:junit4]   2> 869 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[63]} 0 1
[junit4:junit4]   2> 872 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[64]} 0 0
[junit4:junit4]   2> 876 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[65]} 0 0
[junit4:junit4]   2> 881 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[66]} 0 1
[junit4:junit4]   2> 888 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[67]} 0 1
[junit4:junit4]   2> 891 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[68]} 0 0
[junit4:junit4]   2> 895 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[69]} 0 0
[junit4:junit4]   2> 907 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[70]} 0 4
[junit4:junit4]   2> 910 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[71]} 0 0
[junit4:junit4]   2> 915 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[72]} 0 2
[junit4:junit4]   2> 919 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[73]} 0 0
[junit4:junit4]   2> 927 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[74]} 0 1
[junit4:junit4]   2> 937 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[75]} 0 1
[junit4:junit4]   2> 942 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[76]} 0 1
[junit4:junit4]   2> 947 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[77]} 0 1
[junit4:junit4]   2> 951 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[78]} 0 1
[junit4:junit4]   2> 956 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[79]} 0 1
[junit4:junit4]   2> 960 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[80]} 0 0
[junit4:junit4]   2> 965 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[81]} 0 1
[junit4:junit4]   2> 970 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[82]} 0 1
[junit4:junit4]   2> 974 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[83]} 0 0
[junit4:junit4]   2> 979 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[84]} 0 1
[junit4:junit4]   2> 984 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[85]} 0 1
[junit4:junit4]   2> 989 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[86]} 0 1
[junit4:junit4]   2> 993 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[87]} 0 0
[junit4:junit4]   2> 998 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[88]} 0 0
[junit4:junit4]   2> 1004 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[89]} 0 1
[junit4:junit4]   2> 1007 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[90]} 0 0
[junit4:junit4]   2> 1011 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[91]} 0 0
[junit4:junit4]   2> 1015 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[92]} 0 0
[junit4:junit4]   2> 1024 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[93]} 0 1
[junit4:junit4]   2> 1028 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[94]} 0 0
[junit4:junit4]   2> 1033 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[95]} 0 1
[junit4:junit4]   2> 1037 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[96]} 0 0
[junit4:junit4]   2> 1042 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[97]} 0 1
[junit4:junit4]   2> 1046 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[98]} 0 1
[junit4:junit4]   2> 1050 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[99]} 0 1
[junit4:junit4]   2> 1054 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[100]} 0 0
[junit4:junit4]   2> 1058 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[101]} 0 0
[junit4:junit4]   2> 1062 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[102]} 0 0
[junit4:junit4]   2> 1067 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[103]} 0 1
[junit4:junit4]   2> 1071 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[104]} 0 0
[junit4:junit4]   2> 1076 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[105]} 0 1
[junit4:junit4]   2> 1080 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[106]} 0 1
[junit4:junit4]   2> 1085 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[107]} 0 1
[junit4:junit4]   2> 1089 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[108]} 0 1
[junit4:junit4]   2> 1093 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[109]} 0 0
[junit4:junit4]   2> 1098 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[110]} 0 1
[junit4:junit4]   2> 1103 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[111]} 0 1
[junit4:junit4]   2> 1107 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[112]} 0 1
[junit4:junit4]   2> 1112 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[113]} 0 1
[junit4:junit4]   2> 1116 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[114]} 0 0
[junit4:junit4]   2> 1120 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[115]} 0 0
[junit4:junit4]   2> 1124 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[116]} 0 0
[junit4:junit4]   2> 1129 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[117]} 0 1
[junit4:junit4]   2> 1133 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[118]} 0 1
[junit4:junit4]   2> 1137 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[119]} 0 1
[junit4:junit4]   2> 1144 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[120]} 0 1
[junit4:junit4]   2> 1147 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[121]} 0 0
[junit4:junit4]   2> 1150 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[122]} 0 0
[junit4:junit4]   2> 1154 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[123]} 0 1
[junit4:junit4]   2> 1158 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[124]} 0 0
[junit4:junit4]   2> 1162 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[125]} 0 0
[junit4:junit4]   2> 1166 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[126]} 0 0
[junit4:junit4]   2> 1171 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[127]} 0 1
[junit4:junit4]   2> 1175 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[128]} 0 1
[junit4:junit4]   2> 1183 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[129]} 0 4
[junit4:junit4]   2> 1187 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[130]} 0 0
[junit4:junit4]   2> 1195 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[131]} 0 1
[junit4:junit4]   2> 1202 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[132]} 0 2
[junit4:junit4]   2> 1209 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[133]} 0 1
[junit4:junit4]   2> 1214 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[134]} 0 1
[junit4:junit4]   2> 1220 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[135]} 0 0
[junit4:junit4]   2> 1224 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[136]} 0 0
[junit4:junit4]   2> 1230 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[137]} 0 0
[junit4:junit4]   2> 1236 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[138]} 0 0
[junit4:junit4]   2> 1241 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[139]} 0 1
[junit4:junit4]   2> 1246 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[140]} 0 1
[junit4:junit4]   2> 1251 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[141]} 0 0
[junit4:junit4]   2> 1258 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[142]} 0 0
[junit4:junit4]   2> 1263 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[143]} 0 1
[junit4:junit4]   2> 1268 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[144]} 0 1
[junit4:junit4]   2> 1273 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[145]} 0 0
[junit4:junit4]   2> 1277 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[146]} 0 1
[junit4:junit4]   2> 1282 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[147]} 0 0
[junit4:junit4]   2> 1286 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[148]} 0 1
[junit4:junit4]   2> 1291 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[149]} 0 1
[junit4:junit4]   2> 1295 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[150]} 0 1
[junit4:junit4]   2> 1300 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[151]} 0 1
[junit4:junit4]   2> 1304 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[152]} 0 1
[junit4:junit4]   2> 1309 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[153]} 0 0
[junit4:junit4]   2> 1314 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[154]} 0 1
[junit4:junit4]   2> 1318 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[155]} 0 1
[junit4:junit4]   2> 1322 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[156]} 0 0
[junit4:junit4]   2> 1327 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[157]} 0 1
[junit4:junit4]   2> 1332 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[158]} 0 1
[junit4:junit4]   2> 1336 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[159]} 0 1
[junit4:junit4]   2> 1340 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[160]} 0 1
[junit4:junit4]   2> 1344 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[161]} 0 0
[junit4:junit4]   2> 1349 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[162]} 0 1
[junit4:junit4]   2> 1353 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[163]} 0 1
[junit4:junit4]   2> 1357 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[164]} 0 0
[junit4:junit4]   2> 1362 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[165]} 0 0
[junit4:junit4]   2> 1367 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[166]} 0 0
[junit4:junit4]   2> 1377 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[167]} 0 1
[junit4:junit4]   2> 1381 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[168]} 0 0
[junit4:junit4]   2> 1386 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[169]} 0 1
[junit4:junit4]   2> 1390 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[170]} 0 1
[junit4:junit4]   2> 1394 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[171]} 0 0
[junit4:junit4]   2> 1399 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[172]} 0 1
[junit4:junit4]   2> 1403 T1696 C116 REQ [collection1] webapp=/solr path=/replication params={command=indexversion&qt=/replication&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 1405 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[173]} 0 0
[junit4:junit4]   2> 1410 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[174]} 0 1
[junit4:junit4]   2> 1414 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[175]} 0 1
[junit4:junit4]   2> 1418 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[176]} 0 1
[junit4:junit4]   2> 1422 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[177]} 0 1
[junit4:junit4]   2> 1426 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[178]} 0 1
[junit4:junit4]   2> 1431 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[179]} 0 1
[junit4:junit4]   2> 1435 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[180]} 0 0
[junit4:junit4]   2> 1440 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[181]} 0 1
[junit4:junit4]   2> 1444 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[182]} 0 0
[junit4:junit4]   2> 1449 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[183]} 0 1
[junit4:junit4]   2> 1453 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[184]} 0 1
[junit4:junit4]   2> 1457 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[185]} 0 1
[junit4:junit4]   2> 1462 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[186]} 0 1
[junit4:junit4]   2> 1467 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[187]} 0 1
[junit4:junit4]   2> 1471 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[188]} 0 1
[junit4:junit4]   2> 1476 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[189]} 0 1
[junit4:junit4]   2> 1481 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[190]} 0 1
[junit4:junit4]   2> 1486 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[191]} 0 0
[junit4:junit4]   2> 1492 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[192]} 0 1
[junit4:junit4]   2> 1496 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[193]} 0 0
[junit4:junit4]   2> 1501 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[194]} 0 0
[junit4:junit4]   2> 1506 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[195]} 0 1
[junit4:junit4]   2> 1513 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[196]} 0 0
[junit4:junit4]   2> 1517 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[197]} 0 0
[junit4:junit4]   2> 1521 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[198]} 0 0
[junit4:junit4]   2> 1532 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[199]} 0 3
[junit4:junit4]   2> 1536 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[200]} 0 0
[junit4:junit4]   2> 1540 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[201]} 0 0
[junit4:junit4]   2> 1545 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[202]} 0 1
[junit4:junit4]   2> 1549 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[203]} 0 0
[junit4:junit4]   2> 1554 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[204]} 0 0
[junit4:junit4]   2> 1560 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[205]} 0 1
[junit4:junit4]   2> 1566 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[206]} 0 2
[junit4:junit4]   2> 1570 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[207]} 0 1
[junit4:junit4]   2> 1574 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[208]} 0 1
[junit4:junit4]   2> 1578 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[209]} 0 0
[junit4:junit4]   2> 1582 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[210]} 0 1
[junit4:junit4]   2> 1584 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[211]} 0 0
[junit4:junit4]   2> 1587 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[212]} 0 0
[junit4:junit4]   2> 1591 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[213]} 0 0
[junit4:junit4]   2> 1594 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[214]} 0 0
[junit4:junit4]   2> 1599 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[215]} 0 1
[junit4:junit4]   2> 1604 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[216]} 0 0
[junit4:junit4]   2> 1607 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[217]} 0 0
[junit4:junit4]   2> 1610 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[218]} 0 0
[junit4:junit4]   2> 1614 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[219]} 0 1
[junit4:junit4]   2> 1621 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[220]} 0 0
[junit4:junit4]   2> 1626 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[221]} 0 0
[junit4:junit4]   2> 1630 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[222]} 0 0
[junit4:junit4]   2> 1634 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[223]} 0 1
[junit4:junit4]   2> 1640 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[224]} 0 1
[junit4:junit4]   2> 1646 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[225]} 0 0
[junit4:junit4]   2> 1651 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[226]} 0 0
[junit4:junit4]   2> 1656 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[227]} 0 1
[junit4:junit4]   2> 1659 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[228]} 0 0
[junit4:junit4]   2> 1663 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[229]} 0 1
[junit4:junit4]   2> 1670 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[230]} 0 1
[junit4:junit4]   2> 1675 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[231]} 0 1
[junit4:junit4]   2> 1686 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[232]} 0 1
[junit4:junit4]   2> 1693 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[233]} 0 0
[junit4:junit4]   2> 1698 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[234]} 0 1
[junit4:junit4]   2> 1703 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[235]} 0 1
[junit4:junit4]   2> 1708 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[236]} 0 0
[junit4:junit4]   2> 1714 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[237]} 0 1
[junit4:junit4]   2> 1718 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[238]} 0 0
[junit4:junit4]   2> 1723 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[239]} 0 1
[junit4:junit4]   2> 1727 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[240]} 0 0
[junit4:junit4]   2> 1732 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[241]} 0 1
[junit4:junit4]   2> 1739 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[242]} 0 1
[junit4:junit4]   2> 1743 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[243]} 0 1
[junit4:junit4]   2> 1747 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[244]} 0 1
[junit4:junit4]   2> 1752 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[245]} 0 1
[junit4:junit4]   2> 1756 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[246]} 0 0
[junit4:junit4]   2> 1761 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[247]} 0 1
[junit4:junit4]   2> 1766 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[248]} 0 1
[junit4:junit4]   2> 1771 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[249]} 0 0
[junit4:junit4]   2> 1776 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[250]} 0 1
[junit4:junit4]   2> 1780 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[251]} 0 0
[junit4:junit4]   2> 1785 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[252]} 0 1
[junit4:junit4]   2> 1789 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[253]} 0 0
[junit4:junit4]   2> 1794 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[254]} 0 1
[junit4:junit4]   2> 1799 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[255]} 0 1
[junit4:junit4]   2> 1803 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[256]} 0 0
[junit4:junit4]   2> 1808 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[257]} 0 1
[junit4:junit4]   2> 1815 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[258]} 0 1
[junit4:junit4]   2> 1819 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[259]} 0 1
[junit4:junit4]   2> 1823 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[260]} 0 0
[junit4:junit4]   2> 1828 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[261]} 0 1
[junit4:junit4]   2> 1833 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[262]} 0 0
[junit4:junit4]   2> 1837 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[263]} 0 1
[junit4:junit4]   2> 1841 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[264]} 0 0
[junit4:junit4]   2> 1845 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[265]} 0 0
[junit4:junit4]   2> 1849 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[266]} 0 1
[junit4:junit4]   2> 1853 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[267]} 0 0
[junit4:junit4]   2> 1857 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[268]} 0 0
[junit4:junit4]   2> 1862 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[269]} 0 0
[junit4:junit4]   2> 1866 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[270]} 0 0
[junit4:junit4]   2> 1870 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[271]} 0 0
[junit4:junit4]   2> 1874 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[272]} 0 1
[junit4:junit4]   2> 1878 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[273]} 0 1
[junit4:junit4]   2> 1884 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[274]} 0 1
[junit4:junit4]   2> 1889 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[275]} 0 1
[junit4:junit4]   2> 1893 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[276]} 0 1
[junit4:junit4]   2> 1897 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[277]} 0 0
[junit4:junit4]   2> 1901 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[278]} 0 0
[junit4:junit4]   2> 1906 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[279]} 0 1
[junit4:junit4]   2> 1910 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[280]} 0 0
[junit4:junit4]   2> 1915 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[281]} 0 1
[junit4:junit4]   2> 1919 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[282]} 0 0
[junit4:junit4]   2> 1924 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[283]} 0 1
[junit4:junit4]   2> 1928 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[284]} 0 1
[junit4:junit4]   2> 1932 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[285]} 0 1
[junit4:junit4]   2> 1936 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[286]} 0 1
[junit4:junit4]   2> 1940 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[287]} 0 0
[junit4:junit4]   2> 1944 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[288]} 0 0
[junit4:junit4]   2> 1949 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[289]} 0 1
[junit4:junit4]   2> 1953 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[290]} 0 0
[junit4:junit4]   2> 1957 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[291]} 0 0
[junit4:junit4]   2> 1962 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[292]} 0 1
[junit4:junit4]   2> 1965 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[293]} 0 0
[junit4:junit4]   2> 1970 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[294]} 0 1
[junit4:junit4]   2> 1975 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[295]} 0 0
[junit4:junit4]   2> 1979 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[296]} 0 0
[junit4:junit4]   2> 1983 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[297]} 0 1
[junit4:junit4]   2> 1987 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[298]} 0 1
[junit4:junit4]   2> 1991 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[299]} 0 1
[junit4:junit4]   2> 1995 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[300]} 0 1
[junit4:junit4]   2> 1999 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[301]} 0 1
[junit4:junit4]   2> 2004 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[302]} 0 1
[junit4:junit4]   2> 2010 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[303]} 0 1
[junit4:junit4]   2> 2014 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[304]} 0 1
[junit4:junit4]   2> 2018 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[305]} 0 1
[junit4:junit4]   2> 2023 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[306]} 0 1
[junit4:junit4]   2> 2027 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[307]} 0 0
[junit4:junit4]   2> 2031 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[308]} 0 1
[junit4:junit4]   2> 2035 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[309]} 0 1
[junit4:junit4]   2> 2039 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[310]} 0 0
[junit4:junit4]   2> 2044 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[311]} 0 1
[junit4:junit4]   2> 2057 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[312]} 0 1
[junit4:junit4]   2> 2062 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[313]} 0 1
[junit4:junit4]   2> 2066 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[314]} 0 0
[junit4:junit4]   2> 2070 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[315]} 0 0
[junit4:junit4]   2> 2075 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[316]} 0 1
[junit4:junit4]   2> 2079 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[317]} 0 1
[junit4:junit4]   2> 2084 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[318]} 0 1
[junit4:junit4]   2> 2089 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[319]} 0 1
[junit4:junit4]   2> 2093 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[320]} 0 0
[junit4:junit4]   2> 2098 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[321]} 0 1
[junit4:junit4]   2> 2102 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[322]} 0 1
[junit4:junit4]   2> 2107 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[323]} 0 1
[junit4:junit4]   2> 2111 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[324]} 0 1
[junit4:junit4]   2> 2115 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[325]} 0 1
[junit4:junit4]   2> 2119 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[326]} 0 1
[junit4:junit4]   2> 2123 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[327]} 0 1
[junit4:junit4]   2> 2128 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[328]} 0 1
[junit4:junit4]   2> 2138 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[329]} 0 1
[junit4:junit4]   2> 2143 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[330]} 0 0
[junit4:junit4]   2> 2146 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[331]} 0 0
[junit4:junit4]   2> 2150 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[332]} 0 0
[junit4:junit4]   2> 2155 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[333]} 0 1
[junit4:junit4]   2> 2159 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[334]} 0 1
[junit4:junit4]   2> 2163 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[335]} 0 1
[junit4:junit4]   2> 2167 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[336]} 0 1
[junit4:junit4]   2> 2171 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[337]} 0 0
[junit4:junit4]   2> 2175 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[338]} 0 0
[junit4:junit4]   2> 2179 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[339]} 0 0
[junit4:junit4]   2> 2183 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[340]} 0 0
[junit4:junit4]   2> 2188 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[341]} 0 0
[junit4:junit4]   2> 2195 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[342]} 0 1
[junit4:junit4]   2> 2199 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[343]} 0 1
[junit4:junit4]   2> 2203 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[344]} 0 0
[junit4:junit4]   2> 2208 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[345]} 0 1
[junit4:junit4]   2> 2213 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[346]} 0 1
[junit4:junit4]   2> 2228 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[347]} 0 1
[junit4:junit4]   2> 2237 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[348]} 0 1
[junit4:junit4]   2> 2245 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[349]} 0 1
[junit4:junit4]   2> 2249 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[350]} 0 1
[junit4:junit4]   2> 2254 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[351]} 0 1
[junit4:junit4]   2> 2259 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[352]} 0 1
[junit4:junit4]   2> 2263 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[353]} 0 0
[junit4:junit4]   2> 2267 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[354]} 0 0
[junit4:junit4]   2> 2272 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[355]} 0 1
[junit4:junit4]   2> 2281 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[356]} 0 1
[junit4:junit4]   2> 2285 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[357]} 0 1
[junit4:junit4]   2> 2289 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[358]} 0 1
[junit4:junit4]   2> 2293 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[359]} 0 0
[junit4:junit4]   2> 2297 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[360]} 0 0
[junit4:junit4]   2> 2301 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[361]} 0 0
[junit4:junit4]   2> 2305 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[362]} 0 1
[junit4:junit4]   2> 2308 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[363]} 0 0
[junit4:junit4]   2> 2312 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[364]} 0 1
[junit4:junit4]   2> 2315 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[365]} 0 0
[junit4:junit4]   2> 2319 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[366]} 0 1
[junit4:junit4]   2> 2323 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[367]} 0 1
[junit4:junit4]   2> 2326 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[368]} 0 0
[junit4:junit4]   2> 2330 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[369]} 0 1
[junit4:junit4]   2> 2334 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[370]} 0 0
[junit4:junit4]   2> 2337 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[371]} 0 0
[junit4:junit4]   2> 2341 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[372]} 0 1
[junit4:junit4]   2> 2345 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[373]} 0 1
[junit4:junit4]   2> 2348 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[374]} 0 0
[junit4:junit4]   2> 2354 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[375]} 0 1
[junit4:junit4]   2> 2363 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[376]} 0 0
[junit4:junit4]   2> 2380 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[377]} 0 1
[junit4:junit4]   2> 2390 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[378]} 0 1
[junit4:junit4]   2> 2398 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[379]} 0 0
[junit4:junit4]   2> 2402 T1696 C116 REQ [collection1] webapp=/solr path=/replication params={command=indexversion&qt=/replication&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 2405 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[380]} 0 1
[junit4:junit4]   2> 2409 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[381]} 0 1
[junit4:junit4]   2> 2413 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[382]} 0 1
[junit4:junit4]   2> 2417 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[383]} 0 1
[junit4:junit4]   2> 2424 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[384]} 0 1
[junit4:junit4]   2> 2430 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[385]} 0 1
[junit4:junit4]   2> 2435 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[386]} 0 1
[junit4:junit4]   2> 2439 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[387]} 0 1
[junit4:junit4]   2> 2443 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[388]} 0 1
[junit4:junit4]   2> 2447 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[389]} 0 1
[junit4:junit4]   2> 2453 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[390]} 0 1
[junit4:junit4]   2> 2457 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[391]} 0 1
[junit4:junit4]   2> 2462 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[392]} 0 0
[junit4:junit4]   2> 2467 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[393]} 0 1
[junit4:junit4]   2> 2476 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[394]} 0 0
[junit4:junit4]   2> 2480 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[395]} 0 0
[junit4:junit4]   2> 2484 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[396]} 0 0
[junit4:junit4]   2> 2491 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[397]} 0 2
[junit4:junit4]   2> 2496 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[398]} 0 1
[junit4:junit4]   2> 2504 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[399]} 0 5
[junit4:junit4]   2> 2508 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[400]} 0 0
[junit4:junit4]   2> 2517 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[401]} 0 4
[junit4:junit4]   2> 2522 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[402]} 0 1
[junit4:junit4]   2> 2530 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[403]} 0 1
[junit4:junit4]   2> 2542 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[404]} 0 1
[junit4:junit4]   2> 2546 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[405]} 0 1
[junit4:junit4]   2> 2550 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[406]} 0 1
[junit4:junit4]   2> 2555 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[407]} 0 2
[junit4:junit4]   2> 2558 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[408]} 0 0
[junit4:junit4]   2> 2562 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[409]} 0 0
[junit4:junit4]   2> 2566 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[410]} 0 0
[junit4:junit4]   2> 2570 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[411]} 0 0
[junit4:junit4]   2> 2574 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[412]} 0 0
[junit4:junit4]   2> 2578 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[413]} 0 1
[junit4:junit4]   2> 2582 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[414]} 0 1
[junit4:junit4]   2> 2586 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[415]} 0 1
[junit4:junit4]   2> 2590 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[416]} 0 0
[junit4:junit4]   2> 2595 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[417]} 0 0
[junit4:junit4]   2> 2599 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[418]} 0 0
[junit4:junit4]   2> 2604 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[419]} 0 1
[junit4:junit4]   2> 2607 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[420]} 0 0
[junit4:junit4]   2> 2612 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[421]} 0 1
[junit4:junit4]   2> 2616 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[422]} 0 1
[junit4:junit4]   2> 2620 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[423]} 0 1
[junit4:junit4]   2> 2624 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[424]} 0 1
[junit4:junit4]   2> 2628 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[425]} 0 0
[junit4:junit4]   2> 2632 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[426]} 0 0
[junit4:junit4]   2> 2636 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[427]} 0 0
[junit4:junit4]   2> 2641 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[428]} 0 1
[junit4:junit4]   2> 2645 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[429]} 0 1
[junit4:junit4]   2> 2649 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[430]} 0 0
[junit4:junit4]   2> 2653 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[431]} 0 0
[junit4:junit4]   2> 2657 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[432]} 0 0
[junit4:junit4]   2> 2661 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[433]} 0 0
[junit4:junit4]   2> 2673 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[434]} 0 8
[junit4:junit4]   2> 2678 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[435]} 0 1
[junit4:junit4]   2> 2682 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[436]} 0 1
[junit4:junit4]   2> 2686 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[437]} 0 0
[junit4:junit4]   2> 2695 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[438]} 0 1
[junit4:junit4]   2> 2698 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[439]} 0 0
[junit4:junit4]   2> 2702 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[440]} 0 0
[junit4:junit4]   2> 2709 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[441]} 0 1
[junit4:junit4]   2> 2713 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[442]} 0 1
[junit4:junit4]   2> 2717 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[443]} 0 1
[junit4:junit4]   2> 2720 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[444]} 0 0
[junit4:junit4]   2> 2724 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[445]} 0 1
[junit4:junit4]   2> 2728 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[446]} 0 1
[junit4:junit4]   2> 2732 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[447]} 0 1
[junit4:junit4]   2> 2739 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[448]} 0 1
[junit4:junit4]   2> 2744 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[449]} 0 1
[junit4:junit4]   2> 2749 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[450]} 0 1
[junit4:junit4]   2> 2759 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[451]} 0 0
[junit4:junit4]   2> 2765 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[452]} 0 1
[junit4:junit4]   2> 2768 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[453]} 0 0
[junit4:junit4]   2> 2773 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[454]} 0 1
[junit4:junit4]   2> 2776 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[455]} 0 0
[junit4:junit4]   2> 2781 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[456]} 0 0
[junit4:junit4]   2> 2787 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[457]} 0 1
[junit4:junit4]   2> 2791 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[458]} 0 1
[junit4:junit4]   2> 2794 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[459]} 0 0
[junit4:junit4]   2> 2805 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[460]} 0 1
[junit4:junit4]   2> 2818 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[461]} 0 0
[junit4:junit4]   2> 2823 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[462]} 0 1
[junit4:junit4]   2> 2828 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[463]} 0 1
[junit4:junit4]   2> 2832 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[464]} 0 0
[junit4:junit4]   2> 2837 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[465]} 0 1
[junit4:junit4]   2> 2841 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[466]} 0 1
[junit4:junit4]   2> 2845 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[467]} 0 1
[junit4:junit4]   2> 2849 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[468]} 0 1
[junit4:junit4]   2> 2853 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[469]} 0 1
[junit4:junit4]   2> 2857 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[470]} 0 1
[junit4:junit4]   2> 2861 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[471]} 0 1
[junit4:junit4]   2> 2865 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[472]} 0 0
[junit4:junit4]   2> 2870 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[473]} 0 0
[junit4:junit4]   2> 2874 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[474]} 0 1
[junit4:junit4]   2> 2878 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[475]} 0 1
[junit4:junit4]   2> 2883 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[476]} 0 0
[junit4:junit4]   2> 2888 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[477]} 0 1
[junit4:junit4]   2> 2891 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[478]} 0 0
[junit4:junit4]   2> 2895 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[479]} 0 1
[junit4:junit4]   2> 2898 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[480]} 0 0
[junit4:junit4]   2> 2904 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[481]} 0 0
[junit4:junit4]   2> 2908 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[482]} 0 1
[junit4:junit4]   2> 2911 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[483]} 0 0
[junit4:junit4]   2> 2915 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[484]} 0 1
[junit4:junit4]   2> 2918 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[485]} 0 0
[junit4:junit4]   2> 2922 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[486]} 0 1
[junit4:junit4]   2> 2925 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[487]} 0 0
[junit4:junit4]   2> 2929 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[488]} 0 1
[junit4:junit4]   2> 2932 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[489]} 0 0
[junit4:junit4]   2> 2939 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[490]} 0 1
[junit4:junit4]   2> 2943 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[491]} 0 1
[junit4:junit4]   2> 2946 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[492]} 0 0
[junit4:junit4]   2> 2949 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[493]} 0 0
[junit4:junit4]   2> 2953 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[494]} 0 0
[junit4:junit4]   2> 2959 T1694 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[495]} 0 1
[junit4:junit4]   2> 2962 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[496]} 0 0
[junit4:junit4]   2> 2967 T1696 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[497]} 0 1
[junit4:junit4]   2> 2970 T1692 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[498]} 0 0
[junit4:junit4]   2> 2973 T1697 C116 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   2> 2986 T1697 C116 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@5dcdbfbe lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@57ee1ab0),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@5dcdbfbe lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@57ee1ab0),segFN=segments_2,generation=2,filenames=[_0.fnm, _0_Lucene41_0.doc, _0.nvd, segments_2, _0.fdx, _0.si, _0.nvm, _0_Lucene41_0.tim, _0.fdt, _0_Lucene41_0.tip]
[junit4:junit4]   2> 2987 T1697 C116 oasc.SolrDeletionPolicy.updateCommits newest commit = 2[_0.fnm, _0_Lucene41_0.doc, _0.nvd, segments_2, _0.fdx, _0.si, _0.nvm, _0_Lucene41_0.tim, _0.fdt, _0_Lucene41_0.tip]
[junit4:junit4]   2> 2993 T1697 C116 oass.SolrIndexSearcher.<init> Opening Searcher@2b6f4583 main
[junit4:junit4]   2> 2994 T1697 C116 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 2995 T1700 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2b6f4583 main{StandardDirectoryReader(segments_2:3 _0(5.0):C499)}
[junit4:junit4]   2> 2995 T1697 C116 UPDATE [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 22
[junit4:junit4]   2> 2996 T1689 oash.TestReplicationHandler.rQuery Waiting for 499 docs
[junit4:junit4]   2> 3001 T1693 C116 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=499 status=0 QTime=1 
[junit4:junit4]   2> 3103 T1689 oash.TestReplicationHandler.rQuery Waiting for 499 docs
[junit4:junit4]   2> ASYNC  NEW_CORE C117 name=collection1 org.apache.solr.core.SolrCore@727b65b4
[junit4:junit4]   2> 3113 T1710 C117 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=1 
[junit4:junit4]   2> 3216 T1689 oash.TestReplicationHandler.rQuery Waiting for 499 docs
[junit4:junit4]   2> 3219 T1705 C117 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 3322 T1689 oash.TestReplicationHandler.rQuery Waiting for 499 docs
[junit4:junit4]   2> 3326 T1707 C117 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 3401 T1694 C116 REQ [collection1] webapp=/solr path=/replication params={command=indexversion&qt=/replication&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 3402 T1713 oash.SnapPuller.fetchLatestIndex Master's generation: 2
[junit4:junit4]   2> 3402 T1713 oash.SnapPuller.fetchLatestIndex Slave's generation: 1
[junit4:junit4]   2> 3402 T1713 oash.SnapPuller.fetchLatestIndex Starting replication process
[junit4:junit4]   2> 3416 T1696 C116 REQ [collection1] webapp=/solr path=/replication params={command=filelist&qt=/replication&wt=javabin&generation=2&version=2} status=0 QTime=7 
[junit4:junit4]   2> 3417 T1713 oash.SnapPuller.fetchLatestIndex Number of files in latest index in master: 10
[junit4:junit4]   2> 3418 T1713 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1/data/index.20130322094654021
[junit4:junit4]   2> 3418 T1713 oash.SnapPuller.fetchLatestIndex Starting download to MockDirWrapper(org.apache.lucene.store.RAMDirectory@4e0b6a9b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@63130f0d) fullCopy=false
[junit4:junit4]   2> 3422 T1692 C116 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> 3427 T1689 oash.TestReplicationHandler.rQuery Waiting for 499 docs
[junit4:junit4]   2> 3428 T1697 C116 REQ [collection1] webapp=/solr path=/replication params={file=_0_Lucene41_0.doc&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0 
[junit4:junit4]   2> 3430 T1708 C117 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 3434 T1693 C116 REQ [collection1] webapp=/solr path=/replication params={file=_0.nvd&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=1 
[junit4:junit4]   2> 3438 T1695 C116 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> 3455 T1694 C116 REQ [collection1] webapp=/solr path=/replication params={file=_0.fdx&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=1 
[junit4:junit4]   2> 3460 T1696 C116 REQ [collection1] webapp=/solr path=/replication params={file=_0.nvm&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=1 
[junit4:junit4]   2> 3469 T1692 C116 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> 3474 T1697 C116 REQ [collection1] webapp=/solr path=/replication params={file=_0_Lucene41_0.tim&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=1 
[junit4:junit4]   2> 3480 T1693 C116 REQ [collection1] webapp=/solr path=/replication params={file=_0_Lucene41_0.tip&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0 
[junit4:junit4]   2> 3488 T503 oasc.OverseerCollectionProcessor.run WARNING Overseer cannot talk to ZK
[junit4:junit4]   2> 3490 T1695 C116 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> 3492 T1713 oash.SnapPuller.fetchLatestIndex Total time taken for download : 0 secs
[junit4:junit4]   2> 3496 T1713 oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter...
[junit4:junit4]   2> 3497 T1713 oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused... core=collection1
[junit4:junit4]   2> 3499 T1713 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@5a22ec40 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@430cb16),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@5a22ec40 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@430cb16),segFN=segments_2,generation=2,filenames=[_0.fnm, _0_Lucene41_0.doc, _0.nvd, segments_2, _0.fdx, _0.nvm, _0.si, _0_Lucene41_0.tim, _0_Lucene41_0.tip, _0.fdt]
[junit4:junit4]   2> 3500 T1713 oasc.SolrDeletionPolicy.updateCommits newest commit = 2[_0.fnm, _0_Lucene41_0.doc, _0.nvd, segments_2, _0.fdx, _0.nvm, _0.si, _0_Lucene41_0.tim, _0_Lucene41_0.tip, _0.fdt]
[junit4:junit4]   2> 3500 T1713 oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used.
[junit4:junit4]   2> 3501 T1713 oass.SolrIndexSearcher.<init> Opening Searcher@1f5e5495 main
[junit4:junit4]   2> 3502 T1712 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1f5e5495 main{StandardDirectoryReader(segments_2:3:nrt _0(5.0):C499)}
[junit4:junit4]   2> 3537 T1689 oash.TestReplicationHandler.rQuery Waiting for 499 docs
[junit4:junit4]   2> 3545 T1709 C117 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=499 status=0 QTime=1 
[junit4:junit4]   2> 3653 T1694 C116 REQ [collection1] webapp=/solr path=/replication params={command=details&wt=javabin&qt=/replication&version=2} status=0 QTime=1 
[junit4:junit4]   2> 3659 T1696 C116 REQ [collection1] webapp=/solr path=/replication params={command=details&wt=javabin&qt=/replication&version=2} status=0 QTime=0 
[junit4:junit4]   2> 3670 T1692 C116 REQ [collection1] webapp=/solr path=/replication params={slave=false&command=details&wt=javabin&qt=/replication&version=2} status=0 QTime=1 
[junit4:junit4]   2> 3671 T1710 C117 REQ [collection1] webapp=/solr path=/replication params={command=details&wt=javabin&qt=/replication&version=2} status=0 QTime=9 
[junit4:junit4]   2> 3674 T1697 C116 REQ [collection1] webapp=/solr path=/replication params={command=indexversion&wt=javabin&qt=/replication&version=2} status=0 QTime=0 
[junit4:junit4]   2> 3678 T1705 C117 REQ [collection1] webapp=/solr path=/replication params={command=indexversion&wt=javabin&qt=/replication&version=2} status=0 QTime=0 
[junit4:junit4]   2> 3685 T1693 C116 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4]   2> 3687 T1693 C116 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:*} 0 2
[junit4:junit4]   2> 3691 T1695 C116 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   2> 3692 T1695 C116 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=3
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@5dcdbfbe lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@57ee1ab0),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@5dcdbfbe lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@57ee1ab0),segFN=segments_2,generation=2,filenames=[_0.fnm, _0_Lucene41_0.doc, _0.nvd, segments_2, _0.fdx, _0.si, _0.nvm, _0_Lucene41_0.tim, _0.fdt, _0_Lucene41_0.tip]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@5dcdbfbe lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@57ee1ab0),segFN=segments_3,generation=3,filenames=[segments_3]
[junit4:junit4]   2> 3692 T1695 C116 oasc.SolrDeletionPolicy.updateCommits newest commit = 3[segments_3]
[junit4:junit4]   2> 3693 T1695 C116 oass.SolrIndexSearcher.<init> Opening Searcher@6793c2a8 main
[junit4:junit4]   2> 3694 T1695 C116 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 3694 T1700 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6793c2a8 main{StandardDirectoryReader(segments_3:4)}
[junit4:junit4]   2> 3695 T1695 C116 UPDATE [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 4
[junit4:junit4]   2> 3712 T1689 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=681218845
[junit4:junit4]   2> 3716 T1689 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@22744e65
[junit4:junit4]   2> 3717 T1689 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> 3718 T1689 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 3718 T1689 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 3719 T1689 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 3721 T1689 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 3722 T1689 oasc.CachingDirectoryFactory.close Closing directory when closing factory: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master/collection1/data/index
[junit4:junit4]   2> 3723 T1689 oasc.CachingDirectoryFactory.closeDirectory Closing directory: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master/collection1/data/index
[junit4:junit4]   2> 3724 T1689 oasc.CachingDirectoryFactory.close Closing directory when closing factory: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master/collection1/data
[junit4:junit4]   2> 3725 T1689 oasc.CachingDirectoryFactory.closeDirectory Closing directory: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master/collection1/data
[junit4:junit4]   2> 3726 T1689 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4]   2> 3779 T1689 oejs.Server.doStart jetty-8.1.8.v20121106
[junit4:junit4]   2> 3786 T1689 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:49738
[junit4:junit4]   2> 3787 T1689 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 3788 T1689 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 3788 T1689 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master
[junit4:junit4]   2> 3789 T1689 oasc.CoreContainer$Initializer.initialize looking for solr config file: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master/solr.xml
[junit4:junit4]   2> 3789 T1689 oasc.CoreContainer.<init> New CoreContainer 83939685
[junit4:junit4]   2> 3790 T1689 oasc.CoreContainer$Initializer.initialize no solr.xml or solr.properties file found - using default old-style solr.xml
[junit4:junit4]   2> 3791 T1689 oasc.CoreContainer.load Loading CoreContainer using Solr Home: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master/'
[junit4:junit4]   2> 3791 T1689 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master/'
[junit4:junit4]   2> 3818 T1689 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 3819 T1689 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 3819 T1689 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 3820 T1689 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 3820 T1689 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 3821 T1689 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 3821 T1689 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 3822 T1689 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 3822 T1689 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 3823 T1689 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 3834 T1689 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 3858 T1725 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master/collection1
[junit4:junit4]   2> 3859 T1725 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master/collection1/'
[junit4:junit4]   2> 3891 T1725 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 3943 T1725 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 3944 T1725 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 3961 T1725 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 3980 T1725 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 3981 T1725 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 3982 T1725 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master/collection1/, dataDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master/collection1/data/
[junit4:junit4]   2> 3982 T1725 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4:junit4]   2> 3982 T1725 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 3983 T1725 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master/collection1/data
[junit4:junit4]   2> 3983 T1725 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master/collection1/data/index/
[junit4:junit4]   2> 3984 T1725 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master/collection1/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 3984 T1725 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master/collection1/data/index
[junit4:junit4]   2> 3986 T1725 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@7043dc6f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@49cd6c09),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 3986 T1725 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 3987 T1725 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 3988 T1725 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 3988 T1725 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 3989 T1725 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 3989 T1725 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 3990 T1725 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 3992 T1725 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 3995 T1725 oass.SolrIndexSearcher.<init> Opening Searcher@753304cb main
[junit4:junit4]   2> 3996 T1725 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 3996 T1725 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 3997 T1725 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4:junit4]   2> 3997 T1725 oash.ReplicationHandler.inform Commits will be reserved for  10000
[junit4:junit4]   2> 3997 T1725 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 3997 T1726 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@753304cb main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 3998 T1689 oass.SolrDispatchFilter.init user.dir=/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0
[junit4:junit4]   2> 3999 T1689 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 3999 T1689 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 4019 T1689 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1081758436
[junit4:junit4]   2> 4022 T1689 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@727b65b4
[junit4:junit4]   2> 4024 T1689 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> 4025 T1689 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 4025 T1689 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 4026 T1689 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 4028 T1689 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 4029 T1689 oasc.CachingDirectoryFactory.close Closing directory when closing factory: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1/data/index
[junit4:junit4]   2> 4029 T1689 oasc.CachingDirectoryFactory.closeDirectory Closing directory: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1/data/index
[junit4:junit4]   2> 4030 T1689 oasc.CachingDirectoryFactory.close Closing directory when closing factory: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1/data/index.20130322094654021
[junit4:junit4]   2> 4030 T1689 oasc.CachingDirectoryFactory.closeDirectory Removing directory: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1/data/index.20130322094654021
[junit4:junit4]   2> 4031 T1689 oasc.CachingDirectoryFactory.closeDirectory Closing directory: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1/data/index.20130322094654021
[junit4:junit4]   2> 4031 T1689 oasc.CachingDirectoryFactory.close Closing directory when closing factory: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1/data
[junit4:junit4]   2> 4032 T1689 oasc.CachingDirectoryFactory.closeDirectory Closing directory: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1/data
[junit4:junit4]   2> 4033 T1689 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4]   2> 4087 T1689 oejs.Server.doStart jetty-8.1.8.v20121106
[junit4:junit4]   2> 4092 T1689 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:49739
[junit4:junit4]   2> 4094 T1689 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 4094 T1689 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 4095 T1689 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave
[junit4:junit4]   2> 4095 T1689 oasc.CoreContainer$Initializer.initialize looking for solr config file: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/solr.xml
[junit4:junit4]   2> 4096 T1689 oasc.CoreContainer.<init> New CoreContainer 367763432
[junit4:junit4]   2> 4097 T1689 oasc.CoreContainer$Initializer.initialize no solr.xml or solr.properties file found - using default old-style solr.xml
[junit4:junit4]   2> 4098 T1689 oasc.CoreContainer.load Loading CoreContainer using Solr Home: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/'
[junit4:junit4]   2> 4098 T1689 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/'
[junit4:junit4]   2> 4126 T1689 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 4127 T1689 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 4128 T1689 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 4128 T1689 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 4129 T1689 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 4129 T1689 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 4130 T1689 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 4131 T1689 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 4131 T1689 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 4132 T1689 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 4145 T1689 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 4170 T1737 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1
[junit4:junit4]   2> 4172 T1737 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1/'
[junit4:junit4]   2> 4221 T1737 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 4280 T1737 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 4281 T1737 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 4285 T1737 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 4321 T1737 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 4323 T1737 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 4323 T1737 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1/, dataDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1/data/
[junit4:junit4]   2> 4323 T1737 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4:junit4]   2> 4324 T1737 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 4325 T1737 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1/data
[junit4:junit4]   2> 4325 T1737 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1/data/index/
[junit4:junit4]   2> 4325 T1737 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 4326 T1737 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1/data/index
[junit4:junit4]   2> 4328 T1737 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@59802e84 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e4aee6),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 4329 T1737 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 4330 T1737 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 4330 T1737 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 4331 T1737 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 4331 T1737 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 4332 T1737 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 4332 T1737 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 4336 T1737 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 4342 T1737 oass.SolrIndexSearcher.<init> Opening Searcher@5e8667b1 main
[junit4:junit4]   2> 4343 T1737 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 4343 T1737 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 4344 T1737 oash.SnapPuller.startExecutorService Poll Scheduled at an interval of 1000ms
[junit4:junit4]   2> 4344 T1737 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 4345 T1738 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5e8667b1 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 4346 T1689 oass.SolrDispatchFilter.init user.dir=/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0
[junit4:junit4]   2> 4346 T1689 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 4347 T1689 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> ASYNC  NEW_CORE C118 name=collection1 org.apache.solr.core.SolrCore@f2f204a
[junit4:junit4]   2> 4363 T1720 C118 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@7043dc6f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@49cd6c09),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 4364 T1720 C118 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 4365 T1720 C118 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[2000]} 0 4
[junit4:junit4]   2> 4369 T1721 C118 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   2> 4371 T1721 C118 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@7043dc6f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@49cd6c09),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@7043dc6f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@49cd6c09),segFN=segments_2,generation=2,filenames=[_0.fnm, _0_Lucene41_0.doc, _0.nvd, segments_2, _0.fdx, _0.si, _0.nvm, _0_Lucene41_0.tim, _0.fdt, _0_Lucene41_0.tip]
[junit4:junit4]   2> 4372 T1721 C118 oasc.SolrDeletionPolicy.updateCommits newest commit = 2[_0.fnm, _0_Lucene41_0.doc, _0.nvd, segments_2, _0.fdx, _0.si, _0.nvm, _0_Lucene41_0.tim, _0.fdt, _0_Lucene41_0.tip]
[junit4:junit4]   2> 4374 T1721 C118 oass.SolrIndexSearcher.<init> Opening Searcher@3a9a9289 main
[junit4:junit4]   2> 4375 T1726 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3a9a9289 main{StandardDirectoryReader(segments_2:3 _0(5.0):C1)}
[junit4:junit4]   2> 4375 T1721 C118 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 4376 T1721 C118 UPDATE [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 7
[junit4:junit4]   2> 4377 T1689 oash.TestReplicationHandler.rQuery Waiting for 1 docs
[junit4:junit4]   2> 4380 T1722 C118 REQ [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=1 status=0 QTime=0 
[junit4:junit4]   2> 4402 T1723 C118 REQ [collection1] webapp=/solr path=/replication params={command=indexversion&qt=/replication&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 4403 T1739 oash.SnapPuller.fetchLatestIndex Master's generation: 2
[junit4:junit4]   2> 4404 T1739 oash.SnapPuller.fetchLatestIndex Slave's generation: 1
[junit4:junit4]   2> 4405 T1739 oash.SnapPuller.fetchLatestIndex Starting replication process
[junit4:junit4]   2> 4412 T1724 C118 REQ [collection1] webapp=/solr path=/replication params={command=filelist&qt=/replication&wt=javabin&generation=2&version=2} status=0 QTime=1 
[junit4:junit4]   2> 4414 T1739 oash.SnapPuller.fetchLatestIndex Number of files in latest index in master: 10
[junit4:junit4]   2> 4415 T1739 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1/data/index.20130322094655017
[junit4:junit4]   2> 4415 T1739 oash.SnapPuller.fetchLatestIndex Starting download to MockDirWrapper(org.apache.lucene.store.RAMDirectory@6196187f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7d35b264) fullCopy=false
[junit4:junit4]   2> 4421 T1719 C118 REQ [collection1] webapp=/solr path=/replication params={file=_0.fnm&command=filecontent&checksum=true&compression=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=1 
[junit4:junit4]   2> 4429 T1720 C118 REQ [collection1] webapp=/solr path=/replication params={file=_0_Lucene41_0.doc&command=filecontent&checksum=true&compression=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0 
[junit4:junit4]   2> 4434 T1721 C118 REQ [collection1] webapp=/solr path=/replication params={file=_0.nvd&command=filecontent&checksum=true&compression=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0 
[junit4:junit4]   2> 4439 T1722 C118 REQ [collection1] webapp=/solr path=/replication params={file=segments_2&command=filecontent&checksum=true&compression=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0 
[junit4:junit4]   2> 4444 T1723 C118 REQ [collection1] webapp=/solr path=/replication params={file=_0.fdx&command=filecontent&checksum=true&compression=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0 
[junit4:junit4]   2> 4449 T1724 C118 REQ [collection1] webapp=/solr path=/replication params={file=_0.nvm&command=filecontent&checksum=true&compression=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0 
[junit4:junit4]   2> 4454 T1719 C118 REQ [collection1] webapp=/solr path=/replication params={file=_0.si&command=filecontent&checksum=true&compression=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=1 
[junit4:junit4]   2> 4458 T1720 C118 REQ [collection1] webapp=/solr path=/replication params={file=_0_Lucene41_0.tim&command=filecontent&checksum=true&compression=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0 
[junit4:junit4]   2> 4464 T1721 C118 REQ [collection1] webapp=/solr path=/replication params={file=_0_Lucene41_0.tip&command=filecontent&checksum=true&compression=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0 
[junit4:junit4]   2> 4470 T1722 C118 REQ [collection1] webapp=/solr path=/replication params={file=_0.fdt&command=filecontent&checksum=true&compression=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0 
[junit4:junit4]   2> 4472 T1739 oash.SnapPuller.fetchLatestIndex Total time taken for download : 0 secs
[junit4:junit4]   2> 4473 T1739 oash.SnapPuller.downloadConfFiles Starting download of configuration files from master: [{name=schema.xml, checksum=1505963717, size=1634}, {name=xslt/dummy.xsl, checksum=1, size=0}]
[junit4:junit4]   2> 4486 T1724 C118 REQ [collection1] webapp=/solr path=/replication params={command=details&wt=javabin&qt=/replication&version=2} status=0 QTime=1 
[junit4:junit4]   2> 4486 T1723 C118 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&compression=true&wt=filestream&cf=schema.xml&qt=/replication&generation=2} status=0 QTime=5 
[junit4:junit4]   2> 4491 T1719 C118 REQ [collection1] webapp=/solr path=/replication params={command=details&wt=javabin&qt=/replication&version=2} status=0 QTime=1 
[junit4:junit4]   2> 4502 T1720 C118 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&compression=true&wt=filestream&cf=xslt/dummy.xsl&qt=/replication&generation=2} status=0 QTime=0 
[junit4:junit4]   2> 4506 T1739 oash.SnapPuller$LocalFsFileFetcher.fetchPackets WARNING No content recieved for file: {name=xslt/dummy.xsl, checksum=1, size=0}
[junit4:junit4]   2> 4512 T1739 oash.SnapPuller.fetchLatestIndex Configuration files are modified, core will be reloaded
[junit4:junit4]   2> 4513 T1721 C118 REQ [collection1] webapp=/solr path=/replication params={slave=false&command=details&wt=javabin&qt=/replication&version=2} status=0 QTime=1 
[junit4:junit4]   2> 4514 T1739 oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter...
[junit4:junit4]   2> 4516 T1739 oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused... core=collection1
[junit4:junit4]   2> 4515 T1742 oasc.CoreContainer.reload Reloading SolrCore 'collection1' using instanceDir: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1
[junit4:junit4]   2> 4518 T1742 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1/'
[junit4:junit4]   2> 4518 T1739 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@59802e84 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e4aee6),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@59802e84 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e4aee6),segFN=segments_2,generation=2,filenames=[_0.fnm, _0_Lucene41_0.doc, _0.nvd, segments_2, _0.fdx, _0.nvm, _0.si, _0_Lucene41_0.tim, _0_Lucene41_0.tip, _0.fdt]
[junit4:junit4]   2> 4519 T1739 oasc.SolrDeletionPolicy.updateCommits newest commit = 2[_0.fnm, _0_Lucene41_0.doc, _0.nvd, segments_2, _0.fdx, _0.nvm, _0.si, _0_Lucene41_0.tim, _0_Lucene41_0.tip, _0.fdt]
[junit4:junit4]   2> 4519 T1739 oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used.
[junit4:junit4]   2> 4520 T1739 oass.SolrIndexSearcher.<init> Opening Searcher@7c3aa321 main
[junit4:junit4]   2> 4520 T1738 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7c3aa321 main{StandardDirectoryReader(segments_2:3:nrt _0(5.0):C1)}
[junit4:junit4]   2> ASYNC  NEW_CORE C119 name=collection1 org.apache.solr.core.SolrCore@d6f860e
[junit4:junit4]   2> 4517 T1732 C119 REQ [collection1] webapp=/solr path=/replication params={command=details&wt=javabin&qt=/replication&version=2} status=0 QTime=9 
[junit4:junit4]   2> 4526 T1722 C118 REQ [collection1] webapp=/solr path=/replication params={command=indexversion&wt=javabin&qt=/replication&version=2} status=0 QTime=0 
[junit4:junit4]   2> 4530 T1733 C119 REQ [collection1] webapp=/solr path=/replication params={command=indexversion&wt=javabin&qt=/replication&version=2} status=0 QTime=0 
[junit4:junit4]   2> 4531 T1689 oas.SolrTestCaseJ4.tearDown ###Ending doTestIndexAndConfigReplication
[junit4:junit4]   2> 4544 T1689 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=83939685
[junit4:junit4]   2> 4549 T1689 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@f2f204a
[junit4:junit4]   2> 4550 T1689 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> 4551 T1689 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 4551 T1689 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 4552 T1689 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 4555 T1689 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 4556 T1689 oasc.CachingDirectoryFactory.close Closing directory when closing factory: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master/collection1/data/index
[junit4:junit4]   2> 4557 T1689 oasc.CachingDirectoryFactory.closeDirectory Closing directory: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master/collection1/data/index
[junit4:junit4]   2> 4557 T1689 oasc.CachingDirectoryFactory.close Closing directory when closing factory: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master/collection1/data
[junit4:junit4]   2> 4558 T1689 oasc.CachingDirectoryFactory.closeDirectory Closing directory: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010618/master/collection1/data
[junit4:junit4]   2> 4559 T1689 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4]   2> 4575 T1742 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 4640 T1689 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=367763432
[junit4:junit4]   2> 4643 T1689 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@d6f860e
[junit4:junit4]   2> 4644 T1689 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> 4645 T1689 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 4646 T1689 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 4646 T1689 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 4648 T1689 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 4648 T1689 oasc.CachingDirectoryFactory.close Closing directory when closing factory: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1/data
[junit4:junit4]   2> 4649 T1689 oasc.CachingDirectoryFactory.closeDirectory Closing directory: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1/data
[junit4:junit4]   2> 4650 T1689 oasc.CachingDirectoryFactory.close Closing directory when closing factory: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1/data/index.20130322094655017
[junit4:junit4]   2> 4650 T1689 oasc.CachingDirectoryFactory.closeDirectory Removing directory: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1/data/index.20130322094655017
[junit4:junit4]   2> 4651 T1742 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 4651 T1689 oasc.CachingDirectoryFactory.closeDirectory Closing directory: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1/data/index.20130322094655017
[junit4:junit4]   2> 4651 T1742 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 4651 T1689 oasc.CachingDirectoryFactory.close Closing directory when closing factory: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1/data/index
[junit4:junit4]   2> 4652 T1689 oasc.CachingDirectoryFactory.closeDirectory Closing directory: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978010900/slave/collection1/data/index
[junit4:junit4]   2> 4653 T1689 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4]   2> 4655 T1742 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 4677 T1742 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 4679 T1742 oasc.CoreContainer.recordAndThrow SEVERE Unable to reload core: collection1 java.lang.IllegalStateException: IndexWriter has been closed
[junit4:junit4]   2> 	at org.apache.solr.update.SolrCoreState.increfSolrCoreState(SolrCoreState.java:55)
[junit4:junit4]   2> 	at org.apache.solr.core.SolrCore.reload(SolrCore.java:401)
[junit4:junit4]   2> 	at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1075)
[junit4:junit4]   2> 	at org.apache.solr.handler.SnapPuller$3.run(SnapPuller.java:691)
[junit4:junit4]   2> 
[junit4:junit4]   2> 4679 T1742 oash.SnapPuller$3.run SEVERE Could not reload core  org.apache.solr.common.SolrException: Unable to reload core: collection1
[junit4:junit4]   2> 	at org.apache.solr.core.CoreContainer.recordAndThrow(CoreContainer.java:1362)
[junit4:junit4]   2> 	at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1085)
[junit4:junit4]   2> 	at org.apache.solr.handler.SnapPuller$3.run(SnapPuller.java:691)
[junit4:junit4]   2> Caused by: java.lang.IllegalStateException: IndexWriter has been closed
[junit4:junit4]   2> 	at org.apache.solr.update.SolrCoreState.increfSolrCoreState(SolrCoreState.java:55)
[junit4:junit4]   2> 	at org.apache.solr.core.SolrCore.reload(SolrCore.java:401)
[junit4:junit4]   2> 	at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1075)
[junit4:junit4]   2> 	... 1 more
[junit4:junit4]   2> 
[junit4:junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestReplicationHandler -Dtests.method=doTestIndexAndConfigReplication -Dtests.seed=A6DEFEB4500D83AD -Dtests.slow=true -Dtests.locale=ar_SD -Dtests.timezone=America/Atka -Dtests.file.encoding=US-ASCII
[junit4:junit4] FAILURE 4.73s | TestReplicationHandler.doTestIndexAndConfigReplication <<<
[junit4:junit4]    > Throwable #1: java.lang.AssertionError: expected:<0> but was:<1363978014972>
[junit4:junit4]    > 	at __randomizedtesting.SeedInfo.seed([A6DEFEB4500D83AD:B296A5E1730A3EB3]:0)
[junit4:junit4]    > 	at org.junit.Assert.fail(Assert.java:93)
[junit4:junit4]    > 	at org.junit.Assert.failNotEquals(Assert.java:647)
[junit4:junit4]    > 	at org.junit.Assert.assertEquals(Assert.java:128)
[junit4:junit4]    > 	at org.junit.Assert.assertEquals(Assert.java:147)
[junit4:junit4]    > 	at org.apache.solr.handler.TestReplicationHandler.assertVersions(TestReplicationHandler.java:834)
[junit4:junit4]    > 	at org.apache.solr.handler.TestReplicationHandler.doTestIndexAndConfigReplication(TestReplicationHandler.java:461)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
[junit4:junit4]    > 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4:junit4]    > 	at java.lang.reflect.Method.invoke(Method.java:601)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
[junit4:junit4]    > 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]    > 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]    > 	at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 4745 T1689 oas.SolrTestCaseJ4.setUp ###Starting doTestReplicateAfterStartupWithNoActivity
[junit4:junit4]   2> 4753 T1689 oejs.Server.doStart jetty-8.1.8.v20121106
[junit4:junit4]   2> 4757 T1689 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:49743
[junit4:junit4]   2> 4758 T1689 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 4758 T1689 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 4759 T1689 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015349/master
[junit4:junit4]   2> 4759 T1689 oasc.CoreContainer$Initializer.initialize looking for solr config file: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015349/master/solr.xml
[junit4:junit4]   2> 4760 T1689 oasc.CoreContainer.<init> New CoreContainer 1607071061
[junit4:junit4]   2> 4761 T1689 oasc.CoreContainer$Initializer.initialize no solr.xml or solr.properties file found - using default old-style solr.xml
[junit4:junit4]   2> 4761 T1689 oasc.CoreContainer.load Loading CoreContainer using Solr Home: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015349/master/'
[junit4:junit4]   2> 4762 T1689 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015349/master/'
[junit4:junit4]   2> 4802 T1689 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 4803 T1689 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 4803 T1689 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 4804 T1689 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 4805 T1689 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 4806 T1689 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 4807 T1689 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 4807 T1689 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 4808 T1689 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 4808 T1689 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 4824 T1689 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 4839 T1752 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015349/master/collection1
[junit4:junit4]   2> 4840 T1752 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015349/master/collection1/'
[junit4:junit4]   2> 4885 T1752 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 4966 T1752 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 4967 T1752 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 4971 T1752 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 4991 T1752 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 4992 T1752 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 4993 T1752 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015349/master/collection1/, dataDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015349/master/collection1/data/
[junit4:junit4]   2> 4993 T1752 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4:junit4]   2> 4994 T1752 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 4995 T1752 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015349/master/collection1/data
[junit4:junit4]   2> 4995 T1752 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015349/master/collection1/data/index/
[junit4:junit4]   2> 4995 T1752 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015349/master/collection1/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 4996 T1752 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015349/master/collection1/data/index
[junit4:junit4]   2> 4997 T1752 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@1e304bf1 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4a0cd60e),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 4998 T1752 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 4999 T1752 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 4999 T1752 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 5000 T1752 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 5000 T1752 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 5000 T1752 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 5001 T1752 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 5009 T1752 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 5012 T1752 oass.SolrIndexSearcher.<init> Opening Searcher@573337b2 main
[junit4:junit4]   2> 5013 T1752 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 5013 T1752 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 5014 T1752 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4:junit4]   2> 5014 T1752 oash.ReplicationHandler.inform Commits will be reserved for  10000
[junit4:junit4]   2> 5014 T1752 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 5014 T1753 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@573337b2 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 5015 T1689 oass.SolrDispatchFilter.init user.dir=/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0
[junit4:junit4]   2> 5016 T1689 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 5017 T1689 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 5030 T1689 oejs.Server.doStart jetty-8.1.8.v20121106
[junit4:junit4]   2> 5035 T1689 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:49744
[junit4:junit4]   2> 5036 T1689 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 5037 T1689 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 5037 T1689 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015626/slave
[junit4:junit4]   2> 5039 T1689 oasc.CoreContainer$Initializer.initialize looking for solr config file: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015626/slave/solr.xml
[junit4:junit4]   2> 5039 T1689 oasc.CoreContainer.<init> New CoreContainer 204674071
[junit4:junit4]   2> 5040 T1689 oasc.CoreContainer$Initializer.initialize no solr.xml or solr.properties file found - using default old-style solr.xml
[junit4:junit4]   2> 5041 T1689 oasc.CoreContainer.load Loading CoreContainer using Solr Home: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015626/slave/'
[junit4:junit4]   2> 5041 T1689 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015626/slave/'
[junit4:junit4]   2> 5069 T1689 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 5070 T1689 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 5070 T1689 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 5071 T1689 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 5071 T1689 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 5072 T1689 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 5072 T1689 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 5073 T1689 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 5074 T1689 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 5074 T1689 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 5087 T1689 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 5112 T1764 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015626/slave/collection1
[junit4:junit4]   2> 5113 T1764 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015626/slave/collection1/'
[junit4:junit4]   2> 5162 T1764 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 5221 T1764 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 5221 T1764 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 5225 T1764 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 5258 T1764 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 5259 T1764 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 5260 T1764 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015626/slave/collection1/, dataDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015626/slave/collection1/data/
[junit4:junit4]   2> 5260 T1764 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4:junit4]   2> 5260 T1764 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 5261 T1764 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015626/slave/collection1/data
[junit4:junit4]   2> 5261 T1764 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015626/slave/collection1/data/index/
[junit4:junit4]   2> 5262 T1764 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015626/slave/collection1/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 5263 T1764 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015626/slave/collection1/data/index
[junit4:junit4]   2> 5264 T1764 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@325a4199 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3cff58ec),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 5264 T1764 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 5266 T1764 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 5266 T1764 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 5266 T1764 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 5267 T1764 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 5267 T1764 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 5267 T1764 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 5269 T1764 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 5272 T1764 oass.SolrIndexSearcher.<init> Opening Searcher@708dc446 main
[junit4:junit4]   2> 5273 T1764 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 5273 T1764 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 5274 T1764 oash.SnapPuller.startExecutorService Poll Scheduled at an interval of 1000ms
[junit4:junit4]   2> 5275 T1764 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 5275 T1765 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@708dc446 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 5275 T1689 oass.SolrDispatchFilter.init user.dir=/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0
[junit4:junit4]   2> 5276 T1689 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 5277 T1689 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 5296 T1689 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=204674071
[junit4:junit4]   2> 5300 T1689 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@1b0a4ee3
[junit4:junit4]   2> 5300 T1689 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> 5301 T1689 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 5301 T1689 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 5302 T1689 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 5303 T1689 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 5303 T1689 oasc.CachingDirectoryFactory.close Closing directory when closing factory: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015626/slave/collection1/data
[junit4:junit4]   2> 5304 T1689 oasc.CachingDirectoryFactory.closeDirectory Closing directory: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015626/slave/collection1/data
[junit4:junit4]   2> 5304 T1689 oasc.CachingDirectoryFactory.close Closing directory when closing factory: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015626/slave/collection1/data/index
[junit4:junit4]   2> 5305 T1689 oasc.CachingDirectoryFactory.closeDirectory Closing directory: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015626/slave/collection1/data/index
[junit4:junit4]   2> 5306 T1689 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4]   2> ASYNC  NEW_CORE C120 name=collection1 org.apache.solr.core.SolrCore@42afea1c
[junit4:junit4]   2> 5365 T1747 C120 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4]   2> 5368 T1747 C120 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@1e304bf1 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4a0cd60e),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 5368 T1747 C120 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 5369 T1747 C120 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:*} 0 4
[junit4:junit4]   2> 5374 T1748 C120 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   2> 5376 T1748 C120 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@1e304bf1 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4a0cd60e),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@1e304bf1 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4a0cd60e),segFN=segments_2,generation=2,filenames=[segments_2]
[junit4:junit4]   2> 5376 T1748 C120 oasc.SolrDeletionPolicy.updateCommits newest commit = 2[segments_2]
[junit4:junit4]   2> 5436 T1748 C120 oass.SolrIndexSearcher.<init> Opening Searcher@2086571f main
[junit4:junit4]   2> 5437 T1748 C120 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 5437 T1753 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2086571f main{StandardDirectoryReader(segments_2:2)}
[junit4:junit4]   2> 5438 T1748 C120 UPDATE [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 64
[junit4:junit4]   2> 5456 T1689 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1607071061
[junit4:junit4]   2> 5458 T1689 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@42afea1c
[junit4:junit4]   2> 5459 T1689 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> 5460 T1689 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 5460 T1689 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 5461 T1689 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 5462 T1689 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 5463 T1689 oasc.CachingDirectoryFactory.close Closing directory when closing factory: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015349/master/collection1/data
[junit4:junit4]   2> 5463 T1689 oasc.CachingDirectoryFactory.closeDirectory Closing directory: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015349/master/collection1/data
[junit4:junit4]   2> 5464 T1689 oasc.CachingDirectoryFactory.close Closing directory when closing factory: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015349/master/collection1/data/index
[junit4:junit4]   2> 5464 T1689 oasc.CachingDirectoryFactory.closeDirectory Closing directory: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015349/master/collection1/data/index
[junit4:junit4]   2> 5465 T1689 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4]   2> 5518 T1689 oejs.Server.doStart jetty-8.1.8.v20121106
[junit4:junit4]   2> 5523 T1689 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:49746
[junit4:junit4]   2> 5524 T1689 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 5525 T1689 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 5526 T1689 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015349/master
[junit4:junit4]   2> 5527 T1689 oasc.CoreContainer$Initializer.initialize looking for solr config file: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015349/master/solr.xml
[junit4:junit4]   2> 5528 T1689 oasc.CoreContainer.<init> New CoreContainer 1212873288
[junit4:junit4]   2> 5529 T1689 oasc.CoreContainer$Initializer.initialize no solr.xml or solr.properties file found - using default old-style solr.xml
[junit4:junit4]   2> 5529 T1689 oasc.CoreContainer.load Loading CoreContainer using Solr Home: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015349/master/'
[junit4:junit4]   2> 5530 T1689 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015349/master/'
[junit4:junit4]   2> 5555 T1689 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 5556 T1689 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 5556 T1689 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 5557 T1689 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 5557 T1689 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 5558 T1689 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 5558 T1689 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 5559 T1689 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 5559 T1689 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 5560 T1689 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 5571 T1689 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 5595 T1777 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015349/master/collection1
[junit4:junit4]   2> 5597 T1777 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015349/master/collection1/'
[junit4:junit4]   2> 5640 T1777 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 5693 T1777 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 5694 T1777 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 5699 T1777 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 5716 T1777 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 5718 T1777 oasc.SolrCore.initDirectoryFactory solr.NRTCachingDirectoryFactory
[junit4:junit4]   2> 5747 T1777 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015349/master/collection1/, dataDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015349/master/collection1/data/
[junit4:junit4]   2> 5747 T1777 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4:junit4]   2> 5748 T1777 oasc.SolrCore.initDirectoryFactory solr.NRTCachingDirectoryFactory
[junit4:junit4]   2> 5748 T1777 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015349/master/collection1/data
[junit4:junit4]   2> 5749 T1777 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015349/master/collection1/data/index/
[junit4:junit4]   2> 5749 T1777 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015349/master/collection1/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 5751 T1777 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015349/master/collection1/data/index
[junit4:junit4]   2> 5756 T1777 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015349/master/collection1/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e259d5e; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 5757 T1777 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 5758 T1777 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 5759 T1777 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 5760 T1777 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 5760 T1777 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 5760 T1777 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 5760 T1777 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 5767 T1777 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 5776 T1777 oass.SolrIndexSearcher.<init> Opening Searcher@406876 main
[junit4:junit4]   2> 5777 T1777 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 5777 T1777 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 5777 T1777 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml
[junit4:junit4]   2> 5779 T1777 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1363978015349/master/collection1/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e259d5e; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 5779 T1777 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 5780 T1777 oash.ReplicationHandler.inform Commits will be reserved for  10000
[junit4:junit4]   2> 5780 T1777 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 5781 T1778 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@406876 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 5782 T1689 oass.SolrDispatchFilter.init user.dir=/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0
[junit4:junit4]   2> 5782 T1689 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 5783 T1689 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> ASYNC  NEW_CORE C121 name=collection1 org.apache.solr.core.SolrCore@3e9a9f41
[junit4:junit4]   2> 5802 T1771 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0]} 0 2
[junit4:junit4]   2> 5811 T1772 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1]} 0 1
[junit4:junit4]   2> 5815 T1773 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[2]} 0 0
[junit4:junit4]   2> 5820 T1774 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[3]} 0 1
[junit4:junit4]   2> 5827 T1775 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[4]} 0 1
[junit4:junit4]   2> 5831 T1776 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[5]} 0 1
[junit4:junit4]   2> 5834 T1771 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[6]} 0 0
[junit4:junit4]   2> 5838 T1772 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[7]} 0 1
[junit4:junit4]   2> 5842 T1773 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[8]} 0 1
[junit4:junit4]   2> 5845 T1774 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[9]} 0 0
[junit4:junit4]   2> 5849 T1775 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[10]} 0 1
[junit4:junit4]   2> 5855 T1776 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[11]} 0 0
[junit4:junit4]   2> 5859 T1771 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[12]} 0 1
[junit4:junit4]   2> 5862 T1772 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[13]} 0 0
[junit4:junit4]   2> 5866 T1773 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[14]} 0 0
[junit4:junit4]   2> 5870 T1774 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[15]} 0 1
[junit4:junit4]   2> 5876 T1775 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[16]} 0 0
[junit4:junit4]   2> 5881 T1776 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[17]} 0 1
[junit4:junit4]   2> 5884 T1771 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[18]} 0 0
[junit4:junit4]   2> 5888 T1772 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[19]} 0 1
[junit4:junit4]   2> 5892 T1773 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[20]} 0 1
[junit4:junit4]   2> 5895 T1774 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[21]} 0 0
[junit4:junit4]   2> 5901 T1775 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[22]} 0 1
[junit4:junit4]   2> 5906 T1776 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[23]} 0 1
[junit4:junit4]   2> 5911 T1771 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[24]} 0 1
[junit4:junit4]   2> 5915 T1772 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[25]} 0 1
[junit4:junit4]   2> 5918 T1773 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[26]} 0 0
[junit4:junit4]   2> 5922 T1774 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[27]} 0 0
[junit4:junit4]   2> 5926 T1776 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[28]} 0 0
[junit4:junit4]   2> 5930 T1771 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[29]} 0 0
[junit4:junit4]   2> 5935 T1772 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[30]} 0 1
[junit4:junit4]   2> 5938 T1773 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[31]} 0 0
[junit4:junit4]   2> 5944 T1774 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[32]} 0 1
[junit4:junit4]   2> 5948 T1775 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[33]} 0 0
[junit4:junit4]   2> 5957 T1776 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[34]} 0 1
[junit4:junit4]   2> 5962 T1771 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[35]} 0 1
[junit4:junit4]   2> 5967 T1772 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[36]} 0 0
[junit4:junit4]   2> 5974 T1773 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[37]} 0 0
[junit4:junit4]   2> 5978 T1774 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[38]} 0 1
[junit4:junit4]   2> 5982 T1775 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[39]} 0 0
[junit4:junit4]   2> 5986 T1776 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[40]} 0 1
[junit4:junit4]   2> 5990 T1771 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[41]} 0 0
[junit4:junit4]   2> 5993 T1772 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[42]} 0 0
[junit4:junit4]   2> 5997 T1773 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[43]} 0 1
[junit4:junit4]   2> 6000 T1774 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[44]} 0 0
[junit4:junit4]   2> 6006 T1775 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[45]} 0 1
[junit4:junit4]   2> 6014 T1776 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[46]} 0 1
[junit4:junit4]   2> 6018 T1771 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[47]} 0 0
[junit4:junit4]   2> 6023 T1772 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[48]} 0 1
[junit4:junit4]   2> 6031 T1773 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[49]} 0 1
[junit4:junit4]   2> 6038 T1774 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[50]} 0 1
[junit4:junit4]   2> 6042 T1775 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[51]} 0 1
[junit4:junit4]   2> 6045 T1776 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[52]} 0 0
[junit4:junit4]   2> 6049 T1771 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[53]} 0 0
[junit4:junit4]   2> 6055 T1772 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[54]} 0 0
[junit4:junit4]   2> 6059 T1773 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[55]} 0 0
[junit4:junit4]   2> 6063 T1774 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[56]} 0 0
[junit4:junit4]   2> 6067 T1775 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[57]} 0 1
[junit4:junit4]   2> 6070 T1776 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[58]} 0 0
[junit4:junit4]   2> 6073 T1771 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[59]} 0 0
[junit4:junit4]   2> 6078 T1772 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[60]} 0 1
[junit4:junit4]   2> 6082 T1773 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[61]} 0 1
[junit4:junit4]   2> 6086 T1774 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[62]} 0 0
[junit4:junit4]   2> 6094 T1775 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[63]} 0 1
[junit4:junit4]   2> 6099 T1776 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[64]} 0 0
[junit4:junit4]   2> 6106 T1771 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[65]} 0 0
[junit4:junit4]   2> 6110 T1772 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[66]} 0 0
[junit4:junit4]   2> 6114 T1773 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[67]} 0 1
[junit4:junit4]   2> 6121 T1774 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[68]} 0 1
[junit4:junit4]   2> 6126 T1775 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[69]} 0 0
[junit4:junit4]   2> 6131 T1776 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[70]} 0 0
[junit4:junit4]   2> 6139 T1771 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[71]} 0 0
[junit4:junit4]   2> 6150 T1772 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[72]} 0 0
[junit4:junit4]   2> 6160 T1773 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[73]} 0 0
[junit4:junit4]   2> 6166 T1774 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[74]} 0 0
[junit4:junit4]   2> 6180 T1775 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[75]} 0 0
[junit4:junit4]   2> 6184 T1776 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[76]} 0 0
[junit4:junit4]   2> 6188 T1771 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[77]} 0 1
[junit4:junit4]   2> 6191 T1772 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[78]} 0 0
[junit4:junit4]   2> 6195 T1773 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[79]} 0 1
[junit4:junit4]   2> 6199 T1774 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[80]} 0 1
[junit4:junit4]   2> 6202 T1775 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[81]} 0 0
[junit4:junit4]   2> 6211 T1776 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[82]} 0 0
[junit4:junit4]   2> 6221 T1771 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[83]} 0 1
[junit4:junit4]   2> 6225 T1772 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[84]} 0 0
[junit4:junit4]   2> 6231 T1773 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[85]} 0 1
[junit4:junit4]   2> 6240 T1774 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[86]} 0 1
[junit4:junit4]   2> 6245 T1775 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[87]} 0 1
[junit4:junit4]   2> 6250 T1776 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[88]} 0 1
[junit4:junit4]   2> 6255 T1771 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[89]} 0 1
[junit4:junit4]   2> 6259 T1772 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[90]} 0 1
[junit4:junit4]   2> 6262 T1773 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[91]} 0 0
[junit4:junit4]   2> 6269 T1774 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[92]} 0 0
[junit4:junit4]   2> 6273 T1775 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[93]} 0 0
[junit4:junit4]   2> 6280 T1776 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[94]} 0 0
[junit4:junit4]   2> 6286 T1771 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[95]} 0 0
[junit4:junit4]   2> 6294 T1772 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[96]} 0 0
[junit4:junit4]   2> 6300 T1773 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[97]} 0 0
[junit4:junit4]   2> 6305 T1774 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[98]} 0 0
[junit4:junit4]   2> 6311 T1775 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[99]} 0 1
[junit4:junit4]   2> 6316 T1776 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[100]} 0 1
[junit4:junit4]   2> 6321 T1771 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[101]} 0 1
[junit4:junit4]   2> 6325 T1772 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[102]} 0 1
[junit4:junit4]   2> 6329 T1774 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[103]} 0 0
[junit4:junit4]   2> 6334 T1775 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[104]} 0 1
[junit4:junit4]   2> 6338 T1776 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[105]} 0 0
[junit4:junit4]   2> 6343 T1771 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[106]} 0 0
[junit4:junit4]   2> 6347 T1773 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[107]} 0 0
[junit4:junit4]   2> 6355 T1772 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[108]} 0 1
[junit4:junit4]   2> 6360 T1774 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[109]} 0 1
[junit4:junit4]   2> 6364 T1775 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[110]} 0 1
[junit4:junit4]   2> 6368 T1776 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[111]} 0 0
[junit4:junit4]   2> 6372 T1771 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[112]} 0 0
[junit4:junit4]   2> 6377 T1773 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[113]} 0 1
[junit4:junit4]   2> 6382 T1772 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[114]} 0 1
[junit4:junit4]   2> 6386 T1774 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[115]} 0 0
[junit4:junit4]   2> 6390 T1775 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[116]} 0 0
[junit4:junit4]   2> 6395 T1776 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[117]} 0 0
[junit4:junit4]   2> 6399 T1771 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[118]} 0 0
[junit4:junit4]   2> 6404 T1773 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[119]} 0 1
[junit4:junit4]   2> 6408 T1772 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[120]} 0 0
[junit4:junit4]   2> 6413 T1774 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[121]} 0 1
[junit4:junit4]   2> 6417 T1775 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[122]} 0 1
[junit4:junit4]   2> 6421 T1776 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[123]} 0 0
[junit4:junit4]   2> 6425 T1771 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[124]} 0 1
[junit4:junit4]   2> 6431 T1773 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[125]} 0 0
[junit4:junit4]   2> 6439 T1772 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[126]} 0 1
[junit4:junit4]   2> 6445 T1774 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[127]} 0 1
[junit4:junit4]   2> 6451 T1775 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[128]} 0 1
[junit4:junit4]   2> 6455 T1776 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[129]} 0 0
[junit4:junit4]   2> 6460 T1771 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[130]} 0 1
[junit4:junit4]   2> 6467 T1773 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[131]} 0 1
[junit4:junit4]   2> 6481 T1772 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[132]} 0 0
[junit4:junit4]   2> 6486 T1774 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[133]} 0 1
[junit4:junit4]   2> 6491 T1775 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[134]} 0 1
[junit4:junit4]   2> 6496 T1776 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[135]} 0 1
[junit4:junit4]   2> 6501 T1771 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[136]} 0 1
[junit4:junit4]   2> 6505 T1773 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[137]} 0 1
[junit4:junit4]   2> 6509 T1772 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[138]} 0 1
[junit4:junit4]   2> 6514 T1774 C121 UPDATE [collection1] webapp=/solr path=/update params={wt=jav

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

loser
[junit4:junit4]   2> 84855 T3396 oasc.SolrCore.closeSearcher [00003_core] Closing main searcher on request.
[junit4:junit4]   2> 84858 T3396 oasc.CachingDirectoryFactory.close Closing directory when closing factory: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/OpenCloseCoreStressTest_/00003_core/data/index
[junit4:junit4]   2> 84858 T3396 oasc.CachingDirectoryFactory.closeDirectory Closing directory: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/OpenCloseCoreStressTest_/00003_core/data/index
[junit4:junit4]   2> 84952 T3396 oasc.CachingDirectoryFactory.close Closing directory when closing factory: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/OpenCloseCoreStressTest_/00003_core/data
[junit4:junit4]   2> 84953 T3396 oasc.CachingDirectoryFactory.closeDirectory Closing directory: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/OpenCloseCoreStressTest_/00003_core/data
[junit4:junit4]   2> 84954 T3396 oasc.SolrCore.close [00015_core]  CLOSING SolrCore org.apache.solr.core.SolrCore@5e1f2fff
[junit4:junit4]   2> 84959 T3396 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=7,autocommits=0,soft autocommits=6,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=514,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4:junit4]   2> 84961 T3396 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 84961 T3396 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 84962 T3396 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 84963 T3396 oasc.SolrCore.closeSearcher [00015_core] Closing main searcher on request.
[junit4:junit4]   2> 85025 T3396 oasc.CachingDirectoryFactory.close Closing directory when closing factory: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/OpenCloseCoreStressTest_/00015_core/data/index
[junit4:junit4]   2> 85026 T3396 oasc.CachingDirectoryFactory.closeDirectory Closing directory: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/OpenCloseCoreStressTest_/00015_core/data/index
[junit4:junit4]   2> 85110 T3396 oasc.CachingDirectoryFactory.close Closing directory when closing factory: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/OpenCloseCoreStressTest_/00015_core/data
[junit4:junit4]   2> 85111 T3396 oasc.CachingDirectoryFactory.closeDirectory Closing directory: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/OpenCloseCoreStressTest_/00015_core/data
[junit4:junit4]   2> 85112 T3396 oasc.SolrCore.close [00006_core]  CLOSING SolrCore org.apache.solr.core.SolrCore@4a85995b
[junit4:junit4]   2> 85118 T3396 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=6,autocommits=0,soft autocommits=5,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=525,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4:junit4]   2> 85119 T3396 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 85120 T3396 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 85120 T3396 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 85122 T3396 oasc.SolrCore.closeSearcher [00006_core] Closing main searcher on request.
[junit4:junit4]   2> 85124 T3396 oasc.CachingDirectoryFactory.close Closing directory when closing factory: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/OpenCloseCoreStressTest_/00006_core/data/index
[junit4:junit4]   2> 85125 T3396 oasc.CachingDirectoryFactory.closeDirectory Closing directory: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/OpenCloseCoreStressTest_/00006_core/data/index
[junit4:junit4]   2> 85174 T3396 oasc.CachingDirectoryFactory.close Closing directory when closing factory: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/OpenCloseCoreStressTest_/00006_core/data
[junit4:junit4]   2> 85175 T3396 oasc.CachingDirectoryFactory.closeDirectory Closing directory: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/OpenCloseCoreStressTest_/00006_core/data
[junit4:junit4]   2> 85176 T3396 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4]   2> 85229 T3396 oejut.QueuedThreadPool.doStop WARNING 1 threads could not be stopped
[junit4:junit4]   2> 85738 T3396 oas.SolrTestCaseJ4.tearDown ###Ending test30SecondsOld
[junit4:junit4] IGNOR/A 0.00s | OpenCloseCoreStressTest.test1HourOld
[junit4:junit4]    > Assumption #1: 'weekly' test group is disabled (@Weekly)
[junit4:junit4]   2> 85746 T3396 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4:junit4]   2> NOTE: test params are: codec=Lucene42: {id=PostingsFormat(name=Asserting), text=MockFixedIntBlock(blockSize=1768)}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=false,coord=yes): {}, locale=ar_SD, timezone=Pacific/Norfolk
[junit4:junit4]   2> NOTE: Mac OS X 10.8.2 x86_64/Oracle Corporation 1.7.0_15 (64-bit)/cpus=2,threads=1,free=127322624,total=287133696
[junit4:junit4]   2> NOTE: All tests run in this JVM: [OverseerCollectionProcessorTest, RecoveryZkTest, FieldMutatingUpdateProcessorTest, StatsComponentTest, OverseerTest, TestRTGBase, SolrPluginUtilsTest, FullSolrCloudDistribCmdsTest, TermVectorComponentTest, LegacyHTMLStripCharFilterTest, MBeansHandlerTest, TestPartialUpdateDeduplication, SolrCoreTest, SOLR749Test, TestDocumentBuilder, CollectionsAPIDistributedZkTest, TestLazyCores, DirectSolrConnectionTest, HardAutoCommitTest, TestFuzzyAnalyzedSuggestions, DistributedSpellCheckComponentTest, TestLRUCache, SoftAutoCommitTest, TestQuerySenderNoQuery, ReturnFieldsTest, TestDefaultSimilarityFactory, SliceStateUpdateTest, DirectUpdateHandlerOptimizeTest, ScriptEngineTest, DocumentBuilderTest, BadComponentTest, TestPhraseSuggestions, TestDistributedGrouping, TestMultiCoreConfBootstrap, TestBinaryResponseWriter, TestBM25SimilarityFactory, DocValuesMultiTest, TestBinaryField, TestReplicationHandler, HighlighterTest, NoCacheHeaderTest, TestSort, DirectUpdateHandlerTest, TestUtils, StandardRequestHandlerTest, AnalysisAfterCoreReloadTest, CurrencyFieldOpenExchangeTest, SpellCheckComponentTest, OutputWriterTest, TestCSVResponseWriter, FastVectorHighlighterTest, QueryEqualityTest, JSONWriterTest, PolyFieldTest, SuggesterTSTTest, XsltUpdateRequestHandlerTest, TestFieldResource, ShardRoutingCustomTest, LukeRequestHandlerTest, CoreContainerCoreInitFailuresTest, SolrRequestParserTest, SolrCoreCheckLockOnStartupTest, CachingDirectoryFactoryTest, TestMergePolicyConfig, CacheHeaderTest, SpellPossibilityIteratorTest, BasicDistributedZk2Test, SimplePostToolTest, TestFastOutputStream, TestTrie, TermsComponentTest, ShardRoutingTest, TestFiltering, TestRealTimeGet, SortByFunctionTest, SuggesterWFSTTest, DistanceFunctionTest, XmlUpdateRequestHandlerTest, AlternateDirectoryTest, SynonymTokenizerTest, HighlighterConfigTest, TestQuerySenderListener, DateMathParserTest, MinimalSchemaTest, TestFunctionQuery, TestPseudoReturnFields, MoreLikeThisHandlerTest, ClusterStateUpdateTest, TestSurroundQueryParser, TestBadConfig, DateFieldTest, IndexSchemaTest, StatelessScriptUpdateProcessorFactoryTest, TestPluginEnable, TestSolrXMLSerializer, TestPostingsSolrHighlighter, TestRandomFaceting, TestLuceneMatchVersion, TestZkChroot, RegexBoostProcessorTest, SuggesterFSTTest, TestFoldingMultitermQuery, TestSolrJ, RequestHandlersTest, SpatialFilterTest, NotRequiredUniqueKeyTest, PreAnalyzedFieldTest, TestCollationField, ShowFileRequestHandlerTest, TestLMJelinekMercerSimilarityFactory, CircularListTest, EchoParamsTest, UpdateRequestProcessorFactoryTest, TestReload, TestExtendedDismaxParser, TimeZoneUtilsTest, ZkSolrClientTest, TestPHPSerializedResponseWriter, ZkNodePropsTest, TestHashPartitioner, TestRangeQuery, DebugComponentTest, MultiTermTest, TestJmxIntegration, TestXIncludeConfig, TestSolr4Spatial, OpenCloseCoreStressTest]
[junit4:junit4] Completed in 85.77s, 6 tests, 1 failure, 4 skipped <<< FAILURES!

[...truncated 435 lines...]
BUILD FAILED
/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/build.xml:375: The following error occurred while executing this line:
/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/build.xml:355: The following error occurred while executing this line:
/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/build.xml:39: The following error occurred while executing this line:
/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build.xml:183: The following error occurred while executing this line:
/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/common-build.xml:449: The following error occurred while executing this line:
/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:1210: The following error occurred while executing this line:
/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:874: There were test failures: 272 suites, 1146 tests, 2 failures, 18 ignored (6 assumptions)

Total time: 70 minutes 16 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Description set: Java: 64bit/jdk1.7.0 -XX:+UseSerialGC
Email was triggered for: Failure
Sending email for trigger: Failure



Mime
View raw message