You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2013/08/07 10:53:29 UTC
[JENKINS] Lucene-Solr-trunk-Linux (64bit/jdk1.8.0-ea-b99) - Build #
6908 - Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/6908/
Java: 64bit/jdk1.8.0-ea-b99 -XX:+UseCompressedOops -XX:+UseSerialGC
2 tests failed.
REGRESSION: org.apache.solr.handler.TestReplicationHandler.doTestIndexAndConfigAliasReplication
Error Message:
timed out waiting for collection1 startAt time to exceed: Wed Aug 07 14:47:33 BTT 2013
Stack Trace:
java.lang.AssertionError: timed out waiting for collection1 startAt time to exceed: Wed Aug 07 14:47:33 BTT 2013
at __randomizedtesting.SeedInfo.seed([287DA0DB6EA11F45:DF0E4E83A849B0A3]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.apache.solr.handler.TestReplicationHandler.watchCoreStartAt(TestReplicationHandler.java:1507)
at org.apache.solr.handler.TestReplicationHandler.doTestIndexAndConfigAliasReplication(TestReplicationHandler.java:1256)
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:491)
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:724)
REGRESSION: org.apache.solr.handler.TestReplicationHandler.doTestStressReplication
Error Message:
timed out waiting for collection1 startAt time to exceed: Wed Aug 07 14:48:10 BTT 2013
Stack Trace:
java.lang.AssertionError: timed out waiting for collection1 startAt time to exceed: Wed Aug 07 14:48:10 BTT 2013
at __randomizedtesting.SeedInfo.seed([287DA0DB6EA11F45:F3D6A01D6B8976F6]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.apache.solr.handler.TestReplicationHandler.watchCoreStartAt(TestReplicationHandler.java:1507)
at org.apache.solr.handler.TestReplicationHandler.doTestStressReplication(TestReplicationHandler.java:811)
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:491)
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:724)
Build Log:
[...truncated 9794 lines...]
[junit4] Suite: org.apache.solr.handler.TestReplicationHandler
[junit4] 2> 655058 T2556 oas.SolrTestCaseJ4.setUp ###Starting doTestReplicateAfterCoreReload
[junit4] 2> 655062 T2556 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 655065 T2556 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:46551
[junit4] 2> 655066 T2556 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 655066 T2556 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 655066 T2556 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master
[junit4] 2> 655066 T2556 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/'
[junit4] 2> 655076 T2556 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/solr.xml
[junit4] 2> 655076 T2556 oasc.ConfigSolr.fromFile /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/solr.xml does not exist, using default configuration
[junit4] 2> 655091 T2556 oasc.CoreContainer.<init> New CoreContainer 801776487
[junit4] 2> 655092 T2556 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/]
[junit4] 2> 655092 T2556 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 655092 T2556 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 655092 T2556 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 655093 T2556 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 655093 T2556 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 655093 T2556 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 655093 T2556 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 655093 T2556 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 655093 T2556 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 655094 T2556 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 655098 T2566 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1
[junit4] 2> 655098 T2566 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1/'
[junit4] 2> 655111 T2566 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4] 2> 655117 T2566 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 655117 T2566 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 655119 T2566 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 655122 T2566 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 655122 T2566 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 655122 T2566 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1/data/
[junit4] 2> 655122 T2566 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 655123 T2566 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1/data
[junit4] 2> 655123 T2566 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1/data/index/
[junit4] 2> 655123 T2566 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 655123 T2566 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1/data/index
[junit4] 2> 655124 T2566 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@1cb977b1 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@34b51f7a),segFN=segments_1,generation=1}
[junit4] 2> 655124 T2566 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 655125 T2566 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 655125 T2566 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 655125 T2566 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 655125 T2566 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 655125 T2566 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 655126 T2566 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 655127 T2566 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 655128 T2566 oass.SolrIndexSearcher.<init> Opening Searcher@1c6dd674 main
[junit4] 2> 655128 T2566 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 655128 T2566 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 655129 T2566 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 655129 T2566 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 655129 T2566 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 655129 T2567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1c6dd674 main{StandardDirectoryReader(segments_1:1)}
[junit4] 2> 655129 T2556 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1
[junit4] 2> 655129 T2556 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 655130 T2556 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> 655134 T2556 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 655136 T2556 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:41081
[junit4] 2> 655137 T2556 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 655137 T2556 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 655137 T2556 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave
[junit4] 2> 655137 T2556 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/'
[junit4] 2> 655145 T2556 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/solr.xml
[junit4] 2> 655146 T2556 oasc.ConfigSolr.fromFile /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/solr.xml does not exist, using default configuration
[junit4] 2> 655159 T2556 oasc.CoreContainer.<init> New CoreContainer 940511998
[junit4] 2> 655160 T2556 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/]
[junit4] 2> 655160 T2556 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 655160 T2556 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 655160 T2556 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 655161 T2556 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 655161 T2556 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 655161 T2556 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 655161 T2556 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 655161 T2556 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 655162 T2556 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 655162 T2556 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 655165 T2578 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1
[junit4] 2> 655165 T2578 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1/'
[junit4] 2> 655178 T2578 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4] 2> 655184 T2578 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 655184 T2578 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 655186 T2578 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 655188 T2578 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 655189 T2578 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 655189 T2578 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1/data/
[junit4] 2> 655189 T2578 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 655189 T2578 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1/data
[junit4] 2> 655189 T2578 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1/data/index/
[junit4] 2> 655190 T2578 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 655190 T2578 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1/data/index
[junit4] 2> 655191 T2578 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@651a4cf5 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@63f0ecd1),segFN=segments_1,generation=1}
[junit4] 2> 655191 T2578 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 655191 T2578 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 655192 T2578 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 655192 T2578 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 655192 T2578 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 655192 T2578 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 655192 T2578 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 655193 T2578 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 655194 T2578 oass.SolrIndexSearcher.<init> Opening Searcher@10dfe546 main
[junit4] 2> 655194 T2578 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 655194 T2578 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 655196 T2578 oash.SnapPuller.startExecutorService Poll Scheduled at an interval of 1000ms
[junit4] 2> 655196 T2578 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 655196 T2579 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@10dfe546 main{StandardDirectoryReader(segments_1:1)}
[junit4] 2> 655196 T2556 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1
[junit4] 2> 655197 T2556 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 655197 T2556 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> 655220 T2556 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=940511998
[junit4] 2> 655221 T2556 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@6bc09629
[junit4] 2> 655222 T2556 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 655222 T2556 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 655222 T2556 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 655222 T2556 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 655223 T2556 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 655223 T2556 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 655223 T2556 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1/data/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1/data/index;done=false>>]
[junit4] 2> 655224 T2556 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1/data/index
[junit4] 2> 655224 T2556 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1/data [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1/data;done=false>>]
[junit4] 2> 655224 T2556 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1/data
[junit4] 2> 655224 T2556 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 655297 T2556 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=801776487
[junit4] 2> 655298 T2556 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@33b193e1
[junit4] 2> 655299 T2556 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 655299 T2556 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 655299 T2556 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 655299 T2556 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 655300 T2556 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 655300 T2556 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 655301 T2556 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1/data/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1/data/index;done=false>>]
[junit4] 2> 655301 T2556 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1/data/index
[junit4] 2> 655301 T2556 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1/data [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1/data;done=false>>]
[junit4] 2> 655301 T2556 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1/data
[junit4] 2> 655302 T2556 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 655353 T2556 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 655356 T2556 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:44314
[junit4] 2> 655356 T2556 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 655356 T2556 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 655356 T2556 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master
[junit4] 2> 655357 T2556 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/'
[junit4] 2> 655364 T2556 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/solr.xml
[junit4] 2> 655365 T2556 oasc.ConfigSolr.fromFile /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/solr.xml does not exist, using default configuration
[junit4] 2> 655378 T2556 oasc.CoreContainer.<init> New CoreContainer 1154747513
[junit4] 2> 655379 T2556 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/]
[junit4] 2> 655379 T2556 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 655379 T2556 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 655379 T2556 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 655380 T2556 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 655380 T2556 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 655380 T2556 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 655380 T2556 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 655380 T2556 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 655381 T2556 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 655381 T2556 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 655384 T2591 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1
[junit4] 2> 655384 T2591 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1/'
[junit4] 2> 655397 T2591 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4] 2> 655402 T2591 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 655403 T2591 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 655405 T2591 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 655407 T2591 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 655407 T2591 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 655407 T2591 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1/data/
[junit4] 2> 655407 T2591 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 655408 T2591 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1/data
[junit4] 2> 655408 T2591 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1/data/index/
[junit4] 2> 655408 T2591 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 655408 T2591 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1/data/index
[junit4] 2> 655409 T2591 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@7680b19b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7596e914),segFN=segments_1,generation=1}
[junit4] 2> 655409 T2591 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 655410 T2591 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 655410 T2591 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 655410 T2591 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 655410 T2591 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 655410 T2591 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 655411 T2591 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 655412 T2591 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 655412 T2591 oass.SolrIndexSearcher.<init> Opening Searcher@26f5fb2b main
[junit4] 2> 655413 T2591 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 655413 T2591 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 655413 T2591 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml
[junit4] 2> 655413 T2591 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@7680b19b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7596e914),segFN=segments_1,generation=1}
[junit4] 2> 655414 T2591 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 655414 T2591 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 655414 T2591 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 655414 T2592 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@26f5fb2b main{StandardDirectoryReader(segments_1:1)}
[junit4] 2> 655414 T2556 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1
[junit4] 2> 655415 T2556 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 655415 T2556 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> ASYNC NEW_CORE C7989 name=collection1 org.apache.solr.core.SolrCore@72f110c5
[junit4] 2> 655418 T2587 C7989 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 655419 T2587 C7989 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:*} 0 1
[junit4] 2> 655421 T2588 C7989 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 655421 T2588 C7989 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@7680b19b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7596e914),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@7680b19b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7596e914),segFN=segments_2,generation=2}
[junit4] 2> 655422 T2588 C7989 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 655422 T2588 C7989 oass.SolrIndexSearcher.<init> Opening Searcher@8a33891 main
[junit4] 2> 655422 T2588 C7989 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 655422 T2592 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@8a33891 main{StandardDirectoryReader(segments_2:2:nrt)}
[junit4] 2> 655423 T2588 C7989 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 2
[junit4] 2> 655427 T2589 C7989 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={sort=id+desc&q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=3
[junit4] 2> 655428 T2556 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 655430 T2556 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:40647
[junit4] 2> 655430 T2556 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 655431 T2556 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 655431 T2556 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave
[junit4] 2> 655431 T2556 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/'
[junit4] 2> 655439 T2556 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/solr.xml
[junit4] 2> 655439 T2556 oasc.ConfigSolr.fromFile /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/solr.xml does not exist, using default configuration
[junit4] 2> 655455 T2556 oasc.CoreContainer.<init> New CoreContainer 1165909361
[junit4] 2> 655455 T2556 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/]
[junit4] 2> 655456 T2556 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 655456 T2556 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 655456 T2556 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 655456 T2556 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 655457 T2556 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 655457 T2556 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 655457 T2556 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 655457 T2556 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 655457 T2556 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 655458 T2556 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 655461 T2603 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1
[junit4] 2> 655461 T2603 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1/'
[junit4] 2> 655474 T2603 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4] 2> 655479 T2603 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 655479 T2603 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 655481 T2603 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 655483 T2603 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 655484 T2603 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 655484 T2603 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1/data/
[junit4] 2> 655484 T2603 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 655484 T2603 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1/data
[junit4] 2> 655484 T2603 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1/data/index/
[junit4] 2> 655485 T2603 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 655485 T2603 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1/data/index
[junit4] 2> 655486 T2603 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@90f2f2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@125d192),segFN=segments_1,generation=1}
[junit4] 2> 655486 T2603 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 655486 T2603 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 655487 T2603 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 655487 T2603 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 655487 T2603 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 655487 T2603 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 655487 T2603 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 655488 T2603 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 655489 T2603 oass.SolrIndexSearcher.<init> Opening Searcher@410ea2b3 main
[junit4] 2> 655489 T2603 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 655489 T2603 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 655490 T2603 oash.SnapPuller.startExecutorService Poll Scheduled at an interval of 1000ms
[junit4] 2> 655490 T2604 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@410ea2b3 main{StandardDirectoryReader(segments_1:1)}
[junit4] 2> 655490 T2603 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 655490 T2556 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1
[junit4] 2> 655491 T2556 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 655491 T2556 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> ASYNC NEW_CORE C7990 name=collection1 org.apache.solr.core.SolrCore@6f17193
[junit4] 2> 655495 T2599 C7990 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={sort=id+desc&q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> ASYNC NEW_CORE C7991 name=collection1 org.apache.solr.core.SolrCore@72f110c5
[junit4] 2> 655497 T2590 C7991 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=indexversion&_trace=getIndexVersion&wt=javabin&qt=/replication&version=2} status=0 QTime=0
[junit4] 2> 655499 T2587 C7991 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=commits&_trace=getCommits&wt=javabin&qt=/replication&version=2} status=0 QTime=0
[junit4] 2> 655501 T2588 oasc.CoreContainer.reload Reloading SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1
[junit4] 2> 655501 T2588 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1/'
[junit4] 2> 655527 T2588 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4] 2> 655533 T2588 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 655533 T2588 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 655536 T2588 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 655538 T2588 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 655539 T2588 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1/data/
[junit4] 2> 655539 T2588 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 655539 T2588 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1/data/index/
[junit4] 2> 655540 T2588 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 655540 T2588 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 655541 T2588 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 655541 T2588 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 655541 T2588 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 655541 T2588 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 655543 T2588 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 655544 T2588 oass.SolrIndexSearcher.<init> Opening Searcher@54dee84a main
[junit4] 2> 655544 T2588 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 655544 T2588 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 655544 T2588 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml
[junit4] 2> 655545 T2588 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 655545 T2588 oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter...
[junit4] 2> 655545 T2607 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@54dee84a main{StandardDirectoryReader(segments_2:2:nrt)}
[junit4] 2> 655545 T2588 oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused... core=collection1
[junit4] 2> 655546 T2588 oasu.DefaultSolrCoreState.newIndexWriter Closing old IndexWriter... core=collection1
[junit4] 2> 655547 T2588 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@7680b19b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7596e914),segFN=segments_2,generation=2}
[junit4] 2> 655547 T2588 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 655548 T2588 oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used.
[junit4] 2> 655548 T2588 oass.SolrIndexSearcher.<init> Opening Searcher@6091ea41 main
[junit4] 2> 655548 T2588 oasc.CoreContainer.registerCore replacing core: collection1
[junit4] 2> 655549 T2588 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@72f110c5
[junit4] 2> 655548 T2607 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6091ea41 main{StandardDirectoryReader(segments_2:2:nrt)}
[junit4] 2> 655549 T2588 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] 2> 655550 T2588 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 655550 T2588 oass.SolrDispatchFilter.handleAdminRequest [admin] webapp=null path=/admin/cores params={action=reload&core=collection1&wt=javabin&qt=/admin/cores&version=2} status=0 QTime=49
[junit4] 2> ASYNC NEW_CORE C7992 name=collection1 org.apache.solr.core.SolrCore@2600e87
[junit4] 2> 655553 T2589 C7992 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=indexversion&_trace=getIndexVersion&wt=javabin&qt=/replication&version=2} status=0 QTime=1
[junit4] 2> 655554 T2590 C7992 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=commits&_trace=getCommits&wt=javabin&qt=/replication&version=2} status=0 QTime=0
[junit4] 2> 655557 T2587 C7992 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[10]} 0 1
[junit4] 2> 655558 T2588 C7992 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[20]} 0 0
[junit4] 2> 655560 T2589 C7992 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 655562 T2589 C7992 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@7680b19b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7596e914),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@7680b19b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7596e914),segFN=segments_3,generation=3}
[junit4] 2> 655562 T2589 C7992 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
[junit4] 2> 655563 T2589 C7992 oass.SolrIndexSearcher.<init> Opening Searcher@13307ac1 main
[junit4] 2> 655564 T2589 C7992 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 655564 T2607 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@13307ac1 main{StandardDirectoryReader(segments_3:4:nrt _0(5.0):C2)}
[junit4] 2> 655564 T2589 C7992 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 4
[junit4] 2> 655566 T2590 C7992 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={sort=id+desc&q=*:*&wt=javabin&version=2} hits=2 status=0 QTime=0
[junit4] 2> ASYNC NEW_CORE C7993 name=collection1 org.apache.solr.core.SolrCore@6f17193
[junit4] 2> 655568 T2600 C7993 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={sort=id+desc&q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> 655569 T2556 oash.TestReplicationHandler.rQuery Waiting for 2 docs
[junit4] 2> 655671 T2601 C7993 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={sort=id+desc&q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=1
[junit4] 2> 655671 T2556 oash.TestReplicationHandler.rQuery Waiting for 2 docs
[junit4] 2> 655683 T2587 C7992 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=indexversion&qt=/replication&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 655683 T2605 oash.SnapPuller.fetchLatestIndex Master's generation: 3
[junit4] 2> 655684 T2605 oash.SnapPuller.fetchLatestIndex Slave's generation: 1
[junit4] 2> 655684 T2605 oash.SnapPuller.fetchLatestIndex Starting replication process
[junit4] 2> 655687 T2588 C7992 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=filelist&qt=/replication&wt=javabin&generation=3&version=2} status=0 QTime=2
[junit4] 2> 655687 T2605 oash.SnapPuller.fetchLatestIndex Number of files in latest index in master: 10
[junit4] 2> 655688 T2605 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1/data/index.20130807144725005
[junit4] 2> 655688 T2605 oash.SnapPuller.fetchLatestIndex Starting download to MockDirWrapper(org.apache.lucene.store.RAMDirectory@35931b65 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@412b95ae) fullCopy=false
[junit4] 2> 655690 T2589 C7992 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0_NestedPulsing_0.doc&command=filecontent&checksum=true&compression=true&wt=filestream&qt=/replication&generation=3} status=0 QTime=0
[junit4] 2> 655693 T2590 C7992 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.fnm&command=filecontent&checksum=true&compression=true&wt=filestream&qt=/replication&generation=3} status=0 QTime=0
[junit4] 2> 655695 T2587 C7992 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.nvd&command=filecontent&checksum=true&compression=true&wt=filestream&qt=/replication&generation=3} status=0 QTime=0
[junit4] 2> 655698 T2588 C7992 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.fdx&command=filecontent&checksum=true&compression=true&wt=filestream&qt=/replication&generation=3} status=0 QTime=0
[junit4] 2> 655700 T2589 C7992 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.nvm&command=filecontent&checksum=true&compression=true&wt=filestream&qt=/replication&generation=3} status=0 QTime=0
[junit4] 2> 655702 T2590 C7992 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0_NestedPulsing_0.tip&command=filecontent&checksum=true&compression=true&wt=filestream&qt=/replication&generation=3} status=0 QTime=0
[junit4] 2> 655705 T2587 C7992 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.si&command=filecontent&checksum=true&compression=true&wt=filestream&qt=/replication&generation=3} status=0 QTime=0
[junit4] 2> 655707 T2588 C7992 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=segments_3&command=filecontent&checksum=true&compression=true&wt=filestream&qt=/replication&generation=3} status=0 QTime=0
[junit4] 2> ASYNC NEW_CORE C7994 name=collection1 org.apache.solr.core.SolrCore@2600e87
[junit4] 2> 655722 T2589 C7994 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.fdt&command=filecontent&checksum=true&compression=true&wt=filestream&qt=/replication&generation=3} status=0 QTime=0
[junit4] 2> 655724 T2590 C7994 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0_NestedPulsing_0.tim&command=filecontent&checksum=true&compression=true&wt=filestream&qt=/replication&generation=3} status=0 QTime=0
[junit4] 2> 655725 T2605 oash.SnapPuller.fetchLatestIndex Total time taken for download : 0 secs
[junit4] 2> 655726 T2605 oasu.DefaultSolrCoreState.closeIndexWriter Closing IndexWriter...
[junit4] 2> 655726 T2605 oasu.DefaultSolrCoreState.closeIndexWriter Waiting until IndexWriter is unused... core=collection1
[junit4] 2> 655726 T2605 oasu.DefaultSolrCoreState.openIndexWriter Creating new IndexWriter...
[junit4] 2> 655727 T2605 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=2
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@90f2f2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@125d192),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@90f2f2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@125d192),segFN=segments_3,generation=3}
[junit4] 2> 655728 T2605 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
[junit4] 2> 655728 T2605 oasu.DefaultSolrCoreState.openIndexWriter New IndexWriter is ready to be used.
[junit4] 2> 655729 T2605 oass.SolrIndexSearcher.<init> Opening Searcher@57611b67 main
[junit4] 2> 655729 T2604 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@57611b67 main{StandardDirectoryReader(segments_3:4:nrt _0(5.0):C2)}
[junit4] 2> 655729 T2605 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1/data/index.20130807144725005 [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1/data/index.20130807144725005;done=true>>]
[junit4] 2> 655729 T2605 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1/data/index.20130807144725005
[junit4] 2> ASYNC NEW_CORE C7995 name=collection1 org.apache.solr.core.SolrCore@6f17193
[junit4] 2> 655773 T2602 C7995 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={sort=id+desc&q=*:*&wt=javabin&version=2} hits=2 status=0 QTime=0
[junit4] 2> 655774 T2556 oas.SolrTestCaseJ4.tearDown ###Ending doTestReplicateAfterCoreReload
[junit4] 2> 655795 T2556 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1154747513
[junit4] 2> 655796 T2556 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@2600e87
[junit4] 2> 655796 T2556 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=2,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 655796 T2556 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 655797 T2556 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 655797 T2556 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 655798 T2556 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 655798 T2556 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 655798 T2556 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1/data [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1/data;done=false>>]
[junit4] 2> 655798 T2556 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1/data
[junit4] 2> 655799 T2556 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1/data/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1/data/index;done=false>>]
[junit4] 2> 655799 T2556 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244377/master/collection1/data/index
[junit4] 2> 655799 T2556 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 655871 T2556 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1165909361
[junit4] 2> 655872 T2556 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@6f17193
[junit4] 2> 655873 T2556 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 655873 T2556 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 655873 T2556 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 655873 T2556 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 655874 T2556 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 655875 T2556 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 655875 T2556 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1/data/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1/data/index;done=false>>]
[junit4] 2> 655875 T2556 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1/data/index
[junit4] 2> 655875 T2556 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1/data [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1/data;done=false>>]
[junit4] 2> 655876 T2556 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865244450/slave/collection1/data
[junit4] 2> 655876 T2556 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 655933 T2556 oas.SolrTestCaseJ4.setUp ###Starting doTestReplicateAfterStartup
[junit4] 2> 655936 T2556 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 655937 T2556 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:50251
[junit4] 2> 655938 T2556 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 655938 T2556 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 655938 T2556 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245251/master
[junit4] 2> 655939 T2556 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245251/master/'
[junit4] 2> 655948 T2556 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245251/master/solr.xml
[junit4] 2> 655949 T2556 oasc.ConfigSolr.fromFile /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245251/master/solr.xml does not exist, using default configuration
[junit4] 2> 655954 T2556 oasc.CoreContainer.<init> New CoreContainer 147338993
[junit4] 2> 655955 T2556 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245251/master/]
[junit4] 2> 655955 T2556 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 655955 T2556 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 655955 T2556 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 655956 T2556 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 655956 T2556 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 655956 T2556 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 655956 T2556 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 655956 T2556 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 655957 T2556 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 655957 T2556 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 655961 T2618 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245251/master/collection1
[junit4] 2> 655961 T2618 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245251/master/collection1/'
[junit4] 2> 655974 T2618 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4] 2> 655987 T2618 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 655987 T2618 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 655990 T2618 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 655992 T2618 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 655992 T2618 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 655992 T2618 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245251/master/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245251/master/collection1/data/
[junit4] 2> 655992 T2618 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 655993 T2618 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245251/master/collection1/data
[junit4] 2> 655993 T2618 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245251/master/collection1/data/index/
[junit4] 2> 655993 T2618 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245251/master/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 655993 T2618 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245251/master/collection1/data/index
[junit4] 2> 655994 T2618 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@6c818775 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2092cc54),segFN=segments_1,generation=1}
[junit4] 2> 655994 T2618 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 655995 T2618 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 655995 T2618 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 655995 T2618 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 655995 T2618 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 655995 T2618 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 655996 T2618 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 655997 T2618 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 655998 T2618 oass.SolrIndexSearcher.<init> Opening Searcher@37ff85dd main
[junit4] 2> 655998 T2618 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 655998 T2618 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 655999 T2618 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 655999 T2618 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 655999 T2619 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@37ff85dd main{StandardDirectoryReader(segments_1:1)}
[junit4] 2> 655999 T2618 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 655999 T2556 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1
[junit4] 2> 656000 T2556 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 656000 T2556 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> 656004 T2556 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 656006 T2556 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:35092
[junit4] 2> 656007 T2556 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 656007 T2556 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 656007 T2556 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245320/slave
[junit4] 2> 656007 T2556 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245320/slave/'
[junit4] 2> 656015 T2556 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245320/slave/solr.xml
[junit4] 2> 656016 T2556 oasc.ConfigSolr.fromFile /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245320/slave/solr.xml does not exist, using default configuration
[junit4] 2> 656021 T2556 oasc.CoreContainer.<init> New CoreContainer 1210235756
[junit4] 2> 656021 T2556 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245320/slave/]
[junit4] 2> 656021 T2556 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 656022 T2556 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 656022 T2556 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 656022 T2556 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 656022 T2556 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 656022 T2556 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 656023 T2556 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 656023 T2556 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 656023 T2556 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 656023 T2556 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 656026 T2630 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245320/slave/collection1
[junit4] 2> 656027 T2630 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245320/slave/collection1/'
[junit4] 2> 656039 T2630 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4] 2> 656052 T2630 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 656052 T2630 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 656054 T2630 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 656056 T2630 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 656056 T2630 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 656057 T2630 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245320/slave/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245320/slave/collection1/data/
[junit4] 2> 656057 T2630 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 656057 T2630 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245320/slave/collection1/data
[junit4] 2> 656057 T2630 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245320/slave/collection1/data/index/
[junit4] 2> 656057 T2630 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245320/slave/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 656058 T2630 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245320/slave/collection1/data/index
[junit4] 2> 656058 T2630 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@39f1896e lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3e220175),segFN=segments_1,generation=1}
[junit4] 2> 656058 T2630 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 656059 T2630 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 656059 T2630 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 656059 T2630 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 656060 T2630 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 656060 T2630 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 656060 T2630 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 656061 T2630 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 656062 T2630 oass.SolrIndexSearcher.<init> Opening Searcher@63c10b98 main
[junit4] 2> 656062 T2630 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 656062 T2630 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 656062 T2630 oash.SnapPuller.startExecutorService Poll Scheduled at an interval of 1000ms
[junit4] 2> 656063 T2630 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 656063 T2631 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@63c10b98 main{StandardDirectoryReader(segments_1:1)}
[junit4] 2> 656063 T2556 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1
[junit4] 2> 656063 T2556 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 656064 T2556 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> 656086 T2556 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1210235756
[junit4] 2> 656087 T2556 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@24992c02
[junit4] 2> 656087 T2556 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 656087 T2556 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 656088 T2556 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 656088 T2556 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 656088 T2556 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 656089 T2556 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 656089 T2556 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245320/slave/collection1/data/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245320/slave/collection1/data/index;done=false>>]
[junit4] 2> 656089 T2556 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245320/slave/collection1/data/index
[junit4] 2> 656089 T2556 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245320/slave/collection1/data [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245320/slave/collection1/data;done=false>>]
[junit4] 2> 656089 T2556 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245320/slave/collection1/data
[junit4] 2> 656090 T2556 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> ASYNC NEW_CORE C7996 name=collection1 org.apache.solr.core.SolrCore@692a53e2
[junit4] 2> 656143 T2614 C7996 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 656144 T2614 C7996 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@6c818775 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2092cc54),segFN=segments_1,generation=1}
[junit4] 2> 656145 T2614 C7996 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 656145 T2614 C7996 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:*} 0 2
[junit4] 2> 656147 T2615 C7996 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 656147 T2615 C7996 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@6c818775 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2092cc54),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@6c818775 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2092cc54),segFN=segments_2,generation=2}
[junit4] 2> 656148 T2615 C7996 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 656148 T2615 C7996 oass.SolrIndexSearcher.<init> Opening Searcher@b355103 main
[junit4] 2> 656148 T2615 C7996 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 656148 T2619 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@b355103 main{StandardDirectoryReader(segments_2:2:nrt)}
[junit4] 2> 656149 T2615 C7996 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 2
[junit4] 2> 656170 T2556 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=147338993
[junit4] 2> 656171 T2556 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@692a53e2
[junit4] 2> 656171 T2556 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] 2> 656171 T2556 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 656172 T2556 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 656172 T2556 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 656172 T2556 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 656173 T2556 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 656173 T2556 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245251/master/collection1/data [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865245251/master/collection1/data;done=false>>]
[junit4] 2>
[...truncated too long message...]
as.SolrTestCaseJ4.tearDown ###Ending doTestReplicateAfterWrite2Slave
[junit4] 2> 742812 T2556 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1243228644
[junit4] 2> 742813 T3227 oahic.DefaultRequestDirector.tryExecute I/O exception (org.apache.http.NoHttpResponseException) caught when processing request: The target server failed to respond
[junit4] 2> 742813 T3227 oahic.DefaultRequestDirector.tryExecute Retrying request
[junit4] 2> 742813 T2556 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@2dbc2ad5
[junit4] 2> 742814 T2556 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=492,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 742814 T3227 oash.SnapPuller.fetchLatestIndex ERROR Master at: http://127.0.0.1:52296/solr is not available. Index fetch failed. Exception: org.apache.solr.client.solrj.SolrServerException: Server refused connection at: http://127.0.0.1:52296/solr
[junit4] 2> 742814 T2556 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 742815 T2556 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 742815 T2556 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 742817 T2556 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 742817 T2556 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 742817 T2556 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865330909/master/collection1/data [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865330909/master/collection1/data;done=false>>]
[junit4] 2> 742818 T2556 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865330909/master/collection1/data
[junit4] 2> 742818 T2556 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865330909/master/collection1/data/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865330909/master/collection1/data/index;done=false>>]
[junit4] 2> 742819 T2556 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865330909/master/collection1/data/index
[junit4] 2> 742819 T2556 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 742891 T2556 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1942884872
[junit4] 2> 742892 T2556 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@3d9d8d86
[junit4] 2> 742892 T2556 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=5,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=5,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 742893 T2556 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 742893 T2556 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 742893 T2556 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 742894 T2556 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 742895 T2556 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 742895 T2556 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865331006/slave/collection1/data/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865331006/slave/collection1/data/index;done=false>>]
[junit4] 2> 742896 T2556 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865331006/slave/collection1/data/index
[junit4] 2> 742896 T2556 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865331006/slave/collection1/data [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865331006/slave/collection1/data;done=false>>]
[junit4] 2> 742896 T2556 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1375865331006/slave/collection1/data
[junit4] 2> 742897 T2556 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 742953 T2556 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: test params are: codec=Lucene42: {newname=PostingsFormat(name=NestedPulsing), id=PostingsFormat(name=NestedPulsing), name=PostingsFormat(name=NestedPulsing)}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=false,coord=crazy): {}, locale=sr_RS, timezone=Asia/Thimphu
[junit4] 2> NOTE: Linux 3.8.0-27-generic amd64/Oracle Corporation 1.8.0-ea (64-bit)/cpus=8,threads=1,free=92633824,total=182706176
[junit4] 2> NOTE: All tests run in this JVM: [TestFuzzyAnalyzedSuggestions, TestReloadAndDeleteDocs, PingRequestHandlerTest, SuggesterTSTTest, SignatureUpdateProcessorFactoryTest, TestRangeQuery, TestCSVResponseWriter, TestDistributedSearch, DocValuesMultiTest, TestRecovery, TestAnalyzedSuggestions, TestSolr4Spatial, TestPluginEnable, TestPartialUpdateDeduplication, IndexSchemaRuntimeFieldTest, OpenExchangeRatesOrgProviderTest, TestRandomMergePolicy, CoreContainerCoreInitFailuresTest, UniqFieldsUpdateProcessorFactoryTest, HdfsLockFactoryTest, FullSolrCloudDistribCmdsTest, TestIndexSearcher, TestFoldingMultitermQuery, TestStressLucene, HdfsUnloadDistributedZkTest, DisMaxRequestHandlerTest, TestFastWriter, HdfsCollectionsAPIDistributedZkTest, TestManagedSchema, DocumentAnalysisRequestHandlerTest, ShardSplitTest, QueryResultKeyTest, TestCollationField, MultiTermTest, SolrCoreCheckLockOnStartupTest, TestSweetSpotSimilarityFactory, TestIBSimilarityFactory, PluginInfoTest, TestPhraseSuggestions, RequestHandlersTest, TestReload, AlternateDirectoryTest, NotRequiredUniqueKeyTest, DebugComponentTest, ShardRoutingCustomTest, BadIndexSchemaTest, TestSolrDeletionPolicy2, MinimalSchemaTest, TestAddFieldRealTimeGet, DirectSolrSpellCheckerTest, TermVectorComponentDistributedTest, NumericFieldsTest, DefaultValueUpdateProcessorTest, DateMathParserTest, PreAnalyzedFieldTest, TestSchemaResource, SolrIndexConfigTest, HdfsSyncSliceTest, HdfsBasicDistributedZk2Test, BadCopyFieldTest, HdfsRecoveryZkTest, SortByFunctionTest, TestInfoStreamLogging, TestSchemaSimilarityResource, CircularListTest, BasicDistributedZk2Test, TestFiltering, TestQuerySenderListener, TestSolrCoreProperties, TestFieldCollectionResource, TestCopyFieldCollectionResource, OutputWriterTest, SpellingQueryConverterTest, SolrCmdDistributorTest, TestZkChroot, ChaosMonkeySafeLeaderTest, UnloadDistributedZkTest, SyncSliceTest, OpenCloseCoreStressTest, LeaderElectionIntegrationTest, ShardRoutingTest, TestReplicationHandler]
[junit4] Completed on J1 in 87.92s, 14 tests, 2 failures <<< FAILURES!
[...truncated 463 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:389: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:369: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:39: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build.xml:181: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/common-build.xml:449: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:1230: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:873: There were test failures: 317 suites, 1343 tests, 2 failures, 36 ignored (6 assumptions)
Total time: 35 minutes 16 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 64bit/jdk1.8.0-ea-b99 -XX:+UseCompressedOops -XX:+UseSerialGC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure