You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2013/09/08 01:18:01 UTC
[JENKINS] Lucene-Solr-NightlyTests-4.x - Build # 369 - Still
Failing
Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-4.x/369/
1 tests failed.
FAILED: org.apache.solr.handler.TestReplicationHandler.doTestStressReplication
Error Message:
timed out waiting for collection1 startAt time to exceed: Sat Sep 07 22:34:50 EGST 2013
Stack Trace:
java.lang.AssertionError: timed out waiting for collection1 startAt time to exceed: Sat Sep 07 22:34:50 EGST 2013
at __randomizedtesting.SeedInfo.seed([922A5A1299C3E8BF:49815AD49CEB810C]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.apache.solr.handler.TestReplicationHandler.watchCoreStartAt(TestReplicationHandler.java:1514)
at org.apache.solr.handler.TestReplicationHandler.doTestStressReplication(TestReplicationHandler.java:818)
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:616)
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:679)
Build Log:
[...truncated 9239 lines...]
[junit4] Suite: org.apache.solr.handler.TestReplicationHandler
[junit4] 2> 392595 T1341 oas.SolrTestCaseJ4.setUp ###Starting doTestIndexAndConfigReplication
[junit4] 2> 392609 T1341 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 392611 T1341 oejs.AbstractConnector.doStart Started SocketConnector@127.0.0.1:47142
[junit4] 2> 392612 T1341 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 392612 T1341 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 392612 T1341 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593273805/master
[junit4] 2> 392613 T1341 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593273805/master/'
[junit4] 2> 392641 T1341 oasc.ConfigSolr.fromFile Loading container configuration from /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593273805/master/solr.xml
[junit4] 2> 392692 T1341 oasc.CoreContainer.<init> New CoreContainer 2079477807
[junit4] 2> 392693 T1341 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593273805/master/]
[junit4] 2> 392694 T1341 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 120000
[junit4] 2> 392694 T1341 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 392694 T1341 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 392695 T1341 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 392695 T1341 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 392695 T1341 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 392696 T1341 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 392696 T1341 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 392696 T1341 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 392696 T1341 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=120000&connTimeout=15000&retry=false
[junit4] 2> 392707 T1341 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 392708 T1341 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 392712 T1351 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593273805/master/collection1
[junit4] 2> 392712 T1351 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593273805/master/collection1/'
[junit4] 2> 392749 T1351 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_45
[junit4] 2> 392786 T1351 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 392787 T1351 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 392791 T1351 oass.IndexSchema.readSchema [null] Schema name=test
[junit4] 2> 392807 T1351 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 392808 T1351 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 392809 T1351 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593273805/master/collection1/, dataDir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593273805/master/collection1/data/
[junit4] 2> 392809 T1351 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 392809 T1351 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593273805/master/collection1/data
[junit4] 2> 392809 T1351 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593273805/master/collection1/data/index/
[junit4] 2> 392810 T1351 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593273805/master/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 392811 T1351 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593273805/master/collection1/data/index
[junit4] 2> 392811 T1351 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=9, maxMergeAtOnceExplicit=3, maxMergedSegmentMB=35.7900390625, floorSegmentMB=1.5693359375, forceMergeDeletesPctAllowed=6.376918961129476, segmentsPerTier=13.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5218631632567061
[junit4] 2> 392812 T1351 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@4a9ffa5e lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2f6772f2),segFN=segments_1,generation=1}
[junit4] 2> 392812 T1351 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 392812 T1351 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 392813 T1351 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 392813 T1351 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 392813 T1351 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 392813 T1351 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 392813 T1351 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 392814 T1351 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 392821 T1351 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 392823 T1351 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 392823 T1351 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 392823 T1351 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=44, maxMergeAtOnceExplicit=40, maxMergedSegmentMB=0.77734375, floorSegmentMB=2.1943359375, forceMergeDeletesPctAllowed=12.0396939561366, segmentsPerTier=25.0, maxCFSSegmentSizeMB=0.7294921875, noCFSRatio=0.24293566164417807
[junit4] 2> 392824 T1351 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@4a9ffa5e lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2f6772f2),segFN=segments_1,generation=1}
[junit4] 2> 392824 T1351 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 392824 T1351 oass.SolrIndexSearcher.<init> Opening Searcher@7003e8b7 main
[junit4] 2> 392825 T1351 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 392825 T1351 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 392825 T1352 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7003e8b7 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 392825 T1351 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 392826 T1341 oass.SolrDispatchFilter.init user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0
[junit4] 2> 392826 T1341 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 392827 T1341 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> 392842 T1341 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 392844 T1341 oejs.AbstractConnector.doStart Started SocketConnector@127.0.0.1:23495
[junit4] 2> 392844 T1341 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 392844 T1341 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 392845 T1341 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593274043/slave
[junit4] 2> 392845 T1341 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593274043/slave/'
[junit4] 2> 392855 T1341 oasc.ConfigSolr.fromFile Loading container configuration from /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593274043/slave/solr.xml
[junit4] 2> 392896 T1341 oasc.CoreContainer.<init> New CoreContainer 1174841538
[junit4] 2> 392896 T1341 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593274043/slave/]
[junit4] 2> 392898 T1341 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 120000
[junit4] 2> 392898 T1341 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 392898 T1341 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 392898 T1341 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 392899 T1341 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 392899 T1341 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 392899 T1341 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 392900 T1341 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 392900 T1341 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 392901 T1341 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=120000&connTimeout=15000&retry=false
[junit4] 2> 392907 T1341 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 392908 T1341 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 392911 T1363 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593274043/slave/collection1
[junit4] 2> 392912 T1363 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593274043/slave/collection1/'
[junit4] 2> 392946 T1363 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_45
[junit4] 2> 392986 T1363 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 392987 T1363 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 392991 T1363 oass.IndexSchema.readSchema [null] Schema name=test
[junit4] 2> 393003 T1363 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 393004 T1363 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 393004 T1363 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593274043/slave/collection1/, dataDir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593274043/slave/collection1/data/
[junit4] 2> 393004 T1363 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 393004 T1363 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593274043/slave/collection1/data
[junit4] 2> 393005 T1363 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593274043/slave/collection1/data/index/
[junit4] 2> 393005 T1363 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593274043/slave/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 393006 T1363 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593274043/slave/collection1/data/index
[junit4] 2> 393006 T1363 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=9, maxMergeAtOnceExplicit=3, maxMergedSegmentMB=35.7900390625, floorSegmentMB=1.5693359375, forceMergeDeletesPctAllowed=6.376918961129476, segmentsPerTier=13.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5218631632567061
[junit4] 2> 393007 T1363 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@63fd2ad8 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4657cc33),segFN=segments_1,generation=1}
[junit4] 2> 393007 T1363 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 393007 T1363 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 393008 T1363 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 393008 T1363 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 393008 T1363 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 393008 T1363 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 393008 T1363 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 393009 T1363 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 393010 T1363 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 393012 T1363 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 393012 T1363 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 393012 T1363 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=44, maxMergeAtOnceExplicit=40, maxMergedSegmentMB=0.77734375, floorSegmentMB=2.1943359375, forceMergeDeletesPctAllowed=12.0396939561366, segmentsPerTier=25.0, maxCFSSegmentSizeMB=0.7294921875, noCFSRatio=0.24293566164417807
[junit4] 2> 393013 T1363 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@63fd2ad8 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4657cc33),segFN=segments_1,generation=1}
[junit4] 2> 393013 T1363 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 393013 T1363 oass.SolrIndexSearcher.<init> Opening Searcher@62525305 main
[junit4] 2> 393014 T1363 oash.SnapPuller.startExecutorService Poll Scheduled at an interval of 1000ms
[junit4] 2> 393014 T1364 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@62525305 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 393014 T1363 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 393015 T1341 oass.SolrDispatchFilter.init user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0
[junit4] 2> 393015 T1341 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 393016 T1341 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> ASYNC NEW_CORE C374 name=collection1 org.apache.solr.core.SolrCore@38cd64aa
[junit4] 2> 393031 T1344 C374 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={sort=id+desc&q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=1
[junit4] 2> 393036 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0]} 0 2
[junit4] 2> 393039 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1]} 0 0
[junit4] 2> 393042 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[2]} 0 0
[junit4] 2> 393045 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[3]} 0 0
[junit4] 2> 393048 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[4]} 0 0
[junit4] 2> 393051 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[5]} 0 0
[junit4] 2> 393054 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[6]} 0 0
[junit4] 2> 393057 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[7]} 0 0
[junit4] 2> 393060 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[8]} 0 0
[junit4] 2> 393062 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[9]} 0 0
[junit4] 2> 393064 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[10]} 0 0
[junit4] 2> 393066 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[11]} 0 0
[junit4] 2> 393068 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[12]} 0 0
[junit4] 2> 393071 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[13]} 0 0
[junit4] 2> 393073 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[14]} 0 0
[junit4] 2> 393075 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[15]} 0 0
[junit4] 2> 393077 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[16]} 0 0
[junit4] 2> 393079 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[17]} 0 0
[junit4] 2> 393081 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[18]} 0 0
[junit4] 2> 393083 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[19]} 0 0
[junit4] 2> 393085 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[20]} 0 0
[junit4] 2> 393087 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[21]} 0 0
[junit4] 2> 393089 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[22]} 0 0
[junit4] 2> 393091 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[23]} 0 0
[junit4] 2> 393093 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[24]} 0 0
[junit4] 2> 393095 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[25]} 0 0
[junit4] 2> 393097 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[26]} 0 0
[junit4] 2> 393099 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[27]} 0 0
[junit4] 2> 393102 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[28]} 0 0
[junit4] 2> 393105 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[29]} 0 0
[junit4] 2> 393107 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[30]} 0 0
[junit4] 2> 393109 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[31]} 0 0
[junit4] 2> 393111 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[32]} 0 0
[junit4] 2> 393114 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[33]} 0 0
[junit4] 2> 393118 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[34]} 0 1
[junit4] 2> 393120 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[35]} 0 0
[junit4] 2> 393123 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[36]} 0 0
[junit4] 2> 393126 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[37]} 0 0
[junit4] 2> 393129 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[38]} 0 0
[junit4] 2> 393132 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[39]} 0 0
[junit4] 2> 393134 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[40]} 0 0
[junit4] 2> 393136 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[41]} 0 0
[junit4] 2> 393139 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[42]} 0 0
[junit4] 2> 393142 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[43]} 0 0
[junit4] 2> 393145 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[44]} 0 0
[junit4] 2> 393148 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[45]} 0 0
[junit4] 2> 393151 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[46]} 0 0
[junit4] 2> 393154 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[47]} 0 0
[junit4] 2> 393157 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[48]} 0 0
[junit4] 2> 393160 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[49]} 0 0
[junit4] 2> 393163 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[50]} 0 0
[junit4] 2> 393166 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[51]} 0 0
[junit4] 2> 393169 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[52]} 0 0
[junit4] 2> 393172 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[53]} 0 0
[junit4] 2> 393175 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[54]} 0 0
[junit4] 2> 393178 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[55]} 0 0
[junit4] 2> 393181 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[56]} 0 0
[junit4] 2> 393184 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[57]} 0 0
[junit4] 2> 393187 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[58]} 0 0
[junit4] 2> 393190 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[59]} 0 0
[junit4] 2> 393193 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[60]} 0 0
[junit4] 2> 393196 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[61]} 0 0
[junit4] 2> 393199 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[62]} 0 0
[junit4] 2> 393202 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[63]} 0 0
[junit4] 2> 393205 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[64]} 0 0
[junit4] 2> 393208 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[65]} 0 0
[junit4] 2> 393211 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[66]} 0 0
[junit4] 2> 393214 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[67]} 0 0
[junit4] 2> 393217 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[68]} 0 0
[junit4] 2> 393220 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[69]} 0 0
[junit4] 2> 393223 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[70]} 0 0
[junit4] 2> 393226 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[71]} 0 0
[junit4] 2> 393229 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[72]} 0 0
[junit4] 2> 393232 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[73]} 0 0
[junit4] 2> 393235 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[74]} 0 0
[junit4] 2> 393238 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[75]} 0 0
[junit4] 2> 393241 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[76]} 0 0
[junit4] 2> 393244 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[77]} 0 0
[junit4] 2> 393247 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[78]} 0 0
[junit4] 2> 393250 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[79]} 0 0
[junit4] 2> 393253 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[80]} 0 0
[junit4] 2> 393256 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[81]} 0 0
[junit4] 2> 393259 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[82]} 0 0
[junit4] 2> 393262 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[83]} 0 0
[junit4] 2> 393265 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[84]} 0 0
[junit4] 2> 393268 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[85]} 0 0
[junit4] 2> 393271 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[86]} 0 0
[junit4] 2> 393274 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[87]} 0 0
[junit4] 2> 393277 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[88]} 0 0
[junit4] 2> 393280 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[89]} 0 0
[junit4] 2> 393283 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[90]} 0 0
[junit4] 2> 393286 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[91]} 0 0
[junit4] 2> 393289 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[92]} 0 0
[junit4] 2> 393292 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[93]} 0 0
[junit4] 2> 393295 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[94]} 0 0
[junit4] 2> 393298 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[95]} 0 0
[junit4] 2> 393301 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[96]} 0 0
[junit4] 2> 393304 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[97]} 0 0
[junit4] 2> 393307 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[98]} 0 0
[junit4] 2> 393310 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[99]} 0 0
[junit4] 2> 393313 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[100]} 0 0
[junit4] 2> 393316 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[101]} 0 0
[junit4] 2> 393319 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[102]} 0 0
[junit4] 2> 393322 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[103]} 0 0
[junit4] 2> 393325 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[104]} 0 0
[junit4] 2> 393328 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[105]} 0 0
[junit4] 2> 393331 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[106]} 0 0
[junit4] 2> 393334 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[107]} 0 0
[junit4] 2> 393337 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[108]} 0 0
[junit4] 2> 393340 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[109]} 0 0
[junit4] 2> 393343 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[110]} 0 0
[junit4] 2> 393346 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[111]} 0 0
[junit4] 2> 393349 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[112]} 0 0
[junit4] 2> 393352 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[113]} 0 0
[junit4] 2> 393355 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[114]} 0 0
[junit4] 2> 393358 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[115]} 0 0
[junit4] 2> 393361 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[116]} 0 0
[junit4] 2> 393365 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[117]} 0 1
[junit4] 2> 393367 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[118]} 0 0
[junit4] 2> 393370 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[119]} 0 0
[junit4] 2> 393373 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[120]} 0 0
[junit4] 2> 393376 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[121]} 0 0
[junit4] 2> 393379 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[122]} 0 0
[junit4] 2> 393382 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[123]} 0 0
[junit4] 2> 393385 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[124]} 0 0
[junit4] 2> 393388 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[125]} 0 0
[junit4] 2> 393391 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[126]} 0 0
[junit4] 2> 393394 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[127]} 0 0
[junit4] 2> 393397 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[128]} 0 0
[junit4] 2> 393400 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[129]} 0 0
[junit4] 2> 393403 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[130]} 0 0
[junit4] 2> 393406 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[131]} 0 0
[junit4] 2> 393409 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[132]} 0 0
[junit4] 2> 393412 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[133]} 0 0
[junit4] 2> 393416 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[134]} 0 1
[junit4] 2> 393419 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[135]} 0 0
[junit4] 2> 393423 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[136]} 0 1
[junit4] 2> 393425 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[137]} 0 0
[junit4] 2> 393428 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[138]} 0 0
[junit4] 2> 393431 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[139]} 0 0
[junit4] 2> 393434 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[140]} 0 0
[junit4] 2> 393437 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[141]} 0 0
[junit4] 2> 393440 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[142]} 0 0
[junit4] 2> 393443 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[143]} 0 0
[junit4] 2> 393446 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[144]} 0 0
[junit4] 2> 393449 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[145]} 0 0
[junit4] 2> 393452 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[146]} 0 0
[junit4] 2> 393455 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[147]} 0 0
[junit4] 2> 393458 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[148]} 0 0
[junit4] 2> 393461 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[149]} 0 0
[junit4] 2> 393464 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[150]} 0 0
[junit4] 2> 393467 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[151]} 0 0
[junit4] 2> 393470 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[152]} 0 0
[junit4] 2> 393473 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[153]} 0 0
[junit4] 2> 393476 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[154]} 0 0
[junit4] 2> 393479 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[155]} 0 0
[junit4] 2> 393482 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[156]} 0 0
[junit4] 2> 393485 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[157]} 0 0
[junit4] 2> 393488 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[158]} 0 0
[junit4] 2> 393491 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[159]} 0 0
[junit4] 2> 393494 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[160]} 0 0
[junit4] 2> 393497 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[161]} 0 0
[junit4] 2> 393500 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[162]} 0 0
[junit4] 2> 393503 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[163]} 0 0
[junit4] 2> 393506 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[164]} 0 0
[junit4] 2> 393509 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[165]} 0 0
[junit4] 2> 393512 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[166]} 0 0
[junit4] 2> 393515 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[167]} 0 0
[junit4] 2> 393518 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[168]} 0 0
[junit4] 2> 393521 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[169]} 0 0
[junit4] 2> 393524 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[170]} 0 0
[junit4] 2> 393527 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[171]} 0 0
[junit4] 2> 393530 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[172]} 0 0
[junit4] 2> 393533 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[173]} 0 0
[junit4] 2> 393536 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[174]} 0 0
[junit4] 2> 393539 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[175]} 0 0
[junit4] 2> 393542 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[176]} 0 0
[junit4] 2> 393545 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[177]} 0 0
[junit4] 2> 393548 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[178]} 0 0
[junit4] 2> 393551 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[179]} 0 0
[junit4] 2> 393554 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[180]} 0 0
[junit4] 2> 393557 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[181]} 0 0
[junit4] 2> 393560 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[182]} 0 0
[junit4] 2> 393563 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[183]} 0 0
[junit4] 2> 393566 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[184]} 0 0
[junit4] 2> 393569 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[185]} 0 0
[junit4] 2> 393572 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[186]} 0 0
[junit4] 2> 393575 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[187]} 0 0
[junit4] 2> 393578 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[188]} 0 0
[junit4] 2> 393581 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[189]} 0 0
[junit4] 2> 393584 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[190]} 0 0
[junit4] 2> 393587 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[191]} 0 0
[junit4] 2> 393590 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[192]} 0 0
[junit4] 2> 393593 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[193]} 0 0
[junit4] 2> 393596 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[194]} 0 0
[junit4] 2> 393599 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[195]} 0 0
[junit4] 2> 393602 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[196]} 0 0
[junit4] 2> 393605 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[197]} 0 0
[junit4] 2> 393608 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[198]} 0 0
[junit4] 2> 393611 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[199]} 0 0
[junit4] 2> 393614 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[200]} 0 0
[junit4] 2> 393617 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[201]} 0 0
[junit4] 2> 393620 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[202]} 0 0
[junit4] 2> 393623 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[203]} 0 0
[junit4] 2> 393626 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[204]} 0 0
[junit4] 2> 393641 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[205]} 0 12
[junit4] 2> 393645 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[206]} 0 1
[junit4] 2> 393647 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[207]} 0 0
[junit4] 2> 393650 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[208]} 0 0
[junit4] 2> 393653 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[209]} 0 0
[junit4] 2> 393656 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[210]} 0 0
[junit4] 2> 393659 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[211]} 0 0
[junit4] 2> 393662 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[212]} 0 0
[junit4] 2> 393665 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[213]} 0 0
[junit4] 2> 393668 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[214]} 0 0
[junit4] 2> 393671 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[215]} 0 0
[junit4] 2> 393674 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[216]} 0 0
[junit4] 2> 393677 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[217]} 0 0
[junit4] 2> 393681 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[218]} 0 1
[junit4] 2> 393683 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[219]} 0 0
[junit4] 2> 393686 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[220]} 0 0
[junit4] 2> 393689 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[221]} 0 0
[junit4] 2> 393692 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[222]} 0 0
[junit4] 2> 393695 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[223]} 0 0
[junit4] 2> 393698 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[224]} 0 0
[junit4] 2> 393701 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[225]} 0 0
[junit4] 2> 393704 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[226]} 0 0
[junit4] 2> 393707 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[227]} 0 0
[junit4] 2> 393710 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[228]} 0 0
[junit4] 2> 393713 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[229]} 0 0
[junit4] 2> 393716 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[230]} 0 0
[junit4] 2> 393719 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[231]} 0 0
[junit4] 2> 393722 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[232]} 0 0
[junit4] 2> 393725 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[233]} 0 0
[junit4] 2> 393728 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[234]} 0 0
[junit4] 2> 393731 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[235]} 0 0
[junit4] 2> 393734 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[236]} 0 0
[junit4] 2> 393737 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[237]} 0 0
[junit4] 2> 393740 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[238]} 0 0
[junit4] 2> 393743 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[239]} 0 0
[junit4] 2> 393746 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[240]} 0 0
[junit4] 2> 393749 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[241]} 0 0
[junit4] 2> 393752 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[242]} 0 0
[junit4] 2> 393755 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[243]} 0 0
[junit4] 2> 393758 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[244]} 0 0
[junit4] 2> 393761 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[245]} 0 0
[junit4] 2> 393764 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[246]} 0 0
[junit4] 2> 393767 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[247]} 0 0
[junit4] 2> 393770 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[248]} 0 0
[junit4] 2> 393773 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[249]} 0 0
[junit4] 2> 393776 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[250]} 0 0
[junit4] 2> 393779 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[251]} 0 0
[junit4] 2> 393782 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[252]} 0 0
[junit4] 2> 393785 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[253]} 0 0
[junit4] 2> 393788 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[254]} 0 0
[junit4] 2> 393791 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[255]} 0 0
[junit4] 2> 393792 T1345 C374 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=indexversion&qt=/replication&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 393794 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[256]} 0 0
[junit4] 2> 393797 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[257]} 0 0
[junit4] 2> 393800 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[258]} 0 0
[junit4] 2> 393803 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[259]} 0 0
[junit4] 2> 393806 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[260]} 0 0
[junit4] 2> 393809 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[261]} 0 0
[junit4] 2> 393812 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[262]} 0 0
[junit4] 2> 393815 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[263]} 0 0
[junit4] 2> 393818 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[264]} 0 0
[junit4] 2> 393821 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[265]} 0 0
[junit4] 2> 393824 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[266]} 0 0
[junit4] 2> 393827 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[267]} 0 0
[junit4] 2> 393830 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[268]} 0 0
[junit4] 2> 393833 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[269]} 0 0
[junit4] 2> 393836 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[270]} 0 0
[junit4] 2> 393839 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[271]} 0 0
[junit4] 2> 393842 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[272]} 0 0
[junit4] 2> 393845 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[273]} 0 0
[junit4] 2> 393848 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[274]} 0 0
[junit4] 2> 393851 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[275]} 0 0
[junit4] 2> 393854 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[276]} 0 0
[junit4] 2> 393857 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[277]} 0 0
[junit4] 2> 393860 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[278]} 0 0
[junit4] 2> 393863 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[279]} 0 0
[junit4] 2> 393866 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[280]} 0 0
[junit4] 2> 393869 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[281]} 0 0
[junit4] 2> 393872 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[282]} 0 0
[junit4] 2> 393875 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[283]} 0 0
[junit4] 2> 393878 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[284]} 0 0
[junit4] 2> 393881 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[285]} 0 0
[junit4] 2> 393884 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[286]} 0 0
[junit4] 2> 393887 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[287]} 0 0
[junit4] 2> 393890 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[288]} 0 0
[junit4] 2> 393893 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[289]} 0 0
[junit4] 2> 393896 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[290]} 0 0
[junit4] 2> 393899 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[291]} 0 0
[junit4] 2> 393902 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[292]} 0 0
[junit4] 2> 393905 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[293]} 0 0
[junit4] 2> 393908 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[294]} 0 0
[junit4] 2> 393911 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[295]} 0 0
[junit4] 2> 393914 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[296]} 0 0
[junit4] 2> 393917 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[297]} 0 0
[junit4] 2> 393920 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[298]} 0 0
[junit4] 2> 393923 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[299]} 0 0
[junit4] 2> 393926 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[300]} 0 0
[junit4] 2> 393929 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[301]} 0 0
[junit4] 2> 393932 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[302]} 0 0
[junit4] 2> 393935 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[303]} 0 0
[junit4] 2> 393938 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[304]} 0 0
[junit4] 2> 393941 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[305]} 0 0
[junit4] 2> 393944 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[306]} 0 0
[junit4] 2> 393947 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[307]} 0 0
[junit4] 2> 393950 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[308]} 0 0
[junit4] 2> 393953 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[309]} 0 0
[junit4] 2> 393956 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[310]} 0 0
[junit4] 2> 393959 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[311]} 0 0
[junit4] 2> 393962 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[312]} 0 0
[junit4] 2> 393965 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[313]} 0 0
[junit4] 2> 393968 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[314]} 0 0
[junit4] 2> 393971 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[315]} 0 0
[junit4] 2> 393974 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[316]} 0 0
[junit4] 2> 393977 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[317]} 0 0
[junit4] 2> 393980 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[318]} 0 0
[junit4] 2> 393983 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[319]} 0 0
[junit4] 2> 393986 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[320]} 0 0
[junit4] 2> 393989 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[321]} 0 0
[junit4] 2> 393992 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[322]} 0 0
[junit4] 2> 393995 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[323]} 0 0
[junit4] 2> 393998 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[324]} 0 0
[junit4] 2> 394001 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[325]} 0 0
[junit4] 2> 394004 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[326]} 0 0
[junit4] 2> 394007 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[327]} 0 0
[junit4] 2> 394010 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[328]} 0 0
[junit4] 2> 394013 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[329]} 0 0
[junit4] 2> 394016 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[330]} 0 0
[junit4] 2> 394019 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[331]} 0 0
[junit4] 2> 394022 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[332]} 0 0
[junit4] 2> 394026 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[333]} 0 0
[junit4] 2> 394028 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[334]} 0 0
[junit4] 2> 394031 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[335]} 0 0
[junit4] 2> 394034 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[336]} 0 0
[junit4] 2> 394037 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[337]} 0 0
[junit4] 2> 394040 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[338]} 0 0
[junit4] 2> 394043 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[339]} 0 0
[junit4] 2> 394046 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[340]} 0 0
[junit4] 2> 394049 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[341]} 0 0
[junit4] 2> 394052 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[342]} 0 0
[junit4] 2> 394055 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[343]} 0 0
[junit4] 2> 394058 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[344]} 0 0
[junit4] 2> 394061 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[345]} 0 0
[junit4] 2> 394064 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[346]} 0 0
[junit4] 2> 394067 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[347]} 0 0
[junit4] 2> 394070 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[348]} 0 0
[junit4] 2> 394073 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[349]} 0 0
[junit4] 2> 394076 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[350]} 0 0
[junit4] 2> 394079 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[351]} 0 0
[junit4] 2> 394082 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[352]} 0 0
[junit4] 2> 394085 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[353]} 0 0
[junit4] 2> 394088 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[354]} 0 0
[junit4] 2> 394091 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[355]} 0 0
[junit4] 2> 394094 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[356]} 0 0
[junit4] 2> 394097 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[357]} 0 0
[junit4] 2> 394101 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[358]} 0 1
[junit4] 2> 394104 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[359]} 0 0
[junit4] 2> 394108 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[360]} 0 1
[junit4] 2> 394110 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[361]} 0 0
[junit4] 2> 394113 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[362]} 0 0
[junit4] 2> 394116 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[363]} 0 0
[junit4] 2> 394119 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[364]} 0 0
[junit4] 2> 394122 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[365]} 0 0
[junit4] 2> 394125 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[366]} 0 0
[junit4] 2> 394128 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[367]} 0 0
[junit4] 2> 394131 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[368]} 0 0
[junit4] 2> 394134 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[369]} 0 0
[junit4] 2> 394137 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[370]} 0 0
[junit4] 2> 394140 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[371]} 0 0
[junit4] 2> 394143 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[372]} 0 0
[junit4] 2> 394146 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[373]} 0 0
[junit4] 2> 394149 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[374]} 0 0
[junit4] 2> 394152 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[375]} 0 0
[junit4] 2> 394155 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[376]} 0 0
[junit4] 2> 394158 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[377]} 0 0
[junit4] 2> 394161 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[378]} 0 0
[junit4] 2> 394164 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[379]} 0 0
[junit4] 2> 394167 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[380]} 0 0
[junit4] 2> 394170 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[381]} 0 0
[junit4] 2> 394173 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[382]} 0 0
[junit4] 2> 394176 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[383]} 0 0
[junit4] 2> 394179 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[384]} 0 0
[junit4] 2> 394182 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[385]} 0 0
[junit4] 2> 394185 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[386]} 0 0
[junit4] 2> 394188 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[387]} 0 0
[junit4] 2> 394192 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[388]} 0 1
[junit4] 2> 394195 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[389]} 0 0
[junit4] 2> 394198 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[390]} 0 0
[junit4] 2> 394201 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[391]} 0 0
[junit4] 2> 394204 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[392]} 0 0
[junit4] 2> 394207 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[393]} 0 0
[junit4] 2> 394210 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[394]} 0 0
[junit4] 2> 394213 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[395]} 0 0
[junit4] 2> 394216 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[396]} 0 0
[junit4] 2> 394219 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[397]} 0 0
[junit4] 2> 394222 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[398]} 0 0
[junit4] 2> 394225 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[399]} 0 0
[junit4] 2> 394228 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[400]} 0 0
[junit4] 2> 394231 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[401]} 0 0
[junit4] 2> 394235 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[402]} 0 1
[junit4] 2> 394237 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[403]} 0 0
[junit4] 2> 394240 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[404]} 0 0
[junit4] 2> 394243 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[405]} 0 0
[junit4] 2> 394246 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[406]} 0 0
[junit4] 2> 394249 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[407]} 0 0
[junit4] 2> 394252 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[408]} 0 0
[junit4] 2> 394255 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[409]} 0 0
[junit4] 2> 394258 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[410]} 0 0
[junit4] 2> 394272 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[411]} 0 11
[junit4] 2> 394276 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[412]} 0 1
[junit4] 2> 394278 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[413]} 0 0
[junit4] 2> 394281 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[414]} 0 0
[junit4] 2> 394284 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[415]} 0 0
[junit4] 2> 394287 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[416]} 0 0
[junit4] 2> 394290 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[417]} 0 0
[junit4] 2> 394293 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[418]} 0 0
[junit4] 2> 394296 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[419]} 0 0
[junit4] 2> 394299 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[420]} 0 0
[junit4] 2> 394302 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[421]} 0 0
[junit4] 2> 394305 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[422]} 0 0
[junit4] 2> 394308 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[423]} 0 0
[junit4] 2> 394311 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[424]} 0 0
[junit4] 2> 394314 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[425]} 0 0
[junit4] 2> 394317 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[426]} 0 0
[junit4] 2> 394320 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[427]} 0 0
[junit4] 2> 394323 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[428]} 0 0
[junit4] 2> 394326 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[429]} 0 0
[junit4] 2> 394329 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[430]} 0 0
[junit4] 2> 394332 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[431]} 0 0
[junit4] 2> 394335 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[432]} 0 0
[junit4] 2> 394338 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[433]} 0 0
[junit4] 2> 394341 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[434]} 0 0
[junit4] 2> 394345 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[435]} 0 1
[junit4] 2> 394348 T1344 C374 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version
[...truncated too long message...]
lave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593810509/repeater/collection1/data/index.20130907224416031 [CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593810509/repeater/collection1/data/index.20130907224416031;done=false>>]
[junit4] 2> 975000 T1341 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593810509/repeater/collection1/data/index.20130907224416031
[junit4] 2> 975002 T1341 oasc.CachingDirectoryFactory.closeCacheValue looking to close /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593810509/repeater/collection1/data [CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593810509/repeater/collection1/data;done=false>>]
[junit4] 2> 975003 T1341 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593810509/repeater/collection1/data
[junit4] 2> 975003 T1341 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 975061 T1341 oas.SolrTestCaseJ4.tearDown ###Ending doTestRepeater
[junit4] 2> 975062 T1341 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1627789537
[junit4] 2> 975063 T1341 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1b332d50
[junit4] 2> 975064 T1341 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=2,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=6,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 975065 T1341 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 975065 T1341 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 975066 T1341 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 975067 T1341 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 975068 T1341 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 975068 T1341 oasc.CachingDirectoryFactory.closeCacheValue looking to close /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593809599/master/collection1/data [CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593809599/master/collection1/data;done=false>>]
[junit4] 2> 975069 T1341 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593809599/master/collection1/data
[junit4] 2> 975069 T1341 oasc.CachingDirectoryFactory.closeCacheValue looking to close /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593809599/master/collection1/data/index [CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593809599/master/collection1/data/index;done=false>>]
[junit4] 2> 975070 T1341 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593809599/master/collection1/data/index
[junit4] 2> 975070 T1341 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 975123 T1341 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=541434570
[junit4] 2> 975124 T1341 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@3abbf106
[junit4] 2> 975125 T1341 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> 975125 T1341 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 975126 T1341 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 975126 T1341 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 975127 T1341 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 975128 T1341 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 975128 T1341 oasc.CachingDirectoryFactory.closeCacheValue looking to close /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593809924/slave/collection1/data/index [CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593809924/slave/collection1/data/index;done=false>>]
[junit4] 2> 975129 T1341 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593809924/slave/collection1/data/index
[junit4] 2> 975129 T1341 oasc.CachingDirectoryFactory.closeCacheValue looking to close /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593809924/slave/collection1/data [CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593809924/slave/collection1/data;done=false>>]
[junit4] 2> 975130 T1341 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1378593809924/slave/collection1/data
[junit4] 2> 975130 T1341 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 975194 T1341 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: test params are: codec=Asserting, sim=DefaultSimilarity, locale=uk, timezone=America/Scoresbysund
[junit4] 2> NOTE: FreeBSD 9.1-RELEASE-p3 amd64/Sun Microsystems Inc. 1.6.0_32 (64-bit)/cpus=16,threads=1,free=45656768,total=270073856
[junit4] 2> NOTE: All tests run in this JVM: [IndexSchemaTest, SolrInfoMBeanTest, TestJmxMonitoredMap, TestFunctionQuery, TestDynamicFieldCollectionResource, DistributedTermsComponentTest, ZkCLITest, BadComponentTest, TestSearchPerf, TestCoreContainer, TestMergePolicyConfig, CSVRequestHandlerTest, SpellPossibilityIteratorTest, RecoveryZkTest, TestSolrQueryParserResource, HdfsDirectoryTest, DateMathParserTest, ReturnFieldsTest, TestSolrXMLSerializer, SimpleFacetsTest, SearchHandlerTest, OverseerCollectionProcessorTest, TestStressVersions, OverseerTest, TestSchemaSimilarityResource, PrimitiveFieldTypeTest, TestRealTimeGet, SuggesterFSTTest, TermVectorComponentTest, BasicFunctionalityTest, URLClassifyProcessorTest, TestReplicationHandler]
[junit4] Completed on J0 in 582.63s, 14 tests, 1 failure <<< FAILURES!
[...truncated 731 lines...]
BUILD FAILED
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/build.xml:409: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/build.xml:382: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/build.xml:39: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build.xml:189: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/common-build.xml:455: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/lucene/common-build.xml:1233: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/lucene/common-build.xml:876: There were test failures: 325 suites, 1418 tests, 1 failure, 32 ignored (4 assumptions)
Total time: 113 minutes 32 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure
[JENKINS] Lucene-Solr-NightlyTests-4.x - Build # 370 - Still
Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-4.x/370/
1 tests failed.
REGRESSION: org.apache.solr.handler.component.DistributedSpellCheckComponentTest.testDistribSearch
Error Message:
Captured an uncaught exception in thread: Thread[id=279, name=Thread-147, state=RUNNABLE, group=TGRP-DistributedSpellCheckComponentTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=279, name=Thread-147, state=RUNNABLE, group=TGRP-DistributedSpellCheckComponentTest]
at __randomizedtesting.SeedInfo.seed([5902CA53FEEB96A5:D8E4444B89B4F699]:0)
Caused by: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:16861
at __randomizedtesting.SeedInfo.seed([5902CA53FEEB96A5]:0)
at org.apache.solr.BaseDistributedSearchTestCase$5.run(BaseDistributedSearchTestCase.java:549)
Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:16861
at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:431)
at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:180)
at org.apache.solr.client.solrj.request.QueryRequest.process(QueryRequest.java:90)
at org.apache.solr.client.solrj.SolrServer.query(SolrServer.java:301)
at org.apache.solr.BaseDistributedSearchTestCase$5.run(BaseDistributedSearchTestCase.java:544)
Caused by: java.net.SocketTimeoutException: Read timed out
at java.net.SocketInputStream.socketRead0(Native Method)
at java.net.SocketInputStream.read(SocketInputStream.java:146)
at org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:166)
at org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:90)
at org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:281)
at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:92)
at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:62)
at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:254)
at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:289)
at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:252)
at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:191)
at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:300)
at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:127)
at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:717)
at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:522)
at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:906)
at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:805)
at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:784)
at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:365)
... 4 more
Build Log:
[...truncated 9042 lines...]
[junit4] Suite: org.apache.solr.handler.component.DistributedSpellCheckComponentTest
[junit4] 2> 104969 T182 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /
[junit4] 2> 104973 T182 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
[junit4] 2> 104977 T182 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 104981 T182 oejs.AbstractConnector.doStart Started SocketConnector@127.0.0.1:16838
[junit4] 2> 104982 T182 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 104982 T182 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 104983 T182 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test-files/solr
[junit4] 2> 104983 T182 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test-files/solr/'
[junit4] 2> 105021 T182 oasc.ConfigSolr.fromFile Loading container configuration from /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test-files/solr/solr.xml
[junit4] 2> 105093 T182 oasc.CoreContainer.<init> New CoreContainer 2116316013
[junit4] 2> 105094 T182 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test-files/solr/]
[junit4] 2> 105095 T182 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 120000
[junit4] 2> 105096 T182 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 105096 T182 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 105097 T182 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 105098 T182 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 105098 T182 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 105099 T182 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 105099 T182 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 105100 T182 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 105100 T182 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=120000&connTimeout=15000&retry=false
[junit4] 2> 105118 T182 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 105118 T182 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 105125 T192 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test-files/solr/collection1
[junit4] 2> 105125 T192 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test-files/solr/collection1/'
[junit4] 2> 105126 T192 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 105127 T192 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 105178 T192 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_45
[junit4] 2> 105235 T192 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 105236 T192 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 105245 T192 oass.IndexSchema.readSchema [null] Schema name=test
[junit4] 2> 105685 T192 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 105685 T192 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 105686 T192 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 105695 T192 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 105698 T192 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 105708 T192 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 105711 T192 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 105714 T192 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 105715 T192 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 105715 T192 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 105715 T192 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 105715 T192 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 105716 T192 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 105716 T192 oasc.SolrCore.initDirectoryFactory solr.NRTCachingDirectoryFactory
[junit4] 2> 105746 T192 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test-files/solr/collection1/, dataDir=./org.apache.solr.handler.component.DistributedSpellCheckComponentTest-1378678444197/control/data/
[junit4] 2> 105746 T192 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@6fa37fac
[junit4] 2> 105747 T192 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/org.apache.solr.handler.component.DistributedSpellCheckComponentTest-1378678444197/control/data
[junit4] 2> 105748 T192 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.handler.component.DistributedSpellCheckComponentTest-1378678444197/control/data/index/
[junit4] 2> 105748 T192 oasc.SolrCore.initIndex WARN [collection1] Solr index directory './org.apache.solr.handler.component.DistributedSpellCheckComponentTest-1378678444197/control/data/index' doesn't exist. Creating new index...
[junit4] 2> 105749 T192 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/org.apache.solr.handler.component.DistributedSpellCheckComponentTest-1378678444197/control/data/index
[junit4] 2> 105750 T192 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@3431b5d7
[junit4] 2> 105760 T192 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/org.apache.solr.handler.component.DistributedSpellCheckComponentTest-1378678444197/control/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2b995106; maxCacheMB=48.0 maxMergeSizeMB=4.0)),segFN=segments_1,generation=1}
[junit4] 2> 105760 T192 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 105761 T192 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4] 2> 105764 T192 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 105764 T192 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 105764 T192 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 105765 T192 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 105765 T192 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 105765 T192 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 105765 T192 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
[junit4] 2> 105766 T192 oasup.UniqFieldsUpdateProcessorFactory.init WARN Use of the 'fields' init param in UniqFieldsUpdateProcessorFactory is deprecated, please use 'fieldName' (or another FieldMutatingUpdateProcessorFactory selector option) instead
[junit4] 2> 105766 T192 oasup.UniqFieldsUpdateProcessorFactory.init Replacing 'fields' init param with (individual) 'fieldName' params
[junit4] 2> 105766 T192 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 105766 T192 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 105767 T192 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 105767 T192 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 105767 T192 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 105767 T192 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 105768 T192 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 105768 T192 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 105769 T192 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 105769 T192 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4] 2> 105770 T192 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 105770 T192 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 105770 T192 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 105771 T192 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 105771 T192 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 105771 T192 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 105772 T192 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 105772 T192 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 105773 T192 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 105773 T192 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 105773 T192 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 105774 T192 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 105774 T192 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 105775 T192 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 105775 T192 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 105775 T192 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 105782 T192 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 105786 T192 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 105787 T192 oasc.SolrCore.initDeprecatedSupport WARN adding ShowFileRequestHandler with hidden files: [SCHEMA-REQUIRED-FIELDS.XML, SCHEMA-MINIMAL.XML, BAD-SCHEMA-DUP-DYNAMICFIELD.XML, SCHEMA-REPLICATION2.XML, TRIVIAL.UPDATEPROCESSOR1.JS, SOLRCONFIG-CACHING.XML, SOLRCONFIG-REPEATER.XML, BAD-SCHEMA-CURRENCY-FT-BOGUS-CODE-IN-XML.XML, SOLRCONFIG-TLOG.XML, SOLRCONFIG-COMPONENTS-NAME.XML, BAD-SCHEMA-UNIQUEKEY-MULTIVALUED.XML, SCHEMA11.XML, MISSLEADING.EXTENSION.UPDATEPROCESSOR.JS.TXT, SOLRCONFIG-SLAVE.XML, ELEVATE.XML, TRIVIAL.UPDATEPROCESSOR0.JS, SCHEMA-SWEETSPOT.XML, SCHEMA-CHARFILTERS.XML, SCHEMA-IB.XML, BAD-SCHEMA-MISPLACED-ASTERISK-COPYFIELD-SOURCE-SHOULD-FAIL-TEST.XML, DA_UTF8.XML, SOLRCONFIG-NOOPREGEN.XML, MISSING.FUNCTIONS.UPDATEPROCESSOR.JS, SCHEMA-ONE-FIELD-NO-DYNAMIC-FIELD-UNIQUE-KEY.XML, SCHEMA-SNIPPET-TYPE.XML, STOPWORDSWRONGENCODING.TXT, SCHEMA-NUMERIC.XML, SCHEMA-REVERSED.XML, STOPTYPES-2.TXT, BAD-SCHEMA-CURRENCY-FT-MULTIVALUED.XML, SOLRCONFIG-SPELLCHECKCOMPONENT.XML, BAD-SCHEMA-CURRENCY-MULTIVALUED.XML, SCHEMA-DFR.XML, BAD-SCHEMA-NOT-INDEXED-BUT-POS.XML, OPEN-EXCHANGE-RATES.JSON, STOPWITHBOM.TXT, SCHEMA-BINARYFIELD.XML, SOLRCONFIG-SPELLCHECKER.XML, SOLRCONFIG-UPDATE-PROCESSOR-CHAINS.XML, BAD-SCHEMA-OMIT-TF-BUT-NOT-POS.XML, BAD-SCHEMA-DUP-FIELDTYPE.XML, SOLRCONFIG-MINIMAL.XML, BAD-SCHEMA-CURRENCY-DYNAMIC-MULTIVALUED.XML, BAD-SCHEMA-UNSUPPORTED-DOCVALUES.XML, SCHEMA_CODEC.XML, SOLRCONFIG-FUNCTIONQUERY.XML, SOLRCONFIG-ELEVATE.XML, SCHEMA-FOLDING.XML, SCHEMA-STOP-KEEP.XML, SOLRCONFIG-TIEREDMERGEPOLICY.XML, STOP-1.TXT, SOLRCONFIG-MASTER2.XML, SCHEMA-SPELLCHECKER.XML, SOLRCONFIG-RESPONSE-LOG-COMPONENT.XML, SOLRCONFIG-LAZYWRITER.XML, BAD-MP-SOLRCONFIG.XML, SCHEMA-COLLATEFILTER.XML, BAD-SCHEMA-MULTIPLE-ASTERISK-COPYFIELD-DEST-SHOULD-FAIL-TEST.XML, HUNSPELL-TEST.DIC, SOLRCONFIG-XINCLUDE.XML, BAD-SCHEMA-CODEC-GLOBAL-VS-FT-MISMATCH.XML, SCHEMA-SIM.XML, BAD-SCHEMA-SIM-GLOBAL-VS-FT-MISMATCH.XML, SOLRCONFIG-ADD-SCHEMA-FIELDS-UPDATE-PROCESSOR-CHAINS.XML, SOLRCONFIG_CODEC.XML, SCHEMA-SYNONYM-TOKENIZER.XML, JASUGGEST.TXT, SCHEMA-REST-LUCENE-MATCH-VERSION.XML, SCHEMA-TFIDF.XML, SCHEMA-ADD-SCHEMA-FIELDS-UPDATE-PROCESSOR.XML, PHRASESUGGEST.TXT, OLD_SYNONYMS.TXT, SOLRCONFIG-DELPOLICY2.XML, BAD-SCHEMA-DUP-FIELD.XML, SOLRCONFIG-NOCACHE.XML, ADDFIELDS.UPDATEPROCESSOR.JS, COMPOUNDDICTIONARY.TXT, BAD-SCHEMA-UNIQUEKEY-IS-COPYFIELD-DEST.XML, MAPPING-ISOLATIN1ACCENT.TXT, BAD_SOLRCONFIG.XML, SOLRCONFIG.SNIPPET.RANDOMINDEXCONFIG.XML, BAD-SCHEMA-EXTERNAL-FILEFIELD.XML, THROW.ERROR.ON.ADD.UPDATEPROCESSOR.JS, SOLRCONFIG-HIGHLIGHT.XML, SCHEMA-POSTINGSHIGHLIGHT.XML, BAD-SOLRCONFIG-UNEXPECTED-SCHEMA-ATTRIBUTE.XML, REGEX-BOOST-PROCESSOR-TEST.TXT, BAD-SCHEMA-NONTEXT-ANALYZER.XML, CURRENCY.XML, SOLRCONFIG-MASTER.XML, SOLRCONFIG-MERGEPOLICY-LEGACY.XML, SOLRCONFIG-BASIC.XML, DA_COMPOUNDDICTIONARY.TXT, SCHEMA-COPYFIELD-TEST.XML, BAD-SOLRCONFIG-BOGUS-SCRIPTENGINE-NAME.XML, SOLRCONFIG-QUERYSENDER.XML, SOLRCONFIG-SNIPPET-PROCESSOR.XML, SCHEMA-REPLICATION1.XML, BAD-SOLRCONFIG-MULTIPLE-INDEXCONFIGS.XML, BAD-SCHEMA-NON-GLOB-COPYFIELD-SOURCE-MATCHING-NOTHING-SHOULD-FAIL-TEST.XML, CONDITIONAL.UPDATEPROCESSOR.JS, SCHEMA-TINY.XML, SOLRCONFIG-DEFAULTS.XML, HYPHENATION.DTD, BAD-SOLRCONFIG-SCHEMA-MUTABLE-BUT-NOT-MANAGED.XML, STEMDICT.TXT, SCHEMA-PHRASESUGGEST.XML, SCHEMA-ID-AND-VERSION-FIELDS-ONLY.XML, HUNSPELL-TEST.AFF, BAD-SCHEMA-CURRENCY-FT-OER-NORATES.XML, STOPTYPES-1.TXT, SOLRCONFIG-TRANSFORMERS.XML, BAD-SCHEMA-NOT-INDEXED-BUT-TF.XML, SCHEMA-DOCVALUES.XML, SOLRCONFIG-INFOSTREAM-LOGGING.XML, WDFTYPES.TXT, BAD-SCHEMA-BOGUS-ANALYSIS-PARAMETERS.XML, SOLRCONFIG-PHRASESUGGEST.XML, KEEP-1.TXT, SCHEMA-SPATIAL.XML, SOLRCONFIG-POSTINGSHIGHLIGHT.XML, SOLRCONFIG-WARMER.XML, SOLRCONFIG-TEST-MISC.XML, SCHEMA-XINCLUDE.XML, SOLRCONFIG-MASTER1.XML, BAD-SCHEMA-MULTIPLE-ASTERISK-COPYFIELD-SOURCE-SHOULD-FAIL-TEST.XML, SCHEMA-BEHAVIOR.XML, SYNONYMS.TXT, SCHEMA-DOCVALUESMULTI.XML, SOLRCONFIG-IMPLICITPROPERTIES.XML, SCHEMA-SNIPPET-TYPES.INCL, BAD-SCHEMA-SWEETSPOT-PARTIAL-HYPERBOLIC.XML, SOLRCONFIG-SOLR-749.XML, SCHEMA-EFF.XML, SOLRCONFIG-MASTER1-KEEPONEBACKUP.XML, STOP-2.TXT, SCHEMA-LMDIRICHLET.XML, SOLRCONFIG-TERMINDEX.XML, SCHEMA-ONE-FIELD-NO-DYNAMIC-FIELD.XML, BAD-SCHEMA-SWEETSPOT-PARTIAL-NORMS.XML, BAD-SCHEMA-SWEETSPOT-PARTIAL-BASELINE.XML, STOPWORDS.TXT, BAD-SCHEMA-BOGUS-FIELD-PARAMETERS.XML, FUZZYSUGGEST.TXT, BAD-SOLRCONFIG-MANAGED-SCHEMA-NAMED-SCHEMA.XML.XML, BAD-SCHEMA-NOT-INDEXED-BUT-NORMS.XML, SCHEMA-REST.XML, SOLRCONFIG-SOLCOREPROPERTIES.XML, SOLRCONFIG-PARSING-UPDATE-PROCESSOR-CHAINS.XML, BAD-SOLRCONFIG-WARMER-NO-REOPEN.XML, SOLRCONFIG-MANAGED-SCHEMA.XML, SOLRCONFIG-MERGEPOLICY-DEFAULTS.XML, BAD-SCHEMA-MISPLACED-ASTERISK-COPYFIELD-DEST-SHOULD-FAIL-TEST.XML, SCHEMA-LUCENEMATCHVERSION.XML, SCHEMA-CLASS-NAME-SHORTENING-ON-SERIALIZATION.XML, FRENCHARTICLES.TXT, SCHEMA15.XML, SOLRCONFIG-REQHANDLER.INCL, BAD-SOLRCONFIG-MULTIPLE-DIRFACTORY.XML, SCHEMASURROUND.XML, SOLRCONFIG-MASTER3.XML, SOLRCONFIG-SLAVE1.XML, SOLRCONFIG-DELPOLICY1.XML, SCHEMA-SNIPPET-FIELD.XML, SCHEMA-COLLATE.XML, STOP-SNOWBALL.TXT, PROTWORDS.TXT, SCHEMA-TRIE.XML, BAD-SOLRCONFIG-INVALID-SCRIPTFILE.XML, SCHEMA-DOCVALUESMISSING.XML, BAD-SOLRCONFIG-MULTIPLE-CFS.XML, SCHEMA-DOCVALUESFACETING.XML, SOLRCONFIG-SCRIPT-UPDATEPROCESSOR.XML, SCHEMA-LMJELINEKMERCER.XML, BAD-SOLRCONFIG-MISSING-SCRIPTFILE.XML, SOLRCONFIG-BASIC-LUCENEVERSION31.XML, BAD-SCHEMA-UNIQUEKEY-USES-DEFAULT.XML, XSLT, SOLRCONFIG-LOGMERGEPOLICY.XML, BAD-SCHEMA-SWEETSPOT-BOTH-TF.XML, SCHEMA-BM25.XML, SOLRCONFIG-QUERYSENDER-NOQUERY.XML, SOLRCONFIG-ALTDIRECTORY.XML, BAD-SCHEMA-CURRENCY-FT-BOGUS-DEFAULT-CODE.XML, SOLRCONFIG-INDEXCONFIG.XML, SOLRCONFIG_PERF.XML, BAD-CURRENCY.XML, SCHEMA-NOT-REQUIRED-UNIQUE-KEY.XML, BAD-SCHEMA-ANALYZER-CLASS-AND-NESTED.XML, KEEP-2.TXT, SCHEMA12.XML]
[junit4] 2> 105790 T192 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 105790 T192 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 105791 T192 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=4, maxMergeAtOnceExplicit=3, maxMergedSegmentMB=43.7705078125, floorSegmentMB=1.138671875, forceMergeDeletesPctAllowed=1.3584658825022267, segmentsPerTier=13.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.46180459969387966
[junit4] 2> 105793 T192 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/org.apache.solr.handler.component.DistributedSpellCheckComponentTest-1378678444197/control/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2b995106; maxCacheMB=48.0 maxMergeSizeMB=4.0)),segFN=segments_1,generation=1}
[junit4] 2> 105793 T192 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 105794 T192 oass.SolrIndexSearcher.<init> Opening Searcher@1c455c33 main
[junit4] 2> 105794 T192 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4] 2> 105803 T192 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 105852 T193 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1c455c33 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 105855 T192 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 105856 T182 oass.SolrDispatchFilter.init user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0
[junit4] 2> 105857 T182 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 105857 T182 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> 105876 T182 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 105879 T182 oejs.AbstractConnector.doStart Started SocketConnector@127.0.0.1:16839
[junit4] 2> 105880 T182 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 105880 T182 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 105881 T182 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test-files/solr
[junit4] 2> 105881 T182 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test-files/solr/'
[junit4] 2> 105918 T182 oasc.ConfigSolr.fromFile Loading container configuration from /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test-files/solr/solr.xml
[junit4] 2> 105990 T182 oasc.CoreContainer.<init> New CoreContainer 1445426246
[junit4] 2> 105991 T182 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test-files/solr/]
[junit4] 2> 105993 T182 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 120000
[junit4] 2> 105993 T182 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 105994 T182 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 105994 T182 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 105995 T182 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 105995 T182 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 105996 T182 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 105996 T182 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 105997 T182 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 105997 T182 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=120000&connTimeout=15000&retry=false
[junit4] 2> 106009 T182 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 106009 T182 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 106015 T204 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test-files/solr/collection1
[junit4] 2> 106016 T204 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test-files/solr/collection1/'
[junit4] 2> 106016 T204 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 106017 T204 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 106065 T204 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_45
[junit4] 2> 106120 T204 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 106121 T204 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 106128 T204 oass.IndexSchema.readSchema [null] Schema name=test
[junit4] 2> 106545 T204 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 106545 T204 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 106546 T204 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 106555 T204 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 106558 T204 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 106568 T204 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 106571 T204 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 106574 T204 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 106574 T204 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 106575 T204 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 106575 T204 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 106575 T204 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 106575 T204 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 106576 T204 oasc.SolrCore.initDirectoryFactory solr.NRTCachingDirectoryFactory
[junit4] 2> 106576 T204 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test-files/solr/collection1/, dataDir=./org.apache.solr.handler.component.DistributedSpellCheckComponentTest-1378678444197/shard0/data/
[junit4] 2> 106576 T204 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@6fa37fac
[junit4] 2> 106578 T204 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/org.apache.solr.handler.component.DistributedSpellCheckComponentTest-1378678444197/shard0/data
[junit4] 2> 106578 T204 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.handler.component.DistributedSpellCheckComponentTest-1378678444197/shard0/data/index/
[junit4] 2> 106579 T204 oasc.SolrCore.initIndex WARN [collection1] Solr index directory './org.apache.solr.handler.component.DistributedSpellCheckComponentTest-1378678444197/shard0/data/index' doesn't exist. Creating new index...
[junit4] 2> 106580 T204 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/org.apache.solr.handler.component.DistributedSpellCheckComponentTest-1378678444197/shard0/data/index
[junit4] 2> 106580 T204 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@515063db
[junit4] 2> 106589 T204 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/org.apache.solr.handler.component.DistributedSpellCheckComponentTest-1378678444197/shard0/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@74cbe891; maxCacheMB=48.0 maxMergeSizeMB=4.0)),segFN=segments_1,generation=1}
[junit4] 2> 106589 T204 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 106589 T204 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4] 2> 106593 T204 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 106593 T204 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 106593 T204 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 106594 T204 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 106594 T204 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 106594 T204 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 106594 T204 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
[junit4] 2> 106595 T204 oasup.UniqFieldsUpdateProcessorFactory.init WARN Use of the 'fields' init param in UniqFieldsUpdateProcessorFactory is deprecated, please use 'fieldName' (or another FieldMutatingUpdateProcessorFactory selector option) instead
[junit4] 2> 106595 T204 oasup.UniqFieldsUpdateProcessorFactory.init Replacing 'fields' init param with (individual) 'fieldName' params
[junit4] 2> 106595 T204 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 106596 T204 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 106596 T204 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 106596 T204 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 106597 T204 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 106597 T204 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 106597 T204 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 106598 T204 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 106598 T204 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 106599 T204 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4] 2> 106599 T204 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 106600 T204 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 106600 T204 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 106600 T204 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 106601 T204 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 106601 T204 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 106602 T204 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 106602 T204 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 106603 T204 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 106603 T204 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 106604 T204 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 106605 T204 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 106605 T204 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 106606 T204 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 106606 T204 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 106607 T204 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 106613 T204 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 106617 T204 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 106619 T204 oasc.SolrCore.initDeprecatedSupport WARN adding ShowFileRequestHandler with hidden files: [SCHEMA-REQUIRED-FIELDS.XML, SCHEMA-MINIMAL.XML, BAD-SCHEMA-DUP-DYNAMICFIELD.XML, SCHEMA-REPLICATION2.XML, TRIVIAL.UPDATEPROCESSOR1.JS, SOLRCONFIG-CACHING.XML, SOLRCONFIG-REPEATER.XML, BAD-SCHEMA-CURRENCY-FT-BOGUS-CODE-IN-XML.XML, SOLRCONFIG-TLOG.XML, SOLRCONFIG-COMPONENTS-NAME.XML, BAD-SCHEMA-UNIQUEKEY-MULTIVALUED.XML, SCHEMA11.XML, MISSLEADING.EXTENSION.UPDATEPROCESSOR.JS.TXT, SOLRCONFIG-SLAVE.XML, ELEVATE.XML, TRIVIAL.UPDATEPROCESSOR0.JS, SCHEMA-SWEETSPOT.XML, SCHEMA-CHARFILTERS.XML, SCHEMA-IB.XML, BAD-SCHEMA-MISPLACED-ASTERISK-COPYFIELD-SOURCE-SHOULD-FAIL-TEST.XML, DA_UTF8.XML, SOLRCONFIG-NOOPREGEN.XML, MISSING.FUNCTIONS.UPDATEPROCESSOR.JS, SCHEMA-ONE-FIELD-NO-DYNAMIC-FIELD-UNIQUE-KEY.XML, SCHEMA-SNIPPET-TYPE.XML, STOPWORDSWRONGENCODING.TXT, SCHEMA-NUMERIC.XML, SCHEMA-REVERSED.XML, STOPTYPES-2.TXT, BAD-SCHEMA-CURRENCY-FT-MULTIVALUED.XML, SOLRCONFIG-SPELLCHECKCOMPONENT.XML, BAD-SCHEMA-CURRENCY-MULTIVALUED.XML, SCHEMA-DFR.XML, BAD-SCHEMA-NOT-INDEXED-BUT-POS.XML, OPEN-EXCHANGE-RATES.JSON, STOPWITHBOM.TXT, SCHEMA-BINARYFIELD.XML, SOLRCONFIG-SPELLCHECKER.XML, SOLRCONFIG-UPDATE-PROCESSOR-CHAINS.XML, BAD-SCHEMA-OMIT-TF-BUT-NOT-POS.XML, BAD-SCHEMA-DUP-FIELDTYPE.XML, SOLRCONFIG-MINIMAL.XML, BAD-SCHEMA-CURRENCY-DYNAMIC-MULTIVALUED.XML, BAD-SCHEMA-UNSUPPORTED-DOCVALUES.XML, SCHEMA_CODEC.XML, SOLRCONFIG-FUNCTIONQUERY.XML, SOLRCONFIG-ELEVATE.XML, SCHEMA-FOLDING.XML, SCHEMA-STOP-KEEP.XML, SOLRCONFIG-TIEREDMERGEPOLICY.XML, STOP-1.TXT, SOLRCONFIG-MASTER2.XML, SCHEMA-SPELLCHECKER.XML, SOLRCONFIG-RESPONSE-LOG-COMPONENT.XML, SOLRCONFIG-LAZYWRITER.XML, BAD-MP-SOLRCONFIG.XML, SCHEMA-COLLATEFILTER.XML, BAD-SCHEMA-MULTIPLE-ASTERISK-COPYFIELD-DEST-SHOULD-FAIL-TEST.XML, HUNSPELL-TEST.DIC, SOLRCONFIG-XINCLUDE.XML, BAD-SCHEMA-CODEC-GLOBAL-VS-FT-MISMATCH.XML, SCHEMA-SIM.XML, BAD-SCHEMA-SIM-GLOBAL-VS-FT-MISMATCH.XML, SOLRCONFIG-ADD-SCHEMA-FIELDS-UPDATE-PROCESSOR-CHAINS.XML, SOLRCONFIG_CODEC.XML, SCHEMA-SYNONYM-TOKENIZER.XML, JASUGGEST.TXT, SCHEMA-REST-LUCENE-MATCH-VERSION.XML, SCHEMA-TFIDF.XML, SCHEMA-ADD-SCHEMA-FIELDS-UPDATE-PROCESSOR.XML, PHRASESUGGEST.TXT, OLD_SYNONYMS.TXT, SOLRCONFIG-DELPOLICY2.XML, BAD-SCHEMA-DUP-FIELD.XML, SOLRCONFIG-NOCACHE.XML, ADDFIELDS.UPDATEPROCESSOR.JS, COMPOUNDDICTIONARY.TXT, BAD-SCHEMA-UNIQUEKEY-IS-COPYFIELD-DEST.XML, MAPPING-ISOLATIN1ACCENT.TXT, BAD_SOLRCONFIG.XML, SOLRCONFIG.SNIPPET.RANDOMINDEXCONFIG.XML, BAD-SCHEMA-EXTERNAL-FILEFIELD.XML, THROW.ERROR.ON.ADD.UPDATEPROCESSOR.JS, SOLRCONFIG-HIGHLIGHT.XML, SCHEMA-POSTINGSHIGHLIGHT.XML, BAD-SOLRCONFIG-UNEXPECTED-SCHEMA-ATTRIBUTE.XML, REGEX-BOOST-PROCESSOR-TEST.TXT, BAD-SCHEMA-NONTEXT-ANALYZER.XML, CURRENCY.XML, SOLRCONFIG-MASTER.XML, SOLRCONFIG-MERGEPOLICY-LEGACY.XML, SOLRCONFIG-BASIC.XML, DA_COMPOUNDDICTIONARY.TXT, SCHEMA-COPYFIELD-TEST.XML, BAD-SOLRCONFIG-BOGUS-SCRIPTENGINE-NAME.XML, SOLRCONFIG-QUERYSENDER.XML, SOLRCONFIG-SNIPPET-PROCESSOR.XML, SCHEMA-REPLICATION1.XML, BAD-SOLRCONFIG-MULTIPLE-INDEXCONFIGS.XML, BAD-SCHEMA-NON-GLOB-COPYFIELD-SOURCE-MATCHING-NOTHING-SHOULD-FAIL-TEST.XML, CONDITIONAL.UPDATEPROCESSOR.JS, SCHEMA-TINY.XML, SOLRCONFIG-DEFAULTS.XML, HYPHENATION.DTD, BAD-SOLRCONFIG-SCHEMA-MUTABLE-BUT-NOT-MANAGED.XML, STEMDICT.TXT, SCHEMA-PHRASESUGGEST.XML, SCHEMA-ID-AND-VERSION-FIELDS-ONLY.XML, HUNSPELL-TEST.AFF, BAD-SCHEMA-CURRENCY-FT-OER-NORATES.XML, STOPTYPES-1.TXT, SOLRCONFIG-TRANSFORMERS.XML, BAD-SCHEMA-NOT-INDEXED-BUT-TF.XML, SCHEMA-DOCVALUES.XML, SOLRCONFIG-INFOSTREAM-LOGGING.XML, WDFTYPES.TXT, BAD-SCHEMA-BOGUS-ANALYSIS-PARAMETERS.XML, SOLRCONFIG-PHRASESUGGEST.XML, KEEP-1.TXT, SCHEMA-SPATIAL.XML, SOLRCONFIG-POSTINGSHIGHLIGHT.XML, SOLRCONFIG-WARMER.XML, SOLRCONFIG-TEST-MISC.XML, SCHEMA-XINCLUDE.XML, SOLRCONFIG-MASTER1.XML, BAD-SCHEMA-MULTIPLE-ASTERISK-COPYFIELD-SOURCE-SHOULD-FAIL-TEST.XML, SCHEMA-BEHAVIOR.XML, SYNONYMS.TXT, SCHEMA-DOCVALUESMULTI.XML, SOLRCONFIG-IMPLICITPROPERTIES.XML, SCHEMA-SNIPPET-TYPES.INCL, BAD-SCHEMA-SWEETSPOT-PARTIAL-HYPERBOLIC.XML, SOLRCONFIG-SOLR-749.XML, SCHEMA-EFF.XML, SOLRCONFIG-MASTER1-KEEPONEBACKUP.XML, STOP-2.TXT, SCHEMA-LMDIRICHLET.XML, SOLRCONFIG-TERMINDEX.XML, SCHEMA-ONE-FIELD-NO-DYNAMIC-FIELD.XML, BAD-SCHEMA-SWEETSPOT-PARTIAL-NORMS.XML, BAD-SCHEMA-SWEETSPOT-PARTIAL-BASELINE.XML, STOPWORDS.TXT, BAD-SCHEMA-BOGUS-FIELD-PARAMETERS.XML, FUZZYSUGGEST.TXT, BAD-SOLRCONFIG-MANAGED-SCHEMA-NAMED-SCHEMA.XML.XML, BAD-SCHEMA-NOT-INDEXED-BUT-NORMS.XML, SCHEMA-REST.XML, SOLRCONFIG-SOLCOREPROPERTIES.XML, SOLRCONFIG-PARSING-UPDATE-PROCESSOR-CHAINS.XML, BAD-SOLRCONFIG-WARMER-NO-REOPEN.XML, SOLRCONFIG-MANAGED-SCHEMA.XML, SOLRCONFIG-MERGEPOLICY-DEFAULTS.XML, BAD-SCHEMA-MISPLACED-ASTERISK-COPYFIELD-DEST-SHOULD-FAIL-TEST.XML, SCHEMA-LUCENEMATCHVERSION.XML, SCHEMA-CLASS-NAME-SHORTENING-ON-SERIALIZATION.XML, FRENCHARTICLES.TXT, SCHEMA15.XML, SOLRCONFIG-REQHANDLER.INCL, BAD-SOLRCONFIG-MULTIPLE-DIRFACTORY.XML, SCHEMASURROUND.XML, SOLRCONFIG-MASTER3.XML, SOLRCONFIG-SLAVE1.XML, SOLRCONFIG-DELPOLICY1.XML, SCHEMA-SNIPPET-FIELD.XML, SCHEMA-COLLATE.XML, STOP-SNOWBALL.TXT, PROTWORDS.TXT, SCHEMA-TRIE.XML, BAD-SOLRCONFIG-INVALID-SCRIPTFILE.XML, SCHEMA-DOCVALUESMISSING.XML, BAD-SOLRCONFIG-MULTIPLE-CFS.XML, SCHEMA-DOCVALUESFACETING.XML, SOLRCONFIG-SCRIPT-UPDATEPROCESSOR.XML, SCHEMA-LMJELINEKMERCER.XML, BAD-SOLRCONFIG-MISSING-SCRIPTFILE.XML, SOLRCONFIG-BASIC-LUCENEVERSION31.XML, BAD-SCHEMA-UNIQUEKEY-USES-DEFAULT.XML, XSLT, SOLRCONFIG-LOGMERGEPOLICY.XML, BAD-SCHEMA-SWEETSPOT-BOTH-TF.XML, SCHEMA-BM25.XML, SOLRCONFIG-QUERYSENDER-NOQUERY.XML, SOLRCONFIG-ALTDIRECTORY.XML, BAD-SCHEMA-CURRENCY-FT-BOGUS-DEFAULT-CODE.XML, SOLRCONFIG-INDEXCONFIG.XML, SOLRCONFIG_PERF.XML, BAD-CURRENCY.XML, SCHEMA-NOT-REQUIRED-UNIQUE-KEY.XML, BAD-SCHEMA-ANALYZER-CLASS-AND-NESTED.XML, KEEP-2.TXT, SCHEMA12.XML]
[junit4] 2> 106622 T204 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 106622 T204 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 106624 T204 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=4, maxMergeAtOnceExplicit=3, maxMergedSegmentMB=43.7705078125, floorSegmentMB=1.138671875, forceMergeDeletesPctAllowed=1.3584658825022267, segmentsPerTier=13.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.46180459969387966
[junit4] 2> 106625 T204 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/org.apache.solr.handler.component.DistributedSpellCheckComponentTest-1378678444197/shard0/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@74cbe891; maxCacheMB=48.0 maxMergeSizeMB=4.0)),segFN=segments_1,generation=1}
[junit4] 2> 106625 T204 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 106626 T204 oass.SolrIndexSearcher.<init> Opening Searcher@4ebe0382 main
[junit4] 2> 106626 T204 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4] 2> 106633 T204 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 106688 T205 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4ebe0382 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 106695 T204 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 106696 T182 oass.SolrDispatchFilter.init user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0
[junit4] 2> 106697 T182 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 106698 T182 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> ASYNC NEW_CORE C25 name=collection1 org.apache.solr.core.SolrCore@339274f9
[junit4] 2> 106736 T185 C25 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1445649130146758656)} 0 3
[junit4] 2> ASYNC NEW_CORE C26 name=collection1 org.apache.solr.core.SolrCore@188cf401
[junit4] 2> 106747 T197 C26 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1445649130159341568)} 0 2
[junit4] 2> 106766 T185 C25 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[1 (1445649130165633024)]} 0 16
[junit4] 2> 106773 T197 C26 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[1 (1445649130185555968)]} 0 4
[junit4] 2> 106778 T185 C25 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[2 (1445649130192896000)]} 0 2
[junit4] 2> 106783 T197 C26 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[2 (1445649130198138880)]} 0 2
[junit4] 2> 106788 T185 C25 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[3 (1445649130202333184)]} 0 1
[junit4] 2> 106792 T197 C26 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[3 (1445649130207576064)]} 0 2
[junit4] 2> 106797 T185 C25 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[4 (1445649130211770368)]} 0 2
[junit4] 2> 106802 T197 C26 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[4 (1445649130218061824)]} 0 2
[junit4] 2> 106806 T185 C25 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[5 (1445649130222256128)]} 0 1
[junit4] 2> 106810 T197 C26 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[5 (1445649130226450432)]} 0 1
[junit4] 2> 106815 T185 C25 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[6 (1445649130231693312)]} 0 2
[junit4] 2> 106820 T197 C26 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[6 (1445649130235887616)]} 0 2
[junit4] 2> 106825 T185 C25 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[7 (1445649130241130496)]} 0 2
[junit4] 2> 106830 T197 C26 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[7 (1445649130247421952)]} 0 2
[junit4] 2> 106835 T185 C25 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[8 (1445649130252664832)]} 0 2
[junit4] 2> 106838 T197 C26 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[8 (1445649130255810560)]} 0 1
[junit4] 2> 106843 T185 C25 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[9 (1445649130260004864)]} 0 2
[junit4] 2> 106848 T197 C26 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[9 (1445649130265247744)]} 0 2
[junit4] 2> 106852 T185 C25 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[10 (1445649130270490624)]} 0 1
[junit4] 2> 106857 T197 C26 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[10 (1445649130275733504)]} 0 2
[junit4] 2> 106862 T185 C25 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[12 (1445649130280976384)]} 0 1
[junit4] 2> 106865 T197 C26 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[12 (1445649130284122112)]} 0 1
[junit4] 2> 106871 T185 C25 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[13 (1445649130289364992)]} 0 3
[junit4] 2> 106876 T197 C26 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[13 (1445649130295656448)]} 0 2
[junit4] 2> 106882 T185 C25 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[14 (1445649130300899328)]} 0 2
[junit4] 2> 106887 T197 C26 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[14 (1445649130307190784)]} 0 2
[junit4] 2> 106894 T185 C25 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[15 (1445649130312433664)]} 0 3
[junit4] 2> 106899 T197 C26 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[15 (1445649130318725120)]} 0 2
[junit4] 2> 106904 T185 C25 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[16 (1445649130325016576)]} 0 2
[junit4] 2> 106910 T197 C26 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[16 (1445649130330259456)]} 0 3
[junit4] 2> 106915 T185 C25 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[17 (1445649130336550912)]} 0 2
[junit4] 2> 106920 T197 C26 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[17 (1445649130341793792)]} 0 2
[junit4] 2> 106925 T185 C25 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[18 (1445649130347036672)]} 0 2
[junit4] 2> 106931 T197 C26 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[18 (1445649130352279552)]} 0 3
[junit4] 2> 106935 T185 C25 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[19 (1445649130357522432)]} 0 2
[junit4] 2> 106940 T197 C26 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[19 (1445649130362765312)]} 0 2
[junit4] 2> 106946 T185 C25 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[20 (1445649130368008192)]} 0 3
[junit4] 2> 106951 T197 C26 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[20 (1445649130374299648)]} 0 2
[junit4] 2> 106957 T185 C25 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[21 (1445649130379542528)]} 0 2
[junit4] 2> 106962 T197 C26 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[21 (1445649130384785408)]} 0 2
[junit4] 2> 106965 T185 C25 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[22 (1445649130388979712)]} 0 1
[junit4] 2> 106970 T197 C26 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[22 (1445649130393174016)]} 0 2
[junit4] 2> 106974 T185 C25 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[23 (1445649130398416896)]} 0 2
[junit4] 2> 106979 T197 C26 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[23 (1445649130403659776)]} 0 2
[junit4] 2> 106984 T185 C25 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[24 (1445649130408902656)]} 0 2
[junit4] 2> 106989 T197 C26 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[24 (1445649130413096960)]} 0 2
[junit4] 2> 106994 T185 C25 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[25 (1445649130419388416)]} 0 2
[junit4] 2> 106998 T197 C26 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[25 (1445649130424631296)]} 0 1
[junit4] 2> 107002 T185 C25 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 107106 T185 C25 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/org.apache.solr.handler.component.DistributedSpellCheckComponentTest-1378678444197/control/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2b995106; maxCacheMB=48.0 maxMergeSizeMB=4.0)),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/org.apache.solr.handler.component.DistributedSpellCheckComponentTest-1378678444197/control/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2b995106; maxCacheMB=48.0 maxMergeSizeMB=4.0)),segFN=segments_2,generation=2}
[junit4] 2> 107107 T185 C25 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 107116 T185 C25 oass.SolrIndexSearcher.<init> Opening Searcher@6724e231 main
[junit4] 2> 107117 T185 C25 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 107119 T193 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6724e231 main{StandardDirectoryReader(segments_2:3:nrt _0(4.5):C24)}
[junit4] 2> 107120 T185 C25 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 118
[junit4] 2> 107123 T197 C26 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 107204 T197 C26 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/org.apache.solr.handler.component.DistributedSpellCheckComponentTest-1378678444197/shard0/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@74cbe891; maxCacheMB=48.0 maxMergeSizeMB=4.0)),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/org.apache.solr.handler.component.DistributedSpellCheckComponentTest-1378678444197/shard0/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@74cbe891; maxCacheMB=48.0 maxMergeSizeMB=4.0)),segFN=segments_2,generation=2}
[junit4] 2> 107204 T197 C26 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 107213 T197 C26 oass.SolrIndexSearcher.<init> Opening Searcher@4eb754b0 main
[junit4] 2> 107214 T197 C26 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 107216 T205 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4eb754b0 main{StandardDirectoryReader(segments_2:3:nrt _0(4.5):C24)}
[junit4] 2> 107216 T197 C26 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 93
[junit4] 2> 107320 T185 C25 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=true&fl=id,lowerfilt&shards.qt=spellCheckCompRH&q=*:*&wt=javabin&qt=spellCheckCompRH&version=2&spellcheck.build=true} hits=24 status=0 QTime=99
[junit4] 2> 107524 T198 C26 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=true&spellcheck.extendedResults=false&shards.qt=spellCheckCompRH&distrib=false&wt=javabin&version=2&spellcheck.onlyMorePopular=false&rows=10&NOW=1378678446548&shard.url=127.0.0.1:16839/&fl=id,score&start=0&q=*:*&spellcheck.count=5&isShard=true&qt=spellCheckCompRH&fsv=true&spellcheck.build=true} hits=24 status=0 QTime=73
[junit4] 2> 107546 T198 C26 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=false&spellcheck.extendedResults=false&shards.qt=spellCheckCompRH&ids=3,2,1,10,7,6,5,4,9,8&distrib=false&wt=javabin&version=2&spellcheck.onlyMorePopular=false&NOW=1378678446548&fl=id,lowerfilt&shard.url=127.0.0.1:16839/&q=*:*&spellcheck.count=1&qt=spellCheckCompRH&isShard=true&spellcheck.build=true} status=0 QTime=1
[junit4] 2> 107556 T197 C26 oashc.SpellCheckComponent.finishStage 127.0.0.1:16839/ null
[junit4] 2> 107557 T197 C26 oashc.SpellCheckComponent.finishStage 127.0.0.1:16839/ null
[junit4] 2> 107563 T197 C26 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=true&shards=127.0.0.1:16839/&fl=id,lowerfilt&shards.qt=spellCheckCompRH&q=*:*&wt=javabin&qt=spellCheckCompRH&version=2&spellcheck.build=true} hits=24 status=0 QTime=238
[junit4] 2> 107621 T185 C25 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=true&fl=id,lowerfilt&shards.qt=spellCheckCompRH&q=*:*&spellcheck.q=toyata&distrib=false&wt=javabin&qt=spellCheckCompRH&version=2} hits=24 status=0 QTime=50
[junit4] 2> 107891 T198 C26 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=true&spellcheck.extendedResults=false&shards.qt=spellCheckCompRH&spellcheck.q=toyata&distrib=false&wt=javabin&version=2&spellcheck.onlyMorePopular=false&rows=10&NOW=1378678446856&shard.url=[ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/&fl=id,score&start=0&q=*:*&spellcheck.count=5&isShard=true&qt=spellCheckCompRH&fsv=true} hits=24 status=0 QTime=9
[junit4] 2> 107897 T198 C26 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=false&spellcheck.extendedResults=false&shards.qt=spellCheckCompRH&ids=3,2,1,10,7,6,5,4,9,8&spellcheck.q=toyata&distrib=false&wt=javabin&version=2&spellcheck.onlyMorePopular=false&NOW=1378678446856&fl=id,lowerfilt&shard.url=[ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/&q=*:*&spellcheck.count=1&qt=spellCheckCompRH&isShard=true} status=0 QTime=1
[junit4] 2> 107898 T197 C26 oashc.SpellCheckComponent.finishStage [ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/ {suggestions={toyata={numFound=2,startOffset=0,endOffset=6,suggestion=[toyota, sonata]}}}
[junit4] 2> 107899 T197 C26 oashc.SpellCheckComponent.finishStage [ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/ null
[junit4] 2> 107899 T197 C26 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=true&shards=[ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/&fl=id,lowerfilt&shards.qt=spellCheckCompRH&q=*:*&spellcheck.q=toyata&wt=javabin&qt=spellCheckCompRH&version=2} hits=24 status=0 QTime=266
[junit4] 2> 107901 T182 oas.BaseDistributedSearchTestCase.query starting stress...
[junit4] 2> 107925 T198 C26 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=true&spellcheck.extendedResults=false&shards.qt=spellCheckCompRH&spellcheck.q=toyata&distrib=false&wt=javabin&version=2&spellcheck.onlyMorePopular=false&rows=10&NOW=1378678447136&shard.url=[ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/&fl=id,score&start=0&q=*:*&spellcheck.count=5&isShard=true&qt=spellCheckCompRH&fsv=true} hits=24 status=0 QTime=7
[junit4] 2> 107925 T202 C26 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=true&spellcheck.extendedResults=false&shards.qt=spellCheckCompRH&spellcheck.q=toyata&distrib=false&wt=javabin&version=2&spellcheck.onlyMorePopular=false&rows=10&NOW=1378678447136&shard.url=[ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/&fl=id,score&start=0&q=*:*&spellcheck.count=5&isShard=true&qt=spellCheckCompRH&fsv=true} hits=24 status=0 QTime=7
[junit4] 2> 107925 T201 C26 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=true&spellcheck.extendedResults=false&shards.qt=spellCheckCompRH&spellcheck.q=toyata&distrib=false&wt=javabin&version=2&spellcheck.onlyMorePopular=false&rows=10&NOW=1378678447136&shard.url=[ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/&fl=id,score&start=0&q=*:*&spellcheck.count=5&isShard=true&qt=spellCheckCompRH&fsv=true} hits=24 status=0 QTime=7
[junit4] 2> 107931 T201 C26 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=false&spellcheck.extendedResults=false&shards.qt=spellCheckCompRH&ids=3,2,1,10,7,6,5,4,9,8&spellcheck.q=toyata&distrib=false&wt=javabin&version=2&spellcheck.onlyMorePopular=false&NOW=1378678447136&fl=id,lowerfilt&shard.url=[ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/&q=*:*&spellcheck.count=1&qt=spellCheckCompRH&isShard=true} status=0 QTime=1
[junit4] 2> 107931 T202 C26 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=false&spellcheck.extendedResults=false&shards.qt=spellCheckCompRH&ids=3,2,1,10,7,6,5,4,9,8&spellcheck.q=toyata&distrib=false&wt=javabin&version=2&spellcheck.onlyMorePopular=false&NOW=1378678447136&fl=id,lowerfilt&shard.url=[ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/&q=*:*&spellcheck.count=1&qt=spellCheckCompRH&isShard=true} status=0 QTime=1
[junit4] 2> 107932 T199 C26 oashc.SpellCheckComponent.finishStage [ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/ {suggestions={toyata={numFound=2,startOffset=0,endOffset=6,suggestion=[toyota, sonata]}}}
[junit4] 2> 107932 T198 C26 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=false&spellcheck.extendedResults=false&shards.qt=spellCheckCompRH&ids=3,2,1,10,7,6,5,4,9,8&spellcheck.q=toyata&distrib=false&wt=javabin&version=2&spellcheck.onlyMorePopular=false&NOW=1378678447136&fl=id,lowerfilt&shard.url=[ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/&q=*:*&spellcheck.count=1&qt=spellCheckCompRH&isShard=true} status=0 QTime=1
[junit4] 2> 107933 T200 C26 oashc.SpellCheckComponent.finishStage [ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/ {suggestions={toyata={numFound=2,startOffset=0,endOffset=6,suggestion=[toyota, sonata]}}}
[junit4] 2> 107932 T199 C26 oashc.SpellCheckComponent.finishStage [ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/ null
[junit4] 2> 107933 T200 C26 oashc.SpellCheckComponent.finishStage [ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/ null
[junit4] 2> 107934 T199 C26 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=true&shards=[ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/&fl=id,lowerfilt&shards.qt=spellCheckCompRH&q=*:*&spellcheck.q=toyata&wt=javabin&qt=spellCheckCompRH&version=2} hits=24 status=0 QTime=21
[junit4] 2> 107934 T197 C26 oashc.SpellCheckComponent.finishStage [ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/ {suggestions={toyata={numFound=2,startOffset=0,endOffset=6,suggestion=[toyota, sonata]}}}
[junit4] 2> 107934 T200 C26 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=true&shards=[ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/&fl=id,lowerfilt&shards.qt=spellCheckCompRH&q=*:*&spellcheck.q=toyata&wt=javabin&qt=spellCheckCompRH&version=2} hits=24 status=0 QTime=21
[junit4] 2> 107935 T197 C26 oashc.SpellCheckComponent.finishStage [ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/ null
[junit4] 2> 107936 T197 C26 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=true&shards=[ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/&fl=id,lowerfilt&shards.qt=spellCheckCompRH&q=*:*&spellcheck.q=toyata&wt=javabin&qt=spellCheckCompRH&version=2} hits=24 status=0 QTime=23
[junit4] 2> 107947 T198 C26 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=true&spellcheck.extendedResults=false&shards.qt=spellCheckCompRH&spellcheck.q=toyata&distrib=false&wt=javabin&version=2&spellcheck.onlyMorePopular=false&rows=10&NOW=1378678447162&shard.url=[ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/&fl=id,score&start=0&q=*:*&spellcheck.count=5&isShard=true&qt=spellCheckCompRH&fsv=true} hits=24 status=0 QTime=4
[junit4] 2> 107947 T202 C26 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=true&spellcheck.extendedResults=false&shards.qt=spellCheckCompRH&spellcheck.q=toyata&distrib=false&wt=javabin&version=2&spellcheck.onlyMorePopular=false&rows=10&NOW=1378678447163&shard.url=[ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/&fl=id,score&start=0&q=*:*&spellcheck.count=5&isShard=true&qt=spellCheckCompRH&fsv=true} hits=24 status=0 QTime=4
[junit4] 2> 107948 T201 C26 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=true&spellcheck.extendedResults=false&shards.qt=spellCheckCompRH&spellcheck.q=toyata&distrib=false&wt=javabin&version=2&spellcheck.onlyMorePopular=false&rows=10&NOW=1378678447164&shard.url=[ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/&fl=id,score&start=0&q=*:*&spellcheck.count=5&isShard=true&qt=spellCheckCompRH&fsv=true} hits=24 status=0 QTime=4
[junit4] 2> 107952 T202 C26 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=false&spellcheck.extendedResults=false&shards.qt=spellCheckCompRH&ids=3,2,1,10,7,6,5,4,9,8&spellcheck.q=toyata&distrib=false&wt=javabin&version=2&spellcheck.onlyMorePopular=false&NOW=1378678447162&fl=id,lowerfilt&shard.url=[ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/&q=*:*&spellcheck.count=1&qt=spellCheckCompRH&isShard=true} status=0 QTime=1
[junit4] 2> 107953 T201 C26 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=false&spellcheck.extendedResults=false&shards.qt=spellCheckCompRH&ids=3,2,1,10,7,6,5,4,9,8&spellcheck.q=toyata&distrib=false&wt=javabin&version=2&spellcheck.onlyMorePopular=false&NOW=1378678447163&fl=id,lowerfilt&shard.url=[ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/&q=*:*&spellcheck.count=1&qt=spellCheckCompRH&isShard=true} status=0 QTime=1
[junit4] 2> 107954 T199 C26 oashc.SpellCheckComponent.finishStage [ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/ {suggestions={toyata={numFound=2,startOffset=0,endOffset=6,suggestion=[toyota, sonata]}}}
[junit4] 2> 107954 T199 C26 oashc.SpellCheckComponent.finishStage [ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/ null
[junit4] 2> 107954 T198 C26 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=false&spellcheck.extendedResults=false&shards.qt=spellCheckCompRH&ids=3,2,1,10,7,6,5,4,9,8&spellcheck.q=toyata&distrib=false&wt=javabin&version=2&spellcheck.onlyMorePopular=false&NOW=1378678447164&fl=id,lowerfilt&shard.url=[ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/&q=*:*&spellcheck.count=1&qt=spellCheckCompRH&isShard=true} status=0 QTime=1
[junit4] 2> 107955 T199 C26 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=true&shards=[ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/&fl=id,lowerfilt&shards.qt=spellCheckCompRH&q=*:*&spellcheck.q=toyata&wt=javabin&qt=spellCheckCompRH&version=2} hits=24 status=0 QTime=16
[junit4] 2> 107955 T200 C26 oashc.SpellCheckComponent.finishStage [ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/ {suggestions={toyata={numFound=2,startOffset=0,endOffset=6,suggestion=[toyota, sonata]}}}
[junit4] 2> 107956 T197 C26 oashc.SpellCheckComponent.finishStage [ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/ {suggestions={toyata={numFound=2,startOffset=0,endOffset=6,suggestion=[toyota, sonata]}}}
[junit4] 2> 107956 T200 C26 oashc.SpellCheckComponent.finishStage [ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/ null
[junit4] 2> 107957 T197 C26 oashc.SpellCheckComponent.finishStage [ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/ null
[junit4] 2> 107957 T200 C26 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=true&shards=[ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/&fl=id,lowerfilt&shards.qt=spellCheckCompRH&q=*:*&spellcheck.q=toyata&wt=javabin&qt=spellCheckCompRH&version=2} hits=24 status=0 QTime=17
[junit4] 2> 107958 T197 C26 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=true&shards=[ff01::213]:33332/|127.0.0.1:16839/|[ff01::114]:33332/|[ff01::083]:33332/&fl=id,lowerfilt&shards.qt=spellCheckCompRH&q=*:*&spellcheck.q=toyata&wt=javabin&qt=spellCheckCompRH&version=2} hits=24 status=0 QTime=17
[junit4] 2> 108124 T185 C25 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=true&fl=id,lowerfilt&spellcheck.extendedResults=true&shards.qt=spellCheckCompRH&q=*:*&spellcheck.q=toyata&distrib=false&group.field=id&group=true&wt=javabin&qt=spellCheckCompRH&version=2} hits=24 status=0 QTime=161
[junit4] 2> ASYNC NEW_CORE C27 name=collection1 org.apache.solr.core.SolrCore@188cf401
[junit4] 2> 108226 T198 C27 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=true&group.distributed.first=true&spellcheck.extendedResults=true&shards.qt=spellCheckCompRH&spellcheck.q=toyata&distrib=false&wt=javabin&version=2&spellcheck.onlyMorePopular=false&rows=10&NOW=1378678447371&shard.url=[ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/&fl=id,score&start=0&q=*:*&group.field=id&spellcheck.count=5&group=true&isShard=true&qt=spellCheckCompRH} status=0 QTime=65
[junit4] 2> 108326 T198 C27 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=false&spellcheck.extendedResults=true&shards.qt=spellCheckCompRH&spellcheck.q=toyata&distrib=false&wt=javabin&group.distributed.second=true&group.topgroups.id=1&group.topgroups.id=2&group.topgroups.id=3&group.topgroups.id=4&group.topgroups.id=5&group.topgroups.id=6&group.topgroups.id=7&group.topgroups.id=8&group.topgroups.id=9&group.topgroups.id=10&version=2&spellcheck.onlyMorePopular=false&rows=10&NOW=1378678447371&shard.url=[ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/&fl=id,score&start=0&q=*:*&group.field=id&spellcheck.count=1&group=true&isShard=true&qt=spellCheckCompRH} status=0 QTime=48
[junit4] 2> 108371 T198 C27 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=false&spellcheck.extendedResults=true&shards.qt=spellCheckCompRH&ids=3,2,10,1,7,6,5,4,9,8&spellcheck.q=toyata&distrib=false&wt=javabin&version=2&spellcheck.onlyMorePopular=false&NOW=1378678447371&shard.url=[ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/&fl=id,lowerfilt,id&q=*:*&group.field=id&spellcheck.count=1&qt=spellCheckCompRH&isShard=true} status=0 QTime=2
[junit4] 2> 108394 T197 C27 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/ {suggestions={toyata={numFound=2,startOffset=0,endOffset=6,origFreq=0,suggestion=[{word=toyota,freq=1}, {word=sonata,freq=1}]},correctlySpelled=false}}
[junit4] 2> 108395 T197 C27 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/ null
[junit4] 2> 108395 T197 C27 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/ null
[junit4] 2> 108396 T197 C27 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=true&shards=[ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/&fl=id,lowerfilt&spellcheck.extendedResults=true&shards.qt=spellCheckCompRH&q=*:*&spellcheck.q=toyata&group.field=id&group=true&wt=javabin&qt=spellCheckCompRH&version=2} status=0 QTime=248
[junit4] 2> 108398 T182 oas.BaseDistributedSearchTestCase.query starting stress...
[junit4] 2> 108410 T198 C27 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=true&group.distributed.first=true&spellcheck.extendedResults=true&shards.qt=spellCheckCompRH&spellcheck.q=toyata&distrib=false&wt=javabin&version=2&spellcheck.onlyMorePopular=false&rows=10&NOW=1378678447625&shard.url=[ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/&fl=id,score&start=0&q=*:*&group.field=id&spellcheck.count=5&group=true&isShard=true&qt=spellCheckCompRH} status=0 QTime=4
[junit4] 2> 108410 T201 C27 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=true&group.distributed.first=true&spellcheck.extendedResults=true&shards.qt=spellCheckCompRH&spellcheck.q=toyata&distrib=false&wt=javabin&version=2&spellcheck.onlyMorePopular=false&rows=10&NOW=1378678447625&shard.url=[ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/&fl=id,score&start=0&q=*:*&group.field=id&spellcheck.count=5&group=true&isShard=true&qt=spellCheckCompRH} status=0 QTime=4
[junit4] 2> 108410 T202 C27 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=true&group.distributed.first=true&spellcheck.extendedResults=true&shards.qt=spellCheckCompRH&spellcheck.q=toyata&distrib=false&wt=javabin&version=2&spellcheck.onlyMorePopular=false&rows=10&NOW=1378678447625&shard.url=[ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/&fl=id,score&start=0&q=*:*&group.field=id&spellcheck.count=5&group=true&isShard=true&qt=spellCheckCompRH} status=0 QTime=4
[junit4] 2> 108415 T202 C27 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=false&spellcheck.extendedResults=true&shards.qt=spellCheckCompRH&spellcheck.q=toyata&distrib=false&wt=javabin&group.distributed.second=true&group.topgroups.id=1&group.topgroups.id=2&group.topgroups.id=3&group.topgroups.id=4&group.topgroups.id=5&group.topgroups.id=6&group.topgroups.id=7&group.topgroups.id=8&group.topgroups.id=9&group.topgroups.id=10&version=2&spellcheck.onlyMorePopular=false&rows=10&NOW=1378678447625&shard.url=[ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/&fl=id,score&start=0&q=*:*&group.field=id&spellcheck.count=1&group=true&isShard=true&qt=spellCheckCompRH} status=0 QTime=1
[junit4] 2> 108417 T201 C27 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=false&spellcheck.extendedResults=true&shards.qt=spellCheckCompRH&spellcheck.q=toyata&distrib=false&wt=javabin&group.distributed.second=true&group.topgroups.id=1&group.topgroups.id=2&group.topgroups.id=3&group.topgroups.id=4&group.topgroups.id=5&group.topgroups.id=6&group.topgroups.id=7&group.topgroups.id=8&group.topgroups.id=9&group.topgroups.id=10&version=2&spellcheck.onlyMorePopular=false&rows=10&NOW=1378678447625&shard.url=[ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/&fl=id,score&start=0&q=*:*&group.field=id&spellcheck.count=1&group=true&isShard=true&qt=spellCheckCompRH} status=0 QTime=1
[junit4] 2> 108417 T198 C27 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=false&spellcheck.extendedResults=true&shards.qt=spellCheckCompRH&spellcheck.q=toyata&distrib=false&wt=javabin&group.distributed.second=true&group.topgroups.id=1&group.topgroups.id=2&group.topgroups.id=3&group.topgroups.id=4&group.topgroups.id=5&group.topgroups.id=6&group.topgroups.id=7&group.topgroups.id=8&group.topgroups.id=9&group.topgroups.id=10&version=2&spellcheck.onlyMorePopular=false&rows=10&NOW=1378678447625&shard.url=[ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/&fl=id,score&start=0&q=*:*&group.field=id&spellcheck.count=1&group=true&isShard=true&qt=spellCheckCompRH} status=0 QTime=1
[junit4] 2> 108421 T202 C27 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=false&spellcheck.extendedResults=true&shards.qt=spellCheckCompRH&ids=3,2,10,1,7,6,5,4,9,8&spellcheck.q=toyata&distrib=false&wt=javabin&version=2&spellcheck.onlyMorePopular=false&NOW=1378678447625&shard.url=[ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/&fl=id,lowerfilt,id&q=*:*&group.field=id&spellcheck.count=1&qt=spellCheckCompRH&isShard=true} status=0 QTime=1
[junit4] 2> 108422 T198 C27 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=false&spellcheck.extendedResults=true&shards.qt=spellCheckCompRH&ids=3,2,10,1,7,6,5,4,9,8&spellcheck.q=toyata&distrib=false&wt=javabin&version=2&spellcheck.onlyMorePopular=false&NOW=1378678447625&shard.url=[ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/&fl=id,lowerfilt,id&q=*:*&group.field=id&spellcheck.count=1&qt=spellCheckCompRH&isShard=true} status=0 QTime=1
[junit4] 2> 108423 T197 C27 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/ {suggestions={toyata={numFound=2,startOffset=0,endOffset=6,origFreq=0,suggestion=[{word=toyota,freq=1}, {word=sonata,freq=1}]},correctlySpelled=false}}
[junit4] 2> 108423 T201 C27 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=false&spellcheck.extendedResults=true&shards.qt=spellCheckCompRH&ids=3,2,10,1,7,6,5,4,9,8&spellcheck.q=toyata&distrib=false&wt=javabin&version=2&spellcheck.onlyMorePopular=false&NOW=1378678447625&shard.url=[ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/&fl=id,lowerfilt,id&q=*:*&group.field=id&spellcheck.count=1&qt=spellCheckCompRH&isShard=true} status=0 QTime=1
[junit4] 2> 108423 T197 C27 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/ null
[junit4] 2> 108424 T200 C27 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/ {suggestions={toyata={numFound=2,startOffset=0,endOffset=6,origFreq=0,suggestion=[{word=toyota,freq=1}, {word=sonata,freq=1}]},correctlySpelled=false}}
[junit4] 2> 108424 T197 C27 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/ null
[junit4] 2> 108425 T199 C27 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/ {suggestions={toyata={numFound=2,startOffset=0,endOffset=6,origFreq=0,suggestion=[{word=toyota,freq=1}, {word=sonata,freq=1}]},correctlySpelled=false}}
[junit4] 2> 108425 T200 C27 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/ null
[junit4] 2> 108426 T199 C27 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/ null
[junit4] 2> 108425 T197 C27 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=true&shards=[ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/&fl=id,lowerfilt&spellcheck.extendedResults=true&shards.qt=spellCheckCompRH&q=*:*&spellcheck.q=toyata&group.field=id&group=true&wt=javabin&qt=spellCheckCompRH&version=2} status=0 QTime=23
[junit4] 2> 108426 T199 C27 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/ null
[junit4] 2> 108426 T200 C27 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/ null
[junit4] 2> 108427 T199 C27 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=true&shards=[ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/&fl=id,lowerfilt&spellcheck.extendedResults=true&shards.qt=spellCheckCompRH&q=*:*&spellcheck.q=toyata&group.field=id&group=true&wt=javabin&qt=spellCheckCompRH&version=2} status=0 QTime=25
[junit4] 2> 108428 T200 C27 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=true&shards=[ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/&fl=id,lowerfilt&spellcheck.extendedResults=true&shards.qt=spellCheckCompRH&q=*:*&spellcheck.q=toyata&group.field=id&group=true&wt=javabin&qt=spellCheckCompRH&version=2} status=0 QTime=26
[junit4] 2> 108440 T201 C27 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=true&group.distributed.first=true&spellcheck.extendedResults=true&shards.qt=spellCheckCompRH&spellcheck.q=toyata&distrib=false&wt=javabin&version=2&spellcheck.onlyMorePopular=false&rows=10&NOW=1378678447655&shard.url=[ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/&fl=id,score&start=0&q=*:*&group.field=id&spellcheck.count=5&group=true&isShard=true&qt=spellCheckCompRH} status=0 QTime=5
[junit4] 2> 108441 T198 C27 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=true&group.distributed.first=true&spellcheck.extendedResults=true&shards.qt=spellCheckCompRH&spellcheck.q=toyata&distrib=false&wt=javabin&version=2&spellcheck.onlyMorePopular=false&rows=10&NOW=1378678447656&shard.url=[ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/&fl=id,score&start=0&q=*:*&group.field=id&spellcheck.count=5&group=true&isShard=true&qt=spellCheckCompRH} status=0 QTime=5
[junit4] 2> 108441 T202 C27 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=true&group.distributed.first=true&spellcheck.extendedResults=true&shards.qt=spellCheckCompRH&spellcheck.q=toyata&distrib=false&wt=javabin&version=2&spellcheck.onlyMorePopular=false&rows=10&NOW=1378678447656&shard.url=[ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/&fl=id,score&start=0&q=*:*&group.field=id&spellcheck.count=5&group=true&isShard=true&qt=spellCheckCompRH} status=0 QTime=5
[junit4] 2> 108445 T198 C27 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=false&spellcheck.extendedResults=true&shards.qt=spellCheckCompRH&spellcheck.q=toyata&distrib=false&wt=javabin&group.distributed.second=true&group.topgroups.id=1&group.topgroups.id=2&group.topgroups.id=3&group.topgroups.id=4&group.topgroups.id=5&group.topgroups.id=6&group.topgroups.id=7&group.topgroups.id=8&group.topgroups.id=9&group.topgroups.id=10&version=2&spellcheck.onlyMorePopular=false&rows=10&NOW=1378678447655&shard.url=[ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/&fl=id,score&start=0&q=*:*&group.field=id&spellcheck.count=1&group=true&isShard=true&qt=spellCheckCompRH} status=0 QTime=1
[junit4] 2> 108446 T201 C27 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=false&spellcheck.extendedResults=true&shards.qt=spellCheckCompRH&spellcheck.q=toyata&distrib=false&wt=javabin&group.distributed.second=true&group.topgroups.id=1&group.topgroups.id=2&group.topgroups.id=3&group.topgroups.id=4&group.topgroups.id=5&group.topgroups.id=6&group.topgroups.id=7&group.topgroups.id=8&group.topgroups.id=9&group.topgroups.id=10&version=2&spellcheck.onlyMorePopular=false&rows=10&NOW=1378678447656&shard.url=[ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/&fl=id,score&start=0&q=*:*&group.field=id&spellcheck.count=1&group=true&isShard=true&qt=spellCheckCompRH} status=0 QTime=1
[junit4] 2> 108446 T202 C27 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=false&spellcheck.extendedResults=true&shards.qt=spellCheckCompRH&spellcheck.q=toyata&distrib=false&wt=javabin&group.distributed.second=true&group.topgroups.id=1&group.topgroups.id=2&group.topgroups.id=3&group.topgroups.id=4&group.topgroups.id=5&group.topgroups.id=6&group.topgroups.id=7&group.topgroups.id=8&group.topgroups.id=9&group.topgroups.id=10&version=2&spellcheck.onlyMorePopular=false&rows=10&NOW=1378678447656&shard.url=[ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/&fl=id,score&start=0&q=*:*&group.field=id&spellcheck.count=1&group=true&isShard=true&qt=spellCheckCompRH} status=0 QTime=1
[junit4] 2> 108451 T201 C27 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=false&spellcheck.extendedResults=true&shards.qt=spellCheckCompRH&ids=3,2,10,1,7,6,5,4,9,8&spellcheck.q=toyata&distrib=false&wt=javabin&version=2&spellcheck.onlyMorePopular=false&NOW=1378678447655&shard.url=[ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/&fl=id,lowerfilt,id&q=*:*&group.field=id&spellcheck.count=1&qt=spellCheckCompRH&isShard=true} status=0 QTime=1
[junit4] 2> 108452 T202 C27 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=false&spellcheck.extendedResults=true&shards.qt=spellCheckCompRH&ids=3,2,10,1,7,6,5,4,9,8&spellcheck.q=toyata&distrib=false&wt=javabin&version=2&spellcheck.onlyMorePopular=false&NOW=1378678447656&shard.url=[ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/&fl=id,lowerfilt,id&q=*:*&group.field=id&spellcheck.count=1&qt=spellCheckCompRH&isShard=true} status=0 QTime=1
[junit4] 2> 108452 T198 C27 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=false&spellcheck.extendedResults=true&shards.qt=spellCheckCompRH&ids=3,2,10,1,7,6,5,4,9,8&spellcheck.q=toyata&distrib=false&wt=javabin&version=2&spellcheck.onlyMorePopular=false&NOW=1378678447656&shard.url=[ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/&fl=id,lowerfilt,id&q=*:*&group.field=id&spellcheck.count=1&qt=spellCheckCompRH&isShard=true} status=0 QTime=1
[junit4] 2> 108453 T197 C27 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/ {suggestions={toyata={numFound=2,startOffset=0,endOffset=6,origFreq=0,suggestion=[{word=toyota,freq=1}, {word=sonata,freq=1}]},correctlySpelled=false}}
[junit4] 2> 108454 T197 C27 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/ null
[junit4] 2> 108454 T197 C27 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/ null
[junit4] 2> 108454 T200 C27 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/ {suggestions={toyata={numFound=2,startOffset=0,endOffset=6,origFreq=0,suggestion=[{word=toyota,freq=1}, {word=sonata,freq=1}]},correctlySpelled=false}}
[junit4] 2> 108455 T197 C27 oasc.SolrCore.execute [collection1] webapp= path=/select params={spellcheck=true&shards=[ff01::114]:33332/|127.0.0.1:16839/|[ff01::213]:33332/|[ff01::083]:33332/&fl=id,lowerfilt&spellcheck.extendedResults=true&shards.qt=spellCheckCompRH&q=*:*&spellcheck.q=toyata&group.field=id&group=true&wt=javabin&qt=spellCheckCompRH&version=2} status=0 QTime=23
[junit4] 2> 108454 T199 C27 oashc.SpellCheckComponent.finishStage [ff01::114]:
[...truncated too long message...]
errors=0,cumulative_adds=8,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0}
[junit4] 2> 181238 T182 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 181239 T182 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 181239 T182 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 181241 T182 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 181242 T182 oasc.CachingDirectoryFactory.close Closing NRTCachingDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 181243 T182 oasc.CachingDirectoryFactory.closeCacheValue looking to close /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/org.apache.solr.handler.component.DistributedSpellCheckComponentTest-1378678444197/shard2/data/index [CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/org.apache.solr.handler.component.DistributedSpellCheckComponentTest-1378678444197/shard2/data/index;done=false>>]
[junit4] 2> 181243 T182 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/org.apache.solr.handler.component.DistributedSpellCheckComponentTest-1378678444197/shard2/data/index
[junit4] 2> 181244 T182 oasc.CachingDirectoryFactory.closeCacheValue looking to close /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/org.apache.solr.handler.component.DistributedSpellCheckComponentTest-1378678444197/shard2/data [CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/org.apache.solr.handler.component.DistributedSpellCheckComponentTest-1378678444197/shard2/data;done=false>>]
[junit4] 2> 181244 T182 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build/solr-core/test/J0/org.apache.solr.handler.component.DistributedSpellCheckComponentTest-1378678444197/shard2/data
[junit4] 2> 181246 T182 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/,null}
[junit4] 2> 181395 T182 oas.SolrTestCaseJ4.tearDown ###Ending testDistribSearch
[junit4] 2> NOTE: download the large Jenkins line-docs file by running 'ant get-jenkins-line-docs' in the lucene directory.
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=DistributedSpellCheckComponentTest -Dtests.method=testDistribSearch -Dtests.seed=5902CA53FEEB96A5 -Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true -Dtests.linedocsfile=/home/hudson/lucene-data/enwiki.random.lines.txt -Dtests.locale=ms_MY -Dtests.timezone=VST -Dtests.file.encoding=ISO8859-1
[junit4] ERROR 76.5s J0 | DistributedSpellCheckComponentTest.testDistribSearch <<<
[junit4] > Throwable #1: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=279, name=Thread-147, state=RUNNABLE, group=TGRP-DistributedSpellCheckComponentTest]
[junit4] > at __randomizedtesting.SeedInfo.seed([5902CA53FEEB96A5:D8E4444B89B4F699]:0)
[junit4] > Caused by: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:16861
[junit4] > at __randomizedtesting.SeedInfo.seed([5902CA53FEEB96A5]:0)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$5.run(BaseDistributedSearchTestCase.java:549)
[junit4] > Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:16861
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:431)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:180)
[junit4] > at org.apache.solr.client.solrj.request.QueryRequest.process(QueryRequest.java:90)
[junit4] > at org.apache.solr.client.solrj.SolrServer.query(SolrServer.java:301)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$5.run(BaseDistributedSearchTestCase.java:544)
[junit4] > Caused by: java.net.SocketTimeoutException: Read timed out
[junit4] > at java.net.SocketInputStream.socketRead0(Native Method)
[junit4] > at java.net.SocketInputStream.read(SocketInputStream.java:146)
[junit4] > at org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:166)
[junit4] > at org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:90)
[junit4] > at org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:281)
[junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:92)
[junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:62)
[junit4] > at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:254)
[junit4] > at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:289)
[junit4] > at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:252)
[junit4] > at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:191)
[junit4] > at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:300)
[junit4] > at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:127)
[junit4] > at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:717)
[junit4] > at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:522)
[junit4] > at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:906)
[junit4] > at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:805)
[junit4] > at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:784)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:365)
[junit4] > ... 4 more
[junit4] 2> 181421 T182 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: test params are: codec=Lucene45: {range_facet_l=PostingsFormat(name=NestedPulsing), _version_=PostingsFormat(name=NestedPulsing), lowerfilt=PostingsFormat(name=MockRandom), end4=Pulsing41(freqCutoff=1 minBlockSize=78 maxBlockSize=154), lowerfilt1and2=PostingsFormat(name=MockRandom), end3=PostingsFormat(name=MockRandom), start1=Pulsing41(freqCutoff=1 minBlockSize=78 maxBlockSize=154), end2=PostingsFormat(name=Memory doPackFST= true), end1=PostingsFormat(name=NestedPulsing), intDefault=PostingsFormat(name=NestedPulsing), id=PostingsFormat(name=Memory doPackFST= true), timestamp=PostingsFormat(name=NestedPulsing), range_facet_sl=Pulsing41(freqCutoff=1 minBlockSize=78 maxBlockSize=154), range_facet_si=PostingsFormat(name=MockRandom), start4=PostingsFormat(name=NestedPulsing), start2=PostingsFormat(name=MockRandom), start3=PostingsFormat(name=Memory doPackFST= true), word=PostingsFormat(name=NestedPulsing), gram2=PostingsFormat(name=Memory doPackFST= true), gram1=PostingsFormat(name=NestedPulsing), multiDefault=PostingsFormat(name=MockRandom), gram4=Pulsing41(freqCutoff=1 minBlockSize=78 maxBlockSize=154), gram3=PostingsFormat(name=MockRandom)}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=false,coord=crazy): {}, locale=ms_MY, timezone=VST
[junit4] 2> NOTE: FreeBSD 9.1-RELEASE-p3 amd64/Sun Microsystems Inc. 1.6.0_32 (64-bit)/cpus=16,threads=1,free=333897224,total=461701120
[junit4] 2> NOTE: All tests run in this JVM: [TestMergePolicyConfig, TestCoreContainer, DocValuesMissingTest, TestPerFieldSimilarity, SoftAutoCommitTest, ResourceLoaderTest, SpellPossibilityIteratorTest, ParsingFieldUpdateProcessorsTest, TestRemoteStreaming, ScriptEngineTest, TestValueSourceCache, TestSystemIdResolver, CachingDirectoryFactoryTest, TestFieldResource, SpatialFilterTest, TestDocumentBuilder, PrimitiveFieldTypeTest, TestLMDirichletSimilarityFactory, PolyFieldTest, DistributedSpellCheckComponentTest]
[junit4] Completed on J0 in 76.48s, 1 test, 1 error <<< FAILURES!
[...truncated 963 lines...]
BUILD FAILED
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/build.xml:409: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/build.xml:382: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/build.xml:39: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/build.xml:189: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/solr/common-build.xml:455: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/lucene/common-build.xml:1233: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-4.x/lucene/common-build.xml:876: There were test failures: 325 suites, 1418 tests, 1 error, 32 ignored (4 assumptions)
Total time: 106 minutes 0 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure