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/17 11:39:56 UTC
[JENKINS] Lucene-Solr-4.x-Linux (64bit/jdk1.8.0-ea-b102) - Build #
6966 - Still Failing!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Linux/6966/
Java: 64bit/jdk1.8.0-ea-b102 -XX:-UseCompressedOops -XX:+UseG1GC
1 tests failed.
REGRESSION: org.apache.solr.handler.TestReplicationHandler.doTestStressReplication
Error Message:
timed out waiting for collection1 startAt time to exceed: Sat Aug 17 05:33:40 AST 2013
Stack Trace:
java.lang.AssertionError: timed out waiting for collection1 startAt time to exceed: Sat Aug 17 05:33:40 AST 2013
at __randomizedtesting.SeedInfo.seed([29FA4CC2FB396F45:F2514C04FE1106F6]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.apache.solr.handler.TestReplicationHandler.watchCoreStartAt(TestReplicationHandler.java:1513)
at org.apache.solr.handler.TestReplicationHandler.doTestStressReplication(TestReplicationHandler.java:817)
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 9944 lines...]
[junit4] Suite: org.apache.solr.handler.TestReplicationHandler
[junit4] 2> 537591 T1542 oas.SolrTestCaseJ4.setUp ###Starting testNoWriter
[junit4] 2> 537595 T1542 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 537597 T1542 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:44500
[junit4] 2> 537598 T1542 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 537598 T1542 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 537598 T1542 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master
[junit4] 2> 537599 T1542 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/'
[junit4] 2> 537616 T1542 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/solr.xml
[junit4] 2> 537617 T1542 oasc.ConfigSolr.fromFile /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/solr.xml does not exist, using default configuration
[junit4] 2> 537627 T1542 oasc.CoreContainer.<init> New CoreContainer 995755945
[junit4] 2> 537628 T1542 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/]
[junit4] 2> 537628 T1542 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 537629 T1542 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 537629 T1542 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 537629 T1542 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 537630 T1542 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 537630 T1542 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 537630 T1542 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 537631 T1542 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 537631 T1542 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 537631 T1542 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 537637 T1552 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/collection1
[junit4] 2> 537638 T1552 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/collection1/'
[junit4] 2> 537655 T1552 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_45
[junit4] 2> 537662 T1552 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 537662 T1552 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 537664 T1552 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 537667 T1552 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 537668 T1552 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 537668 T1552 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/collection1/data/
[junit4] 2> 537668 T1552 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 537669 T1552 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/collection1/data
[junit4] 2> 537669 T1552 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/collection1/data/index/
[junit4] 2> 537669 T1552 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 537670 T1552 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/collection1/data/index
[junit4] 2> 537670 T1552 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=38, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8267677479279375]
[junit4] 2> 537671 T1552 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@413a4761 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@14c8f788; maxCacheMB=0.2314453125 maxMergeSizeMB=0.7568359375)),segFN=segments_1,generation=1}
[junit4] 2> 537671 T1552 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 537672 T1552 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 537672 T1552 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 537673 T1552 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 537673 T1552 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 537673 T1552 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 537673 T1552 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 537673 T1552 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 537675 T1552 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 537676 T1552 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 537676 T1552 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 537676 T1552 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=36, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4285780737803514]
[junit4] 2> 537676 T1552 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@413a4761 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@14c8f788; maxCacheMB=0.2314453125 maxMergeSizeMB=0.7568359375)),segFN=segments_1,generation=1}
[junit4] 2> 537677 T1552 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 537677 T1552 oass.SolrIndexSearcher.<init> Opening Searcher@3cf6ccdc main
[junit4] 2> 537677 T1552 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 537677 T1552 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 537677 T1552 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 537677 T1553 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3cf6ccdc main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 537678 T1542 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0
[junit4] 2> 537678 T1542 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 537678 T1542 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> 537683 T1542 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 537685 T1542 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:34952
[junit4] 2> 537685 T1542 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 537686 T1542 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 537686 T1542 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave
[junit4] 2> 537686 T1542 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/'
[junit4] 2> 537694 T1542 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/solr.xml
[junit4] 2> 537695 T1542 oasc.ConfigSolr.fromFile /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/solr.xml does not exist, using default configuration
[junit4] 2> 537702 T1542 oasc.CoreContainer.<init> New CoreContainer 280754709
[junit4] 2> 537702 T1542 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/]
[junit4] 2> 537703 T1542 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 537703 T1542 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 537703 T1542 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 537703 T1542 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 537704 T1542 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 537704 T1542 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 537704 T1542 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 537704 T1542 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 537704 T1542 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 537705 T1542 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 537708 T1564 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1
[junit4] 2> 537709 T1564 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/'
[junit4] 2> 537723 T1564 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_45
[junit4] 2> 537730 T1564 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 537730 T1564 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 537732 T1564 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 537734 T1564 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 537735 T1564 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 537735 T1564 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data/
[junit4] 2> 537735 T1564 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 537736 T1564 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data
[junit4] 2> 537736 T1564 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data/index/
[junit4] 2> 537736 T1564 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 537736 T1564 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data/index
[junit4] 2> 537742 T1564 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=38, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8267677479279375]
[junit4] 2> 537743 T1564 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@f5d2ae9 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5d850ec9; maxCacheMB=0.2314453125 maxMergeSizeMB=0.7568359375)),segFN=segments_1,generation=1}
[junit4] 2> 537743 T1564 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 537744 T1564 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 537744 T1564 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 537744 T1564 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 537744 T1564 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 537744 T1564 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 537745 T1564 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 537745 T1564 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 537746 T1564 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 537747 T1564 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 537747 T1564 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 537747 T1564 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=36, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4285780737803514]
[junit4] 2> 537748 T1564 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@f5d2ae9 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5d850ec9; maxCacheMB=0.2314453125 maxMergeSizeMB=0.7568359375)),segFN=segments_1,generation=1}
[junit4] 2> 537748 T1564 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 537748 T1564 oass.SolrIndexSearcher.<init> Opening Searcher@3c615291 main
[junit4] 2> 537750 T1564 oash.SnapPuller.startExecutorService Poll Scheduled at an interval of 1000ms
[junit4] 2> 537750 T1565 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3c615291 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 537750 T1564 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 537751 T1542 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0
[junit4] 2> 537751 T1542 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 537751 T1542 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> 537775 T1542 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=280754709
[junit4] 2> 537775 T1542 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@2a3b0e44
[junit4] 2> 537776 T1542 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> 537776 T1542 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 537776 T1542 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 537776 T1542 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 537777 T1542 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 537777 T1542 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 537778 T1542 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data;done=false>>]
[junit4] 2> 537778 T1542 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data
[junit4] 2> 537778 T1542 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data/index;done=false>>]
[junit4] 2> 537779 T1542 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data/index
[junit4] 2> 537779 T1542 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 537852 T1542 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=995755945
[junit4] 2> 537852 T1542 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@6fb834ea
[junit4] 2> 537853 T1542 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> 537853 T1542 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 537853 T1542 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 537853 T1542 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 537854 T1542 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 537854 T1542 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 537855 T1542 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/collection1/data/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/collection1/data/index;done=false>>]
[junit4] 2> 537855 T1542 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/collection1/data/index
[junit4] 2> 537855 T1542 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/collection1/data [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/collection1/data;done=false>>]
[junit4] 2> 537855 T1542 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/collection1/data
[junit4] 2> 537856 T1542 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 537908 T1542 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 537910 T1542 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:34952
[junit4] 2> 537910 T1542 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 537911 T1542 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 537911 T1542 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave
[junit4] 2> 537911 T1542 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/'
[junit4] 2> 537919 T1542 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/solr.xml
[junit4] 2> 537920 T1542 oasc.ConfigSolr.fromFile /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/solr.xml does not exist, using default configuration
[junit4] 2> 537927 T1542 oasc.CoreContainer.<init> New CoreContainer 1674563932
[junit4] 2> 537928 T1542 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/]
[junit4] 2> 537928 T1542 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 537929 T1542 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 537929 T1542 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 537929 T1542 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 537930 T1542 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 537930 T1542 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 537930 T1542 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 537930 T1542 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 537931 T1542 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 537931 T1542 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 537935 T1577 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1
[junit4] 2> 537935 T1577 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/'
[junit4] 2> 537972 T1577 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_45
[junit4] 2> 537980 T1577 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 537980 T1577 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 537982 T1577 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 537984 T1577 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 537985 T1577 oasc.SolrCore.initDirectoryFactory solr.NRTCachingDirectoryFactory
[junit4] 2> 537985 T1577 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data/
[junit4] 2> 537985 T1577 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 537986 T1577 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data
[junit4] 2> 537986 T1577 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data/index/
[junit4] 2> 537986 T1577 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 537986 T1577 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data/index
[junit4] 2> 537987 T1577 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=29, maxMergeAtOnceExplicit=19, maxMergedSegmentMB=32.4892578125, floorSegmentMB=1.7138671875, forceMergeDeletesPctAllowed=6.967983838744331, segmentsPerTier=34.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.2888640138225719
[junit4] 2> 537998 T1577 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=NRTCachingDirectory(org.apache.lucene.store.MMapDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@180ce8c4; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
[junit4] 2> 537998 T1577 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 537999 T1577 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 537999 T1577 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 537999 T1577 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 537999 T1577 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 537999 T1577 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 538000 T1577 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 538000 T1577 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 538001 T1577 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 538002 T1577 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 538002 T1577 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 538003 T1577 oass.SolrIndexSearcher.<init> Opening Searcher@2b5ad548 main
[junit4] 2> 538003 T1577 oash.SnapPuller.startExecutorService Poll Scheduled at an interval of 1000ms
[junit4] 2> 538003 T1577 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 538003 T1578 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2b5ad548 main{StandardDirectoryReader(segments_1:1)}
[junit4] 2> 538004 T1542 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0
[junit4] 2> 538004 T1542 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 538005 T1542 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 538006 T1542 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:44500
[junit4] 2> 538006 T1542 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 538007 T1542 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 538007 T1542 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master
[junit4] 2> 538007 T1542 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/'
[junit4] 2> 538017 T1542 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/solr.xml
[junit4] 2> 538018 T1542 oasc.ConfigSolr.fromFile /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/solr.xml does not exist, using default configuration
[junit4] 2> 538025 T1542 oasc.CoreContainer.<init> New CoreContainer 1983294002
[junit4] 2> 538026 T1542 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/]
[junit4] 2> 538026 T1542 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 538026 T1542 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 538027 T1542 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 538027 T1542 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 538027 T1542 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 538027 T1542 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 538027 T1542 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 538028 T1542 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 538028 T1542 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 538028 T1542 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 538032 T1590 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/collection1
[junit4] 2> 538032 T1590 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/collection1/'
[junit4] 2> 538046 T1590 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_45
[junit4] 2> 538053 T1590 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 538054 T1590 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 538055 T1590 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 538058 T1590 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 538059 T1590 oasc.SolrCore.initDirectoryFactory solr.NRTCachingDirectoryFactory
[junit4] 2> 538059 T1590 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/collection1/data/
[junit4] 2> 538059 T1590 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 538060 T1590 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/collection1/data
[junit4] 2> 538060 T1590 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/collection1/data/index/
[junit4] 2> 538060 T1590 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 538060 T1590 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/collection1/data/index
[junit4] 2> 538061 T1590 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=29, maxMergeAtOnceExplicit=19, maxMergedSegmentMB=32.4892578125, floorSegmentMB=1.7138671875, forceMergeDeletesPctAllowed=6.967983838744331, segmentsPerTier=34.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.2888640138225719
[junit4] 2> 538064 T1590 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=NRTCachingDirectory(org.apache.lucene.store.MMapDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/collection1/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@471988e0; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
[junit4] 2> 538064 T1590 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 538065 T1590 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 538065 T1590 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 538065 T1590 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 538065 T1590 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 538065 T1590 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 538066 T1590 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 538066 T1590 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 538067 T1590 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 538068 T1590 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 538068 T1590 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 538069 T1590 oass.SolrIndexSearcher.<init> Opening Searcher@6c8b740d main
[junit4] 2> 538069 T1590 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 538069 T1590 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 538069 T1590 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 538069 T1591 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6c8b740d main{StandardDirectoryReader(segments_1:1)}
[junit4] 2> 538070 T1542 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0
[junit4] 2> 538070 T1542 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> ASYNC NEW_CORE C569 name=collection1 org.apache.solr.core.SolrCore@3495544e
[junit4] 2> 538073 T1573 C569 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=29, maxMergeAtOnceExplicit=19, maxMergedSegmentMB=32.4892578125, floorSegmentMB=1.7138671875, forceMergeDeletesPctAllowed=6.967983838744331, segmentsPerTier=34.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.2888640138225719
[junit4] 2> 538074 T1573 C569 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=NRTCachingDirectory(org.apache.lucene.store.MMapDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@180ce8c4; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
[junit4] 2> 538074 T1573 C569 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 538075 T1573 C569 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[123456]} 0 3
[junit4] 2> 538077 T1574 C569 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 538096 T1574 C569 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=NRTCachingDirectory(org.apache.lucene.store.MMapDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@180ce8c4; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=NRTCachingDirectory(org.apache.lucene.store.MMapDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@180ce8c4; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_2,generation=2}
[junit4] 2> 538096 T1574 C569 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 538099 T1574 C569 oass.SolrIndexSearcher.<init> Opening Searcher@300cb46a main
[junit4] 2> 538099 T1574 C569 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 538099 T1578 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@300cb46a main{StandardDirectoryReader(segments_2:3 _0(4.5):C1)}
[junit4] 2> 538099 T1574 C569 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 22
[junit4] 2> 538121 T1542 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1674563932
[junit4] 2> 538122 T1542 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@3495544e
[junit4] 2> 538123 T1542 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=1,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 538123 T1542 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 538123 T1542 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 538123 T1542 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 538125 T1542 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 538125 T1542 oasc.CachingDirectoryFactory.close Closing NRTCachingDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 538125 T1542 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data/index;done=false>>]
[junit4] 2> 538126 T1542 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data/index
[junit4] 2> 538126 T1542 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data;done=false>>]
[junit4] 2> 538126 T1542 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data
[junit4] 2> 538127 T1542 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 538178 T1542 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 538180 T1542 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:34952
[junit4] 2> 538180 T1542 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 538181 T1542 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 538181 T1542 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave
[junit4] 2> 538181 T1542 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/'
[junit4] 2> 538193 T1542 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/solr.xml
[junit4] 2> 538194 T1542 oasc.ConfigSolr.fromFile /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/solr.xml does not exist, using default configuration
[junit4] 2> 538201 T1542 oasc.CoreContainer.<init> New CoreContainer 775328551
[junit4] 2> 538202 T1542 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/]
[junit4] 2> 538202 T1542 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 538202 T1542 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 538202 T1542 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 538203 T1542 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 538203 T1542 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 538203 T1542 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 538203 T1542 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 538203 T1542 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 538204 T1542 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 538204 T1542 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 538208 T1602 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1
[junit4] 2> 538208 T1602 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/'
[junit4] 2> 538222 T1602 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_45
[junit4] 2> 538229 T1602 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 538229 T1602 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 538231 T1602 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 538234 T1602 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 538234 T1602 oasc.SolrCore.initDirectoryFactory solr.NRTCachingDirectoryFactory
[junit4] 2> 538234 T1602 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data/
[junit4] 2> 538235 T1602 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 538235 T1602 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data
[junit4] 2> 538235 T1602 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data/index/
[junit4] 2> 538236 T1602 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 538236 T1602 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 538236 T1602 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 538236 T1602 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 538236 T1602 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 538236 T1602 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 538237 T1602 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 538238 T1602 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 538239 T1602 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 538239 T1602 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 538239 T1602 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data/index
[junit4] 2> 538241 T1602 oass.SolrIndexSearcher.<init> Opening Searcher@767e2321 main
[junit4] 2> 538241 T1602 oash.SnapPuller.startExecutorService Poll Scheduled at an interval of 1000ms
[junit4] 2> 538241 T1602 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 538241 T1603 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@767e2321 main{StandardDirectoryReader(segments_2:3 _0(4.5):C1)}
[junit4] 2> 538242 T1542 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0
[junit4] 2> 538242 T1542 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 538248 T1606 oash.SnapPuller.<init> WARN 'masterUrl' must be specified without the /replication suffix
[junit4] 2> 538248 T1606 oash.SnapPuller.<init> No value set for 'pollInterval'. Timer Task not started.
[junit4] 2> ASYNC NEW_CORE C570 name=collection1 org.apache.solr.core.SolrCore@78000391
[junit4] 2> 538250 T1586 C570 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=indexversion&qt=/replication&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> ASYNC NEW_CORE C571 name=collection1 org.apache.solr.core.SolrCore@37c1eef5
[junit4] 2> 538251 T1598 C571 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={masterUrl=http://127.0.0.1:44500/solr/replication&command=fetchindex&wait=true} status=0 QTime=7
[junit4] 2> 538253 T1542 oas.SolrTestCaseJ4.tearDown ###Ending testNoWriter
[junit4] 2> 538276 T1542 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1983294002
[junit4] 2> 538277 T1542 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@78000391
[junit4] 2> 538277 T1542 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> 538277 T1542 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 538278 T1542 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 538278 T1542 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 538278 T1542 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 538279 T1542 oasc.CachingDirectoryFactory.close Closing NRTCachingDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 538279 T1542 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/collection1/data [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/collection1/data;done=false>>]
[junit4] 2> 538279 T1542 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/collection1/data
[junit4] 2> 538279 T1542 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/collection1/data/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/collection1/data/index;done=false>>]
[junit4] 2> 538280 T1542 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015201/master/collection1/data/index
[junit4] 2> 538280 T1542 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 538353 T1542 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=775328551
[junit4] 2> 538354 T1542 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@37c1eef5
[junit4] 2> 538354 T1542 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> 538354 T1542 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 538355 T1542 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 538355 T1542 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 538355 T1542 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 538356 T1542 oasc.CachingDirectoryFactory.close Closing NRTCachingDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 538356 T1542 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data;done=false>>]
[junit4] 2> 538356 T1542 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data
[junit4] 2> 538357 T1542 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data/index;done=false>>]
[junit4] 2> 538357 T1542 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732015289/slave/collection1/data/index
[junit4] 2> 538357 T1542 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 538415 T1542 oas.SolrTestCaseJ4.setUp ###Starting testEmptyCommits
[junit4] 2> 538418 T1542 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 538419 T1542 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:39100
[junit4] 2> 538420 T1542 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 538420 T1542 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 538420 T1542 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732016024/master
[junit4] 2> 538420 T1542 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732016024/master/'
[junit4] 2> 538430 T1542 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732016024/master/solr.xml
[junit4] 2> 538431 T1542 oasc.ConfigSolr.fromFile /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732016024/master/solr.xml does not exist, using default configuration
[junit4] 2> 538439 T1542 oasc.CoreContainer.<init> New CoreContainer 2143523648
[junit4] 2> 538439 T1542 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732016024/master/]
[junit4] 2> 538439 T1542 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 538440 T1542 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 538440 T1542 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 538440 T1542 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 538440 T1542 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 538440 T1542 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 538441 T1542 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 538441 T1542 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 538441 T1542 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 538441 T1542 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 538445 T1617 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732016024/master/collection1
[junit4] 2> 538446 T1617 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732016024/master/collection1/'
[junit4] 2> 538459 T1617 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_45
[junit4] 2> 538496 T1617 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 538496 T1617 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 538498 T1617 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 538501 T1617 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 538501 T1617 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 538501 T1617 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732016024/master/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732016024/master/collection1/data/
[junit4] 2> 538501 T1617 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 538502 T1617 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732016024/master/collection1/data
[junit4] 2> 538502 T1617 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732016024/master/collection1/data/index/
[junit4] 2> 538502 T1617 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732016024/master/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 538502 T1617 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732016024/master/collection1/data/index
[junit4] 2> 538503 T1617 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=38, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8267677479279375]
[junit4] 2> 538503 T1617 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@18e7aaa7 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f09fa27; maxCacheMB=0.2314453125 maxMergeSizeMB=0.7568359375)),segFN=segments_1,generation=1}
[junit4] 2> 538503 T1617 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 538504 T1617 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 538504 T1617 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 538504 T1617 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 538504 T1617 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 538505 T1617 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 538505 T1617 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 538505 T1617 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 538506 T1617 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 538507 T1617 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 538507 T1617 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 538507 T1617 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=36, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4285780737803514]
[junit4] 2> 538508 T1617 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@18e7aaa7 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f09fa27; maxCacheMB=0.2314453125 maxMergeSizeMB=0.7568359375)),segFN=segments_1,generation=1}
[junit4] 2> 538508 T1617 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 538508 T1617 oass.SolrIndexSearcher.<init> Opening Searcher@9b87d28 main
[junit4] 2> 538508 T1617 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 538509 T1617 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 538509 T1617 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 538509 T1618 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@9b87d28 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 538509 T1542 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0
[junit4] 2> 538509 T1542 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 538510 T1542 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> 538514 T1542 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 538516 T1542 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:33331
[junit4] 2> 538517 T1542 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 538517 T1542 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 538517 T1542 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732016121/slave
[junit4] 2> 538518 T1542 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732016121/slave/'
[junit4] 2> 538528 T1542 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732016121/slave/solr.xml
[junit4] 2> 538528 T1542 oasc.ConfigSolr.fromFile /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732016121/slave/solr.xml does not exist, using default configuration
[junit4] 2> 538535 T1542 oasc.CoreContainer.<init> New CoreContainer 1136734950
[junit4] 2> 538536 T1542 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732016121/slave/]
[junit4] 2> 538536 T1542 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 538536 T1542 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 538537 T1542 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 538537 T1542 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 538537 T1542 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 538537 T1542 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 538538 T1542 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 538538 T1542 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 538538 T1542 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 538538 T1542 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 538542 T1629 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732016121/slave/collection1
[junit4] 2> 538542 T1629 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732016121/slave/collection1/'
[junit4] 2> 538556 T1629 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_45
[junit4] 2> 538563 T1629 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 538563 T1629 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 538565 T1629 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 538568 T1629 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 538568 T1629 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 538568 T1629 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732016121/slave/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732016121/slave/collection1/data/
[junit4] 2> 538568 T1629 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 538569 T1629 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732016121/slave/collection1/data
[junit4] 2> 538569 T1629 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732016121/slave/collection1/data/index/
[junit4] 2> 538569 T1629 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732016121/slave/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 538569 T1629 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732016121/slave/collection1/data/index
[junit4] 2> 538570 T1629 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=38, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8267677479279375]
[junit4] 2> 538570 T1629 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@5560fee3 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7c644443; maxCacheMB=0.2314453125 maxMergeSizeMB=0.7568359375)),segFN=segments_1,generation=1}
[junit4] 2> 538570 T1629 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 538571 T1629 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 538571 T1629 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 538571 T1629 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 538571 T1629 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 538571 T1629 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 538572 T1629 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 538572 T1629 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 538573 T1629 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 538573 T1629 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 538573 T1629 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 538574 T1629 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=36, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4285780737803514]
[junit4] 2> 538574 T1629 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@5560fee3 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7c644443; maxCacheMB=0.2314453125 maxMergeSizeMB=0.7568359375)),segFN=segments_1,generation=1}
[junit4] 2> 538574 T1629 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 538574 T1629 oass.SolrIndexSearcher.<init> Opening Searcher@67763641 main
[junit4] 2> 538575 T1629 oash.SnapPuller.startExecutorService Poll Scheduled at an interval of 1000ms
[junit4] 2> 538575 T1629 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 538575 T1630 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@67763641 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 538575 T1542 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0
[junit4] 2> 538576 T1542 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 538576 T1542 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> ASYNC NEW_CORE C572 name=collection1 org.apache.solr.core.SolrCore@2b850292
[junit4] 2> 538580 T1613 C572 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> 538583 T1614 C572 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1]} 0 1
[junit4] 2> 538585 T1615 C572 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 538587 T1615 C572 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@18e7aaa7 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f09fa27; maxCacheMB=0.2314453125 maxMergeSizeMB=0.7568359375)),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@18e7aaa7 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f09fa27; maxCacheMB=0.2314453125 maxMergeSizeMB=0.7568359375)),segFN=segments_2,generation=2}
[junit4] 2> 538587 T1615 C572 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 538588 T1615 C572 oass.SolrIndexSearcher.<init> Opening Searcher@31cf9b21 main
[junit4] 2> 538589 T1615 C572 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 538589 T1618 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@31cf9b21 main{StandardDirectoryReader(segments_2:3:nrt _0(4.5):C1)}
[junit4] 2> 538589 T1615 C572 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={commit=true&wt=javabin&version=2} {commit=} 0 4
[junit4] 2> 538591 T1633 oash.SnapPuller.<init> WARN 'masterUrl' must be specified without the /replication suffix
[junit4] 2> 538592 T1633 oash.SnapPuller.<init> No value set for 'pollInterval'. Timer Task not started.
[junit4] 2> 538593 T1616 C572 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=indexversion&qt=/replication&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 538593 T1633 oash.SnapPuller.fetchLatestIndex Master's generation: 2
[junit4] 2> 538593 T1633 oash.SnapPuller.fetchLatestIndex Slave's generation: 1
[junit4] 2> 538593 T1633 oash.SnapPuller.fetchLatestIndex Starting replication process
[junit4] 2> 538597 T1613 C572 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=filelist&qt=/replication&wt=javabin&generation=2&version=2} status=0 QTime=2
[junit4] 2> 538598 T1633 oash.SnapPuller.fetchLatestIndex Number of files in latest index in master: 11
[junit4] 2> 538598 T1633 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732016121/slave/collection1/data/index.20130817053336207
[junit4] 2> 538598 T1633 oash.SnapPuller.fetchLatestIndex Starting download to MockDirWrapper(org.apache.lucene.store.RAMDirectory@47241516 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@336ed022) fullCopy=false
[junit4] 2> 538600 T1614 C572 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0_MockRandom_0.tib&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 538603 T1615 C572 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0_MockRandom_0.sd&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 538606 T1616 C572 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.fnm&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=1
[junit4] 2> 538608 T1613 C572 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0_MockRandom_0.doc&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 538611 T1614 C572 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.nvd&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 538613 T1615 C572 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=segments_2&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 538615 T1616 C572 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0_MockRandom_0.tii&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 538617 T1613 C572 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.fdx&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 538619 T1614 C572 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.nvm&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 538622 T1615 C572 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.si&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 538624 T1616 C572 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.fdt&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 538643 T1633 oash.SnapPuller.fetchLatestIndex Total time taken for download : 0 secs
[junit4] 2> 538644 T1633 oasu.DefaultSolrCoreState.closeIndexWriter Closing IndexWriter...
[junit4] 2> 538644 T1633 oasu.DefaultSolrCoreState.closeIndexWriter Waiting until IndexWriter is unused... core=collection1
[junit4] 2> 538644 T1633 oasu.DefaultSolrCoreState.closeIndexWriter Rollback old IndexWriter... core=collection1
[junit4] 2> 538645 T1633 oasu.DefaultSolrCoreState.openIndexWriter Creating new IndexWriter...
[junit4] 2> 538645 T1633 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=26, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8433932142806739]
[junit4] 2> 538646 T1633 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=2
[junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@5560fee3 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7c644443; maxCacheMB=0.2314453125 maxMergeSizeMB=0.7568359375)),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@5560fee3 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7c644443; maxCacheMB=0.2314453125 maxMergeSizeMB=0.7568359375)),segFN=segments_2,generation=2}
[junit4] 2> 538646 T1633 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 538646 T1633 oasu.DefaultSolrCoreState.openIndexWriter New IndexWriter is ready to be used.
[junit4] 2> 538647 T1633 oass.SolrIndexSearcher.<init> Opening Searcher@220407a9 main
[junit4] 2> 538647 T1630 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@220407a9 main{StandardDirectoryReader(segments_2:3:nrt _0(4.5):C1)}
[junit4] 2> 538647 T1633 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732016121/slave/collection1/data/index.20130817053336207 [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrI
[...truncated too long message...]
on: Server refused connection at: http://127.0.0.1:59646/solr
[junit4] 2> 598078 T2209 C635 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 598079 T2220 oash.SnapShooter.createSnapshot Creating backup snapshot...
[junit4] 2> 598078 T2208 C635 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={numberToKeep=1&command=backup} status=0 QTime=0
[junit4] 2> 598281 T2210 C635 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 598289 T1542 oas.SolrTestCaseJ4.tearDown ###Ending doTestBackup
[junit4] 2> 598310 T1542 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=530242747
[junit4] 2> 598311 T1542 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@ad32823
[junit4] 2> 598312 T1542 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=1,cumulative_errors=0}
[junit4] 2> 598313 T1542 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 598313 T1542 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 598314 T1542 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 598315 T1542 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 598316 T1542 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 598317 T1542 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732073282/master/collection1/data/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732073282/master/collection1/data/index;done=false>>]
[junit4] 2> 598317 T1542 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732073282/master/collection1/data/index
[junit4] 2> 598318 T1542 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732073282/master/collection1/data [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732073282/master/collection1/data;done=false>>]
[junit4] 2> 598319 T1542 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732073282/master/collection1/data
[junit4] 2> 598320 T1542 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 598392 T2201 oash.SnapPuller.fetchLatestIndex ERROR Master at: http://127.0.0.1:59646/solr is not available. Index fetch failed. Exception: org.apache.solr.client.solrj.SolrServerException: Server refused connection at: http://127.0.0.1:59646/solr
[junit4] 2> 598393 T1542 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=350572747
[junit4] 2> 598394 T1542 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@428d1e6c
[junit4] 2> 598395 T1542 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> 598395 T1542 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 598396 T1542 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 598396 T1542 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 598397 T1542 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 598398 T1542 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 598399 T1542 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732073354/slave/collection1/data/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732073354/slave/collection1/data/index;done=false>>]
[junit4] 2> 598399 T1542 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732073354/slave/collection1/data/index
[junit4] 2> 598400 T1542 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732073354/slave/collection1/data [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732073354/slave/collection1/data;done=false>>]
[junit4] 2> 598401 T1542 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376732073354/slave/collection1/data
[junit4] 2> 598402 T1542 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 598460 T1542 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: test params are: codec=Lucene42: {newname=PostingsFormat(name=MockRandom), id=PostingsFormat(name=MockRandom), name=PostingsFormat(name=MockRandom)}, docValues:{}, sim=DefaultSimilarity, locale=es_BO, timezone=America/Kralendijk
[junit4] 2> NOTE: Linux 3.2.0-51-generic amd64/Oracle Corporation 1.8.0-ea (64-bit)/cpus=8,threads=1,free=243160176,total=438304768
[junit4] 2> NOTE: All tests run in this JVM: [AnalysisAfterCoreReloadTest, UnloadDistributedZkTest, TestPHPSerializedResponseWriter, BinaryUpdateRequestHandlerTest, CoreMergeIndexesAdminHandlerTest, LegacyHTMLStripCharFilterTest, TestSolrIndexConfig, HdfsCollectionsAPIDistributedZkTest, ScriptEngineTest, IndexSchemaTest, UUIDFieldTest, AliasIntegrationTest, TestSolrQueryParser, SolrXmlInZkTest, PeerSyncTest, ClusterStateUpdateTest, SolrCoreTest, DateMathParserTest, DocValuesTest, HdfsRecoveryZkTest, PrimitiveFieldTypeTest, PreAnalyzedUpdateProcessorTest, SolrIndexSplitterTest, TestJoin, ZkControllerTest, BasicFunctionalityTest, URLClassifyProcessorTest, OverseerCollectionProcessorTest, ResponseLogComponentTest, TestSchemaSimilarityResource, TestConfig, DistributedSpellCheckComponentTest, TestRemoteStreaming, TestFieldResource, RecoveryZkTest, TestPseudoReturnFields, CoreAdminHandlerTest, TestDynamicFieldCollectionResource, TestReversedWildcardFilterFactory, TestStressVersions, TestRandomDVFaceting, TestFieldTypeResource, QueryEqualityTest, LoggingHandlerTest, TestCharFilters, ExternalFileFieldSortTest, LukeRequestHandlerTest, TestClassNameShortening, TestBM25SimilarityFactory, BlockDirectoryTest, BlockCacheTest, FieldMutatingUpdateProcessorTest, DirectUpdateHandlerOptimizeTest, TestSystemIdResolver, WordBreakSolrSpellCheckerTest, TermVectorComponentTest, DOMUtilTest, HdfsSyncSliceTest, ShowFileRequestHandlerTest, TermsComponentTest, DocumentBuilderTest, ShardSplitTest, CircularListTest, TestTrie, SliceStateUpdateTest, TestSearchPerf, CachingDirectoryFactoryTest, SpellPossibilityIteratorTest, AutoCommitTest, SyncSliceTest, StatelessScriptUpdateProcessorFactoryTest, SOLR749Test, TestInfoStreamLogging, TestReplicationHandler]
[junit4] Completed on J0 in 60.89s, 14 tests, 1 failure <<< FAILURES!
[...truncated 498 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:395: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:375: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:39: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build.xml:181: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/common-build.xml:450: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:1233: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:876: There were test failures: 322 suites, 1375 tests, 1 failure, 38 ignored (6 assumptions)
Total time: 40 minutes 13 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 64bit/jdk1.8.0-ea-b102 -XX:-UseCompressedOops -XX:+UseG1GC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure