Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/11882/
Java: 32bit/jdk1.9.0-ea-b47 -client -XX:+UseG1GC

3 tests failed.
FAILED:  junit.framework.TestSuite.org.apache.solr.search.TestSolr4Spatial

Error Message:
SolrCore.getOpenCount()==6

Stack Trace:
java.lang.RuntimeException: SolrCore.getOpenCount()==6
        at __randomizedtesting.SeedInfo.seed([9D5B345CFDE272E6]:0)
        at org.apache.solr.util.TestHarness.close(TestHarness.java:356)
        at org.apache.solr.SolrTestCaseJ4.deleteCore(SolrTestCaseJ4.java:683)
        at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:226)
        at sun.reflect.GeneratedMethodAccessor34.invoke(Unknown Source)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:790)
        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 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        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:365)
        at java.lang.Thread.run(Thread.java:745)


FAILED:  junit.framework.TestSuite.org.apache.solr.search.TestSolr4Spatial

Error Message:
2 threads leaked from SUITE scope at org.apache.solr.search.TestSolr4Spatial:   
  1) Thread[id=870, name=searcherExecutor-488-thread-1, state=WAITING, 
group=TGRP-TestSolr4Spatial]         at sun.misc.Unsafe.park(Native Method)     
    at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)        
 at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
         at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)     
    at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)   
      at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) 
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) 
        at java.lang.Thread.run(Thread.java:745)    2) Thread[id=871, 
name=Thread-306, state=WAITING, group=TGRP-TestSolr4Spatial]         at 
java.lang.Object.wait(Native Method)         at 
java.lang.Object.wait(Object.java:502)         at 
org.apache.solr.core.CloserThread.run(CoreContainer.java:902)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 2 threads leaked from SUITE 
scope at org.apache.solr.search.TestSolr4Spatial: 
   1) Thread[id=870, name=searcherExecutor-488-thread-1, state=WAITING, 
group=TGRP-TestSolr4Spatial]
        at sun.misc.Unsafe.park(Native Method)
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
        at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
        at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
        at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
        at java.lang.Thread.run(Thread.java:745)
   2) Thread[id=871, name=Thread-306, state=WAITING, 
group=TGRP-TestSolr4Spatial]
        at java.lang.Object.wait(Native Method)
        at java.lang.Object.wait(Object.java:502)
        at org.apache.solr.core.CloserThread.run(CoreContainer.java:902)
        at __randomizedtesting.SeedInfo.seed([9D5B345CFDE272E6]:0)


FAILED:  junit.framework.TestSuite.org.apache.solr.search.TestSolr4Spatial

Error Message:
There are still zombie threads that couldn't be terminated:    1) 
Thread[id=870, name=searcherExecutor-488-thread-1, state=WAITING, 
group=TGRP-TestSolr4Spatial]         at sun.misc.Unsafe.park(Native Method)     
    at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)        
 at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
         at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)     
    at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)   
      at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) 
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) 
        at java.lang.Thread.run(Thread.java:745)    2) Thread[id=871, 
name=Thread-306, state=WAITING, group=TGRP-TestSolr4Spatial]         at 
java.lang.Object.wait(Native Method)         at 
java.lang.Object.wait(Object.java:502)         at 
org.apache.solr.core.CloserThread.run(CoreContainer.java:902)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie 
threads that couldn't be terminated:
   1) Thread[id=870, name=searcherExecutor-488-thread-1, state=WAITING, 
group=TGRP-TestSolr4Spatial]
        at sun.misc.Unsafe.park(Native Method)
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
        at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
        at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
        at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
        at java.lang.Thread.run(Thread.java:745)
   2) Thread[id=871, name=Thread-306, state=WAITING, 
group=TGRP-TestSolr4Spatial]
        at java.lang.Object.wait(Native Method)
        at java.lang.Object.wait(Object.java:502)
        at org.apache.solr.core.CloserThread.run(CoreContainer.java:902)
        at __randomizedtesting.SeedInfo.seed([9D5B345CFDE272E6]:0)




Build Log:
[...truncated 9109 lines...]
   [junit4] Suite: org.apache.solr.search.TestSolr4Spatial
   [junit4]   2> Creating dataDir: 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestSolr4Spatial
 9D5B345CFDE272E6-001/init-core-data-001
   [junit4]   2> 182409 T868 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl 
(false) and clientAuth (false)
   [junit4]   2> 182409 T868 oas.SolrTestCaseJ4.initCore ####initCore
   [junit4]   2> 182409 T868 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 182410 T868 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/.svn/'
 to classloader
   [junit4]   2> 182410 T868 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 182411 T868 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 182433 T868 oasc.SolrConfig.refreshRequestParams current 
version of requestparams : -1
   [junit4]   2> 182437 T868 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
6.0.0
   [junit4]   2> 182444 T868 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig-basic.xml
   [junit4]   2> 182444 T868 oass.IndexSchema.readSchema Reading Solr Schema 
from 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/schema-spatial.xml
   [junit4]   2> 182447 T868 oass.IndexSchema.readSchema [null] Schema name=test
   [junit4]   2> 182477 T868 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 182478 T868 oasc.SolrResourceLoader.locateSolrHome JNDI not 
configured for solr (NoInitialContextEx)
   [junit4]   2> 182478 T868 oasc.SolrResourceLoader.locateSolrHome using 
system property solr.solr.home: 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr
   [junit4]   2> 182479 T868 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/'
   [junit4]   2> 182494 T868 oasc.CoreContainer.<init> New CoreContainer 2331907
   [junit4]   2> 182495 T868 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/]
   [junit4]   2> 182495 T868 oasc.CoreContainer.load loading shared library: 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/lib
   [junit4]   2> 182495 T868 oasc.SolrResourceLoader.addToClassLoader WARN 
Can't find (or read) directory to add to classloader: lib (resolved as: 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/lib).
   [junit4]   2> 182502 T868 oashc.HttpShardHandlerFactory.getParameter Setting 
socketTimeout to: 600000
   [junit4]   2> 182502 T868 oashc.HttpShardHandlerFactory.getParameter Setting 
urlScheme to: null
   [junit4]   2> 182502 T868 oashc.HttpShardHandlerFactory.getParameter Setting 
connTimeout to: 60000
   [junit4]   2> 182503 T868 oashc.HttpShardHandlerFactory.getParameter Setting 
maxConnectionsPerHost to: 20
   [junit4]   2> 182503 T868 oashc.HttpShardHandlerFactory.getParameter Setting 
maxConnections to: 10000
   [junit4]   2> 182503 T868 oashc.HttpShardHandlerFactory.getParameter Setting 
corePoolSize to: 0
   [junit4]   2> 182503 T868 oashc.HttpShardHandlerFactory.getParameter Setting 
maximumPoolSize to: 2147483647
   [junit4]   2> 182503 T868 oashc.HttpShardHandlerFactory.getParameter Setting 
maxThreadIdleTime to: 5
   [junit4]   2> 182504 T868 oashc.HttpShardHandlerFactory.getParameter Setting 
sizeOfQueue to: -1
   [junit4]   2> 182504 T868 oashc.HttpShardHandlerFactory.getParameter Setting 
fairnessPolicy to: false
   [junit4]   2> 182504 T868 oashc.HttpShardHandlerFactory.getParameter Setting 
useRetries to: false
   [junit4]   2> 182505 T868 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=30000&connTimeout=30000&retry=true
   [junit4]   2> 182505 T868 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 182505 T868 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 182505 T868 oasc.CoreContainer.load Node Name: testNode
   [junit4]   2> 182507 T869 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 182507 T869 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/.svn/'
 to classloader
   [junit4]   2> 182507 T869 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 182508 T869 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 182528 T869 oasc.SolrConfig.refreshRequestParams current 
version of requestparams : -1
   [junit4]   2> 182531 T869 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
6.0.0
   [junit4]   2> 182538 T869 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig-basic.xml
   [junit4]   2> 182538 T869 oass.IndexSchema.readSchema Reading Solr Schema 
from 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/schema-spatial.xml
   [junit4]   2> 182541 T869 oass.IndexSchema.readSchema [collection1] Schema 
name=test
   [junit4]   2> 182560 T869 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 182561 T869 oasc.CoreContainer.create Creating SolrCore 
'collection1' using configuration from instancedir 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 182561 T869 oasc.SolrCore.initDirectoryFactory 
org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 182562 T869 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/,
 
dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestSolr4Spatial
 9D5B345CFDE272E6-001/init-core-data-001/
   [junit4]   2> 182562 T869 oasc.SolrCore.<init> JMX monitoring not detected 
for core: collection1
   [junit4]   2> 182562 T869 oasc.CachingDirectoryFactory.get return new 
directory for 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestSolr4Spatial
 9D5B345CFDE272E6-001/init-core-data-001
   [junit4]   2> 182563 T869 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestSolr4Spatial
 9D5B345CFDE272E6-001/init-core-data-001/index/
   [junit4]   2> 182563 T869 oasc.SolrCore.initIndex WARN [collection1] Solr 
index directory 
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestSolr4Spatial
 9D5B345CFDE272E6-001/init-core-data-001/index' doesn't exist. Creating new 
index...
   [junit4]   2> 182563 T869 oasc.CachingDirectoryFactory.get return new 
directory for 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestSolr4Spatial
 9D5B345CFDE272E6-001/init-core-data-001/index
   [junit4]   2> 182563 T869 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: 
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=49, 
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, 
calibrateSizeByDeletes=false, maxMergeDocs=2147483647, 
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.780908429849234]
   [junit4]   2> 182564 T869 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_1,generation=1}
   [junit4]   2> 182564 T869 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 182565 T869 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 182566 T869 oasc.RequestHandlers.initHandlersFromConfig 
created /update: solr.UpdateRequestHandler
   [junit4]   2> 182566 T869 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 182566 T869 oasc.RequestHandlers.initHandlersFromConfig 
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 182566 T869 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 182567 T869 oasc.RequestHandlers.initHandlersFromConfig 
created /config: org.apache.solr.handler.SolrConfigHandler
   [junit4]   2> 182567 T869 oasc.RequestHandlers.initHandlersFromConfig 
created /schema: org.apache.solr.handler.SchemaHandler
   [junit4]   2> 182567 T869 oasc.RequestHandlers.initHandlersFromConfig 
created /replication: org.apache.solr.handler.ReplicationHandler
   [junit4]   2> 182567 T869 oasc.RequestHandlers.initHandlersFromConfig 
created /get: org.apache.solr.handler.RealTimeGetHandler
   [junit4]   2> 182568 T869 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
   [junit4]   2> 182568 T869 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
   [junit4]   2> 182568 T869 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
   [junit4]   2> 182568 T869 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
   [junit4]   2> 182569 T869 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
   [junit4]   2> 182569 T869 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/properties: 
org.apache.solr.handler.admin.PropertiesRequestHandler
   [junit4]   2> 182569 T869 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
   [junit4]   2> 182569 T869 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/file: org.apache.solr.handler.admin.ShowFileRequestHandler
   [junit4]   2> 182570 T869 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/ping: org.apache.solr.handler.PingRequestHandler
   [junit4]   2> 182570 T869 oasc.RequestHandlers.initHandlersFromConfig 
created standard: solr.StandardRequestHandler
   [junit4]   2> 182572 T869 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 182573 T869 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 182574 T869 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 182575 T869 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 182575 T869 oasc.SolrCore.initStatsCache Using default 
statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 182576 T869 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 182576 T869 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 182576 T869 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=3, maxMergeAtOnceExplicit=9, maxMergedSegmentMB=79.7001953125, 
floorSegmentMB=2.01953125, forceMergeDeletesPctAllowed=9.184351501389706, 
segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 182577 T869 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_1,generation=1}
   [junit4]   2> 182577 T869 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 182577 T869 oass.SolrIndexSearcher.<init> Opening 
Searcher@72c27c[collection1] main
   [junit4]   2> 182578 T869 oasr.ManagedResourceStorage.newStorageIO WARN 
Cannot write to config directory 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf;
 switching to use InMemory storage instead.
   [junit4]   2> 182578 T869 oasr.RestManager.init Initializing RestManager 
with initArgs: {}
   [junit4]   2> 182578 T869 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using InMemoryStorage
   [junit4]   2> 182578 T869 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 182578 T869 oash.ReplicationHandler.inform Commits will be 
reserved for  10000
   [junit4]   2> 182579 T870 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@72c27c[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 182579 T869 oasc.CoreContainer.registerCore registering core: 
collection1
   [junit4]   2> 182581 T868 oas.SolrTestCaseJ4.initCore ####initCore end
   [junit4]   2> 182583 T868 oas.SolrTestCaseJ4.setUp ###Starting testSort 
{p0=bbox}
   [junit4]   2> ASYNC  NEW_CORE C281 name=collection1 
org.apache.solr.core.SolrCore@1feb1e6
   [junit4]   2> 182584 T868 C281 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 182584 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {deleteByQuery=*:*} 0 0
   [junit4]   2> 182587 T868 C281 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 182588 T868 C281 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_1,generation=1}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_2,generation=2}
   [junit4]   2> 182589 T868 C281 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 2
   [junit4]   2> 182590 T868 C281 oass.SolrIndexSearcher.<init> Opening 
Searcher@efdea1[collection1] main
   [junit4]   2> 182590 T868 C281 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 182590 T870 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@efdea1[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 182591 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 4
   [junit4]   2> 182600 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[100]} 0 8
   [junit4]   2> 182601 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[101]} 0 0
   [junit4]   2> 182603 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[999]} 0 1
   [junit4]   2> 182603 T868 C281 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 182609 T868 C281 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_2,generation=2}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_3,generation=3}
   [junit4]   2> 182610 T868 C281 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 3
   [junit4]   2> 182612 T868 C281 oass.SolrIndexSearcher.<init> Opening 
Searcher@189e2d0[collection1] main
   [junit4]   2> 182612 T868 C281 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 182613 T870 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@189e2d0[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c3)))}
   [junit4]   2> 182613 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 10
   [junit4]   2> 182625 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q={!bbox+sfield%3Dbbox+++pt%3D3.0,4.0+d%3D9.0}&fl=id,score&wt=xml} 
hits=2 status=0 QTime=11 
   [junit4]   2> 182635 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q={!bbox+sfield%3Dbbox+score%3Ddistance++pt%3D3.0,4.0+d%3D9.0}&fl=id,score&sort=score+asc&wt=xml}
 hits=2 status=0 QTime=8 
   [junit4]   2> 182638 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q={!bbox+sfield%3Dbbox+score%3DrecipDistance++pt%3D3.0,4.0+d%3D9.0}&fl=id,score&sort=score+desc&wt=xml}
 hits=2 status=0 QTime=2 
   [junit4]   2> 182640 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q={!bbox+sfield%3Dbbox+score%3Ddistance+filter%3Dfalse+pt%3D3.0,4.0+d%3D1.0E-6}&fl=id,score&sort=score+asc&wt=xml}
 hits=3 status=0 QTime=1 
   [junit4]   2> 182642 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q={!bbox+sfield%3Dbbox+score%3Ddistance++pt%3D4.0,0.0+d%3D9.0}&fl=id,score&sort=score+asc&wt=xml}
 hits=2 status=0 QTime=1 
   [junit4]   2> 182649 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=-id:999&fl=id,score&sort=query($sortQuery)+asc&wt=xml&sortQuery={!bbox+sfield%3Dbbox+score%3Ddistance++pt%3D3.0,4.0+d%3D9.0}}
 hits=2 status=0 QTime=7 
   [junit4]   2> 182651 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=-id:999&fl=id,score&sort=query($sortQuery)+asc&wt=xml&sortQuery={!bbox+sfield%3Dbbox+score%3Ddistance++pt%3D4.0,0.0+d%3D9.0}}
 hits=2 status=0 QTime=1 
   [junit4]   2> 182652 T868 oas.SolrTestCaseJ4.tearDown ###Ending testSort 
{p0=bbox}
   [junit4]   2> 182655 T868 oas.SolrTestCaseJ4.setUp ###Starting 
checkQueryEmptyIndex {p0=bbox}
   [junit4]   2> 182656 T868 C281 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 182656 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 182657 T868 C281 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 182657 T868 C281 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_3,generation=3}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_4,generation=4}
   [junit4]   2> 182658 T868 C281 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 4
   [junit4]   2> 182658 T868 C281 oass.SolrIndexSearcher.<init> Opening 
Searcher@1ddece4[collection1] main
   [junit4]   2> 182659 T868 C281 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 182659 T870 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1ddece4[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 182660 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 3
   [junit4]   2> 182660 T868 oas.SolrTestCaseJ4.tearDown ###Ending 
checkQueryEmptyIndex {p0=bbox}
   [junit4]   2> 182663 T868 oas.SolrTestCaseJ4.setUp ###Starting 
testSortMultiVal {p0=bbox}
   [junit4]   2> 182664 T868 C281 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 182664 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {deleteByQuery=*:*} 0 0
   [junit4]   2> 182665 T868 C281 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 182666 T868 C281 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_4,generation=4}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_5,generation=5}
   [junit4]   2> 182666 T868 C281 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 5
   [junit4]   2> 182667 T868 C281 oass.SolrIndexSearcher.<init> Opening 
Searcher@1ced174[collection1] main
   [junit4]   2> 182667 T868 C281 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 182667 T870 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1ced174[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 182668 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 3
   [junit4]   2> 182669 T868 oas.SolrTestCaseJ4.tearDown ###Ending 
testSortMultiVal {p0=bbox}
   [junit4] IGNOR/A 0.03s J1 | TestSolr4Spatial.testSortMultiVal {p0=bbox}
   [junit4]    > Assumption #1: Multivalue not supported for this field
   [junit4]   2> 182697 T868 oas.SolrTestCaseJ4.setUp ###Starting 
testRangeSyntax {p0=bbox}
   [junit4]   2> 182697 T868 C281 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 182698 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 182698 T868 C281 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 182699 T868 C281 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_5,generation=5}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_6,generation=6}
   [junit4]   2> 182699 T868 C281 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 6
   [junit4]   2> 182700 T868 C281 oass.SolrIndexSearcher.<init> Opening 
Searcher@1c4b64b[collection1] main
   [junit4]   2> 182700 T868 C281 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 182700 T870 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1c4b64b[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 182701 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 3
   [junit4]   2> 182703 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[1]} 0 2
   [junit4]   2> 182704 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[2]} 0 1
   [junit4]   2> 182705 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[3]} 0 1
   [junit4]   2> 182706 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[4]} 0 1
   [junit4]   2> 182706 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[5]} 0 0
   [junit4]   2> 182707 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[6]} 0 0
   [junit4]   2> 182708 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[7]} 0 0
   [junit4]   2> 182709 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[8]} 0 0
   [junit4]   2> 182710 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[9]} 0 0
   [junit4]   2> 182711 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[10]} 0 0
   [junit4]   2> 182712 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[11]} 0 0
   [junit4]   2> 182713 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[12]} 0 0
   [junit4]   2> 182714 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[13]} 0 0
   [junit4]   2> 182715 T868 C281 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 182722 T868 C281 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_6,generation=6}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_7,generation=7}
   [junit4]   2> 182723 T868 C281 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 7
   [junit4]   2> 182725 T868 C281 oass.SolrIndexSearcher.<init> Opening 
Searcher@1f94471[collection1] main
   [junit4]   2> 182725 T868 C281 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 182725 T870 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1f94471[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.0.0):c13)))}
   [junit4]   2> 182726 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 11
   [junit4]   2> 182731 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!+score%3Dnone+df%3Dbbox}[32,-80+TO+"33+,+-79"]&rows=1000&wt=xml}
 hits=1 status=0 QTime=4 
   [junit4]   2> 182732 T868 oas.SolrTestCaseJ4.tearDown ###Ending 
testRangeSyntax {p0=bbox}
   [junit4]   2> 182735 T868 oas.SolrTestCaseJ4.setUp ###Starting 
checkResultFormat {p0=bbox}
   [junit4]   2> 182735 T868 C281 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 182736 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 182737 T868 C281 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 182737 T868 C281 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_7,generation=7}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_8,generation=8}
   [junit4]   2> 182737 T868 C281 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 8
   [junit4]   2> 182738 T868 C281 oass.SolrIndexSearcher.<init> Opening 
Searcher@1a2581[collection1] main
   [junit4]   2> 182738 T868 C281 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 182738 T870 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1a2581[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 182739 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 2
   [junit4]   2> 182741 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[11]} 0 1
   [junit4]   2> 182741 T868 C281 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 182746 T868 C281 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_8,generation=8}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_9,generation=9}
   [junit4]   2> 182746 T868 C281 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 9
   [junit4]   2> 182748 T868 C281 oass.SolrIndexSearcher.<init> Opening 
Searcher@120e25d[collection1] main
   [junit4]   2> 182749 T868 C281 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 182749 T870 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@120e25d[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(6.0.0):c1)))}
   [junit4]   2> 182749 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 8
   [junit4]   2> 182751 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id,bbox&fq={!bbox+sfield%3Dbbox+pt%3D89.9,-130+d%3D9}&rows=1000&wt=xml}
 hits=1 status=0 QTime=1 
   [junit4]   2> 182752 T868 oas.SolrTestCaseJ4.tearDown ###Ending 
checkResultFormat {p0=bbox}
   [junit4]   2> 182755 T868 oas.SolrTestCaseJ4.setUp ###Starting 
testBadScoreParam {p0=bbox}
   [junit4]   2> 182756 T868 C281 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 182756 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 182757 T868 C281 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 182757 T868 C281 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_9,generation=9}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_a,generation=10}
   [junit4]   2> 182757 T868 C281 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 10
   [junit4]   2> 182758 T868 C281 oass.SolrIndexSearcher.<init> Opening 
Searcher@178848a[collection1] main
   [junit4]   2> 182758 T868 C281 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 182758 T870 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@178848a[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 182759 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 2
   [junit4]   2> 182760 T868 C281 oasc.SolrException.log Ignoring exception 
matching .
   [junit4]   2> 182760 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q={!bbox+sfield%3Dbbox+score%3Dbogus+filter%3Dfalse+pt%3D0.0,0.0+d%3D0.0}&qt=standard&start=0&rows=20&version=2.2}
 status=400 QTime=0 
   [junit4]   2> 182761 T868 oas.SolrTestCaseJ4.tearDown ###Ending 
testBadScoreParam {p0=bbox}
   [junit4]   2> 182763 T868 oas.SolrTestCaseJ4.setUp ###Starting 
testIntersectFilter {p0=bbox}
   [junit4]   2> 182764 T868 C281 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 182764 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {deleteByQuery=*:*} 0 0
   [junit4]   2> 182765 T868 C281 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 182765 T868 C281 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_a,generation=10}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_b,generation=11}
   [junit4]   2> 182766 T868 C281 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 11
   [junit4]   2> 182766 T868 C281 oass.SolrIndexSearcher.<init> Opening 
Searcher@1ca90d1[collection1] main
   [junit4]   2> 182766 T868 C281 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 182767 T870 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1ca90d1[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 182767 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 2
   [junit4]   2> 182769 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[1]} 0 1
   [junit4]   2> 182770 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[2]} 0 1
   [junit4]   2> 182771 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[3]} 0 1
   [junit4]   2> 182772 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[4]} 0 1
   [junit4]   2> 182773 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[5]} 0 1
   [junit4]   2> 182774 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[6]} 0 0
   [junit4]   2> 182775 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[7]} 0 1
   [junit4]   2> 182776 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[8]} 0 1
   [junit4]   2> 182776 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[9]} 0 0
   [junit4]   2> 182777 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[10]} 0 0
   [junit4]   2> 182779 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[11]} 0 0
   [junit4]   2> 182779 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[12]} 0 0
   [junit4]   2> 182780 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[13]} 0 0
   [junit4]   2> 182781 T868 C281 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 182788 T868 C281 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_b,generation=11}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_c,generation=12}
   [junit4]   2> 182789 T868 C281 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 12
   [junit4]   2> 182791 T868 C281 oass.SolrIndexSearcher.<init> Opening 
Searcher@1dc37a6[collection1] main
   [junit4]   2> 182791 T868 C281 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 182791 T870 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1dc37a6[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(6.0.0):c13)))}
   [junit4]   2> 182792 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 11
   [junit4]   2> 182795 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dbbox+score%3Dnone}Intersects(ENVELOPE(-0.034898260626377464,+0.23489826062637748,+0.23489805516424955,+-0.03489805516424954))&rows=1000&wt=xml}
 hits=2 status=0 QTime=2 
   [junit4]   2> 182797 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!bbox+sfield%3Dbbox+pt%3D'0.1,0.1'+d%3D15.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=2 status=0 QTime=1 
   [junit4]   2> 182799 T868 C281 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 182799 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 182801 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[14]} 0 1
   [junit4]   2> 182802 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[15]} 0 1
   [junit4]   2> 182803 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[16]} 0 1
   [junit4]   2> 182803 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[17]} 0 0
   [junit4]   2> 182804 T868 C281 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 182809 T868 C281 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_c,generation=12}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_d,generation=13}
   [junit4]   2> 182810 T868 C281 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 13
   [junit4]   2> 182812 T868 C281 oass.SolrIndexSearcher.<init> Opening 
Searcher@19efb88[collection1] main
   [junit4]   2> 182812 T868 C281 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 182812 T870 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@19efb88[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(6.0.0):c4)))}
   [junit4]   2> 182813 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 9
   [junit4]   2> 182815 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dbbox+score%3DrecipDistance}Intersects(ENVELOPE(-26.979611032849906,+26.979611032849906,+26.979611032849906,+-26.979611032849906))&rows=1000&wt=xml}
 hits=3 status=0 QTime=1 
   [junit4]   2> 182818 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!bbox+sfield%3Dbbox+pt%3D'0,0'+d%3D3000.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=3 status=0 QTime=1 
   [junit4]   2> 182820 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dbbox+score%3DrecipDistance}Intersects(ENVELOPE(-98.15383081481679,+-95.42537518518321,+44.50628240453783,+42.52777759546217))&rows=1000&wt=xml}
 hits=1 status=0 QTime=1 
   [junit4]   2> 182822 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!bbox+sfield%3Dbbox+pt%3D'43.517030,-96.789603'+d%3D110.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=1 status=0 QTime=1 
   [junit4]   2> 182823 T868 oas.SolrTestCaseJ4.tearDown ###Ending 
testIntersectFilter {p0=bbox}
   [junit4]   2> 182826 T868 oas.SolrTestCaseJ4.setUp ###Starting 
testSpatialConfig {p0=bbox}
   [junit4]   2> 182827 T868 C281 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 182827 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 182828 T868 C281 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 182828 T868 C281 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_d,generation=13}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_e,generation=14}
   [junit4]   2> 182828 T868 C281 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 14
   [junit4]   2> 182829 T868 C281 oass.SolrIndexSearcher.<init> Opening 
Searcher@1d6a39b[collection1] main
   [junit4]   2> 182829 T868 C281 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 182829 T870 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1d6a39b[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 182830 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 2
   [junit4]   2> 182831 T868 oas.SolrTestCaseJ4.tearDown ###Ending 
testSpatialConfig {p0=bbox}
   [junit4]   2> 182833 T868 oas.SolrTestCaseJ4.setUp ###Starting 
testBadShapeParse400 {p0=bbox}
   [junit4]   2> 182834 T868 C281 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 182834 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {deleteByQuery=*:*} 0 0
   [junit4]   2> 182835 T868 C281 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 182835 T868 C281 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_e,generation=14}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_f,generation=15}
   [junit4]   2> 182835 T868 C281 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 15
   [junit4]   2> 182836 T868 C281 oass.SolrIndexSearcher.<init> Opening 
Searcher@f4521d[collection1] main
   [junit4]   2> 182836 T868 C281 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 182836 T870 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@f4521d[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 182837 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 2
   [junit4]   2> 182838 T868 C281 oasc.SolrException.log Ignoring exception 
matching .
   [junit4]   2> 182838 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id,bbox&fq={!field+f%3Dbbox}Intersects(NonexistentShape(89.9,-130+d%3D9))&rows=1000&wt=xml}
 status=400 QTime=1 
   [junit4]   2> 182839 T868 C281 oasc.SolrException.log Ignoring exception 
matching .
   [junit4]   2> 182840 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id,bbox&fq={!field+f%3Dbbox}Intersects(NonexistentShape(89.9,-130+d%3D9&rows=1000&wt=xml}
 status=400 QTime=1 
   [junit4]   2> 182840 T868 C281 oasc.SolrException.log Ignoring exception 
matching .
   [junit4]   2> 182841 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id,bbox&fq={!field+f%3Dbbox}Intersectssss&rows=1000&wt=xml} 
status=400 QTime=1 
   [junit4]   2> 182841 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {} 0 0
   [junit4]   2> 182842 T868 C281 oasc.SolrException.log Ignoring exception 
matching NonexistentShape
   [junit4]   2> 182842 T868 oas.SolrTestCaseJ4.tearDown ###Ending 
testBadShapeParse400 {p0=bbox}
   [junit4]   2> 182845 T868 oas.SolrTestCaseJ4.setUp ###Starting testSort 
{p0=srpt_geohash}
   [junit4]   2> 182846 T868 C281 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 182846 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 182847 T868 C281 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 182847 T868 C281 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_f,generation=15}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_g,generation=16}
   [junit4]   2> 182848 T868 C281 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 16
   [junit4]   2> 182848 T868 C281 oass.SolrIndexSearcher.<init> Opening 
Searcher@1ac5514[collection1] main
   [junit4]   2> 182848 T868 C281 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 182849 T870 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1ac5514[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 182849 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 2
   [junit4]   2> 182852 T868 C281 
oass.AbstractSpatialPrefixTreeFieldType.newSpatialStrategy 
srpt_geohash{class=org.apache.solr.schema.SpatialRecursivePrefixTreeFieldType,analyzer=org.apache.solr.schema.FieldType$DefaultAnalyzer,args={distanceUnits=degrees,
 class=solr.SpatialRecursivePrefixTreeFieldType, prefixTree=geohash}} strat: 
RecursivePrefixTreeStrategy(SPG:(GeohashPrefixTree(maxLevels:11,ctx:SpatialContext{geo=true,
 calculator=Haversine, 
worldBounds=Rect(minX=-180.0,maxX=180.0,minY=-90.0,maxY=90.0)})),pruneLeafyBranches)
 maxLevels: 11
   [junit4]   2> 182856 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[100]} 0 6
   [junit4]   2> 182857 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[101]} 0 0
   [junit4]   2> 182858 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[999]} 0 0
   [junit4]   2> 182859 T868 C281 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 182861 T868 C281 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_g,generation=16}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_h,generation=17}
   [junit4]   2> 182861 T868 C281 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 17
   [junit4]   2> 182862 T868 C281 oass.SolrIndexSearcher.<init> Opening 
Searcher@1722770[collection1] main
   [junit4]   2> 182862 T868 C281 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 182862 T870 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1722770[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(6.0.0):c3)))}
   [junit4]   2> 182863 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 4
   [junit4]   2> 182867 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q={!+++}srpt_geohash:"Intersects(BUFFER(POINT(4.0+3.0),9.0))"&fl=id,score&wt=xml}
 hits=2 status=0 QTime=3 
   [junit4]   2> 182871 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q={!geofilt+sfield%3Dsrpt_geohash+score%3Ddistance++pt%3D3.0,4.0+d%3D9.0}&fl=id,score&sort=score+asc&wt=xml}
 hits=2 status=0 QTime=3 
   [junit4]   2> 182874 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q={!geofilt+sfield%3Dsrpt_geohash+score%3DrecipDistance++pt%3D3.0,4.0+d%3D9.0}&fl=id,score&sort=score+desc&wt=xml}
 hits=2 status=0 QTime=2 
   [junit4]   2> 182874 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q={!+score%3Ddistance+filter%3Dfalse+}srpt_geohash:"Intersects(BUFFER(POINT(4.0+3.0),1.0E-6))"&fl=id,score&sort=score+asc&wt=xml}
 hits=3 status=0 QTime=0 
   [junit4]   2> 182878 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q={!geofilt+sfield%3Dsrpt_geohash+score%3Ddistance++pt%3D4.0,0.0+d%3D9.0}&fl=id,score&sort=score+asc&wt=xml}
 hits=2 status=0 QTime=3 
   [junit4]   2> 182880 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=-id:999&fl=id,score&sort=query($sortQuery)+asc&wt=xml&sortQuery={!geofilt+sfield%3Dsrpt_geohash+score%3Ddistance++pt%3D3.0,4.0+d%3D9.0}}
 hits=2 status=0 QTime=2 
   [junit4]   2> 182883 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=-id:999&fl=id,score&sort=query($sortQuery)+asc&wt=xml&sortQuery={!+score%3Ddistance++}srpt_geohash:"Intersects(BUFFER(POINT(0.0+4.0),9.0))"}
 hits=2 status=0 QTime=3 
   [junit4]   2> 182883 T868 oas.SolrTestCaseJ4.tearDown ###Ending testSort 
{p0=srpt_geohash}
   [junit4]   2> 182887 T868 oas.SolrTestCaseJ4.setUp ###Starting 
checkQueryEmptyIndex {p0=srpt_geohash}
   [junit4]   2> 182887 T868 C281 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 182887 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {deleteByQuery=*:*} 0 0
   [junit4]   2> 182888 T868 C281 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 182889 T868 C281 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_h,generation=17}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_i,generation=18}
   [junit4]   2> 182889 T868 C281 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 18
   [junit4]   2> 182889 T868 C281 oass.SolrIndexSearcher.<init> Opening 
Searcher@12699b5[collection1] main
   [junit4]   2> 182890 T868 C281 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 182890 T870 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@12699b5[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 182890 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 2
   [junit4]   2> 182891 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dsrpt_geohash+score%3Ddistance}Intersects(BUFFER(POINT(0.0+0.0),0.8993203677616635))&rows=1000&wt=xml}
 hits=0 status=0 QTime=0 
   [junit4]   2> 182892 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dsrpt_geohash+pt%3D'0,0'+d%3D100.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=0 status=0 QTime=0 
   [junit4]   2> 182893 T868 oas.SolrTestCaseJ4.tearDown ###Ending 
checkQueryEmptyIndex {p0=srpt_geohash}
   [junit4]   2> 182896 T868 oas.SolrTestCaseJ4.setUp ###Starting 
testSortMultiVal {p0=srpt_geohash}
   [junit4]   2> 182896 T868 C281 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 182896 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {deleteByQuery=*:*} 0 0
   [junit4]   2> 182897 T868 C281 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 182898 T868 C281 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_i,generation=18}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_j,generation=19}
   [junit4]   2> 182898 T868 C281 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 19
   [junit4]   2> 182898 T868 C281 oass.SolrIndexSearcher.<init> Opening 
Searcher@8ee92a[collection1] main
   [junit4]   2> 182899 T868 C281 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 182899 T870 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@8ee92a[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 182899 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 2
   [junit4]   2> 182901 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[100]} 0 0
   [junit4]   2> 182903 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[101]} 0 1
   [junit4]   2> 182903 T868 C281 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 182905 T868 C281 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_j,generation=19}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_k,generation=20}
   [junit4]   2> 182905 T868 C281 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 20
   [junit4]   2> 182906 T868 C281 oass.SolrIndexSearcher.<init> Opening 
Searcher@1579a9b[collection1] main
   [junit4]   2> 182907 T868 C281 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 182907 T870 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1579a9b[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_6(6.0.0):c2)))}
   [junit4]   2> 182907 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 4
   [junit4]   2> 182909 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q={!+score%3Ddistance++}srpt_geohash:"Intersects(BUFFER(POINT(4.0+3.0),9.0))"&fl=id,score&sort=score+asc&wt=xml}
 hits=2 status=0 QTime=1 
   [junit4]   2> 182910 T868 oas.SolrTestCaseJ4.tearDown ###Ending 
testSortMultiVal {p0=srpt_geohash}
   [junit4]   2> 182913 T868 oas.SolrTestCaseJ4.setUp ###Starting 
testRangeSyntax {p0=srpt_geohash}
   [junit4]   2> 182913 T868 C281 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 182914 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 182914 T868 C281 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 182915 T868 C281 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_k,generation=20}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_l,generation=21}
   [junit4]   2> 182915 T868 C281 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 21
   [junit4]   2> 182916 T868 C281 oass.SolrIndexSearcher.<init> Opening 
Searcher@e2ed5d[collection1] main
   [junit4]   2> 182916 T868 C281 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 182916 T870 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@e2ed5d[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 182917 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 3
   [junit4]   2> 182918 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[1]} 0 1
   [junit4]   2> 182919 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[2]} 0 0
   [junit4]   2> 182920 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[3]} 0 0
   [junit4]   2> 182921 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[4]} 0 0
   [junit4]   2> 182922 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[5]} 0 1
   [junit4]   2> 182923 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[6]} 0 1
   [junit4]   2> 182923 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[7]} 0 0
   [junit4]   2> 182924 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[8]} 0 0
   [junit4]   2> 182925 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[9]} 0 0
   [junit4]   2> 182926 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[10]} 0 0
   [junit4]   2> 182927 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[11]} 0 0
   [junit4]   2> 182928 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[12]} 0 0
   [junit4]   2> 182929 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[13]} 0 0
   [junit4]   2> 182930 T868 C281 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 182932 T868 C281 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_l,generation=21}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_m,generation=22}
   [junit4]   2> 182933 T868 C281 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 22
   [junit4]   2> 182934 T868 C281 oass.SolrIndexSearcher.<init> Opening 
Searcher@f9b10f[collection1] main
   [junit4]   2> 182934 T868 C281 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 182934 T870 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@f9b10f[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_7(6.0.0):c13)))}
   [junit4]   2> 182935 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 5
   [junit4]   2> 182937 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!+score%3Dnone+df%3Dsrpt_geohash}[32,-80+TO+"33+,+-79"]&rows=1000&wt=xml}
 hits=1 status=0 QTime=1 
   [junit4]   2> 182938 T868 oas.SolrTestCaseJ4.tearDown ###Ending 
testRangeSyntax {p0=srpt_geohash}
   [junit4]   2> 182941 T868 oas.SolrTestCaseJ4.setUp ###Starting 
checkResultFormat {p0=srpt_geohash}
   [junit4]   2> 182942 T868 C281 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 182942 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 182943 T868 C281 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 182943 T868 C281 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_m,generation=22}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_n,generation=23}
   [junit4]   2> 182944 T868 C281 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 23
   [junit4]   2> 182944 T868 C281 oass.SolrIndexSearcher.<init> Opening 
Searcher@13e295d[collection1] main
   [junit4]   2> 182945 T868 C281 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 182945 T870 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@13e295d[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 182945 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 2
   [junit4]   2> 182946 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[11]} 0 0
   [junit4]   2> 182947 T868 C281 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 182949 T868 C281 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_n,generation=23}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_o,generation=24}
   [junit4]   2> 182949 T868 C281 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 24
   [junit4]   2> 182950 T868 C281 oass.SolrIndexSearcher.<init> Opening 
Searcher@31e518[collection1] main
   [junit4]   2> 182950 T868 C281 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 182950 T870 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@31e518[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_8(6.0.0):c1)))}
   [junit4]   2> 182951 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 4
   [junit4]   2> 182952 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id,srpt_geohash&fq={!bbox+sfield%3Dsrpt_geohash+pt%3D89.9,-130+d%3D9}&rows=1000&wt=xml}
 hits=1 status=0 QTime=0 
   [junit4]   2> 182953 T868 oas.SolrTestCaseJ4.tearDown ###Ending 
checkResultFormat {p0=srpt_geohash}
   [junit4]   2> 182956 T868 oas.SolrTestCaseJ4.setUp ###Starting 
testBadScoreParam {p0=srpt_geohash}
   [junit4]   2> 182956 T868 C281 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 182957 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 182958 T868 C281 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 182958 T868 C281 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_o,generation=24}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_p,generation=25}
   [junit4]   2> 182958 T868 C281 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 25
   [junit4]   2> 182959 T868 C281 oass.SolrIndexSearcher.<init> Opening 
Searcher@1b72388[collection1] main
   [junit4]   2> 182959 T868 C281 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 182959 T870 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1b72388[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 182960 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 2
   [junit4]   2> 182961 T868 C281 oasc.SolrException.log Ignoring exception 
matching .
   [junit4]   2> 182961 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q={!geofilt+sfield%3Dsrpt_geohash+score%3Dbogus+filter%3Dfalse+pt%3D0.0,0.0+d%3D0.0}&qt=standard&start=0&rows=20&version=2.2}
 status=400 QTime=1 
   [junit4]   2> 182961 T868 oas.SolrTestCaseJ4.tearDown ###Ending 
testBadScoreParam {p0=srpt_geohash}
   [junit4]   2> 182964 T868 oas.SolrTestCaseJ4.setUp ###Starting 
testIntersectFilter {p0=srpt_geohash}
   [junit4]   2> 182965 T868 C281 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 182965 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {deleteByQuery=*:*} 0 0
   [junit4]   2> 182966 T868 C281 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 182966 T868 C281 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_p,generation=25}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_q,generation=26}
   [junit4]   2> 182967 T868 C281 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 26
   [junit4]   2> 182967 T868 C281 oass.SolrIndexSearcher.<init> Opening 
Searcher@b255c3[collection1] main
   [junit4]   2> 182967 T868 C281 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 182968 T870 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@b255c3[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 182968 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 2
   [junit4]   2> 182969 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[1]} 0 0
   [junit4]   2> 182970 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[2]} 0 0
   [junit4]   2> 182971 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[3]} 0 0
   [junit4]   2> 182972 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[4]} 0 0
   [junit4]   2> 182973 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[5]} 0 0
   [junit4]   2> 182974 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[6]} 0 0
   [junit4]   2> 182975 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[7]} 0 1
   [junit4]   2> 182976 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[8]} 0 1
   [junit4]   2> 182976 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[9]} 0 0
   [junit4]   2> 182977 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[10]} 0 0
   [junit4]   2> 182978 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[11]} 0 0
   [junit4]   2> 182979 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[12]} 0 0
   [junit4]   2> 182980 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[13]} 0 0
   [junit4]   2> 182980 T868 C281 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 182983 T868 C281 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_q,generation=26}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_r,generation=27}
   [junit4]   2> 182984 T868 C281 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 27
   [junit4]   2> 182985 T868 C281 oass.SolrIndexSearcher.<init> Opening 
Searcher@1aa9b07[collection1] main
   [junit4]   2> 182985 T868 C281 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 182985 T870 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1aa9b07[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_9(6.0.0):c13)))}
   [junit4]   2> 182986 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 6
   [junit4]   2> 182988 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dsrpt_geohash+score%3Dnone}Intersects(BUFFER(POINT(1.0+1.0),1.5738106435829113))&rows=1000&wt=xml}
 hits=3 status=0 QTime=2 
   [junit4]   2> 182991 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dsrpt_geohash+pt%3D'1,1'+d%3D175.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=3 status=0 QTime=2 
   [junit4]   2> 182996 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dsrpt_geohash+score%3DrecipDistance}Intersects(BUFFER(POINT(179.8+0.0),1.798640735523327))&rows=1000&wt=xml}
 hits=2 status=0 QTime=4 
   [junit4]   2> 182999 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dsrpt_geohash+pt%3D'0,179.8'+d%3D200.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=2 status=0 QTime=2 
   [junit4]   2> 183001 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dsrpt_geohash+score%3DrecipDistance}Intersects(BUFFER(POINT(50.0+89.8),1.798640735523327))&rows=1000&wt=xml}
 hits=2 status=0 QTime=1 
   [junit4]   2> 183002 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dsrpt_geohash+pt%3D'89.8,+50'+d%3D200.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=2 status=0 QTime=0 
   [junit4]   2> 183004 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dsrpt_geohash+score%3Ddistance}Intersects(BUFFER(POINT(50.0+-89.8),1.798640735523327))&rows=1000&wt=xml}
 hits=2 status=0 QTime=1 
   [junit4]   2> 183007 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dsrpt_geohash+pt%3D'-89.8,+50'+d%3D200.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=2 status=0 QTime=1 
   [junit4]   2> 183008 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dsrpt_geohash+score%3Ddistance}Intersects(BUFFER(POINT(-80.0+33.0),2.6979611032849906))&rows=1000&wt=xml}
 hits=2 status=0 QTime=0 
   [junit4]   2> 183010 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dsrpt_geohash+pt%3D'33.0,-80.0'+d%3D300.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=2 status=0 QTime=1 
   [junit4]   2> 183012 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dsrpt_geohash}Intersects(BUFFER(POINT(1.0+1.0),44.96601838808318))&rows=1000&wt=xml}
 hits=3 status=0 QTime=2 
   [junit4]   2> 183015 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dsrpt_geohash+pt%3D'1,1'+d%3D5000.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=3 status=0 QTime=1 
   [junit4]   2> 183018 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dsrpt_geohash+score%3Dnone}Intersects(ENVELOPE(-0.034898260626377464,+0.23489826062637748,+0.23489805516424955,+-0.03489805516424954))&rows=1000&wt=xml}
 hits=2 status=0 QTime=2 
   [junit4]   2> 183020 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!bbox+sfield%3Dsrpt_geohash+pt%3D'0.1,0.1'+d%3D15.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=2 status=0 QTime=2 
   [junit4]   2> 183021 T868 C281 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 183021 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {deleteByQuery=*:*} 0 0
   [junit4]   2> 183023 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[14]} 0 1
   [junit4]   2> 183023 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[15]} 0 0
   [junit4]   2> 183024 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[16]} 0 0
   [junit4]   2> 183025 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[17]} 0 0
   [junit4]   2> 183026 T868 C281 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 183028 T868 C281 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_r,generation=27}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_s,generation=28}
   [junit4]   2> 183028 T868 C281 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 28
   [junit4]   2> 183029 T868 C281 oass.SolrIndexSearcher.<init> Opening 
Searcher@fd4eb2[collection1] main
   [junit4]   2> 183029 T868 C281 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 183030 T870 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@fd4eb2[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_a(6.0.0):c4)))}
   [junit4]   2> 183030 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 4
   [junit4]   2> 183032 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dsrpt_geohash+score%3Ddistance}Intersects(BUFFER(POINT(0.0+0.0),8.993203677616636))&rows=1000&wt=xml}
 hits=1 status=0 QTime=1 
   [junit4]   2> 183033 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dsrpt_geohash+pt%3D'0,0'+d%3D1000.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=1 status=0 QTime=0 
   [junit4]   2> 183035 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dsrpt_geohash}Intersects(BUFFER(POINT(0.0+0.0),17.986407355233272))&rows=1000&wt=xml}
 hits=2 status=0 QTime=1 
   [junit4]   2> 183037 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dsrpt_geohash+pt%3D'0,0'+d%3D2000.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=2 status=0 QTime=1 
   [junit4]   2> 183038 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dsrpt_geohash+score%3DrecipDistance}Intersects(ENVELOPE(-26.979611032849906,+26.979611032849906,+26.979611032849906,+-26.979611032849906))&rows=1000&wt=xml}
 hits=3 status=0 QTime=0 
   [junit4]   2> 183040 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!bbox+sfield%3Dsrpt_geohash+pt%3D'0,0'+d%3D3000.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=3 status=0 QTime=1 
   [junit4]   2> 183042 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dsrpt_geohash+score%3Ddistance}Intersects(BUFFER(POINT(0.0+0.0),26.98860423652752))&rows=1000&wt=xml}
 hits=3 status=0 QTime=1 
   [junit4]   2> 183044 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dsrpt_geohash+pt%3D'0,0'+d%3D3001.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=3 status=0 QTime=1 
   [junit4]   2> 183046 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dsrpt_geohash+score%3DrecipDistance}Intersects(BUFFER(POINT(0.0+0.0),26.980510353217664))&rows=1000&wt=xml}
 hits=3 status=0 QTime=1 
   [junit4]   2> 183048 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dsrpt_geohash+pt%3D'0,0'+d%3D3000.1+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=3 status=0 QTime=0 
   [junit4]   2> 183050 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dsrpt_geohash}Intersects(BUFFER(POINT(-96.789603+43.51703),0.9802592008602133))&rows=1000&wt=xml}
 hits=0 status=0 QTime=0 
   [junit4]   2> 183051 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dsrpt_geohash+pt%3D'43.517030,-96.789603'+d%3D109.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=0 status=0 QTime=0 
   [junit4]   2> 183053 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dsrpt_geohash+score%3Dnone}Intersects(BUFFER(POINT(-96.789603+43.51703),0.9892524045378299))&rows=1000&wt=xml}
 hits=0 status=0 QTime=1 
   [junit4]   2> 183054 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dsrpt_geohash+pt%3D'43.517030,-96.789603'+d%3D110.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=0 status=0 QTime=1 
   [junit4]   2> 183055 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dsrpt_geohash+score%3Dnone}Intersects(ENVELOPE(-98.15383081481679,+-95.42537518518321,+44.50628240453783,+42.52777759546217))&rows=1000&wt=xml}
 hits=1 status=0 QTime=1 
   [junit4]   2> 183057 T868 C281 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!bbox+sfield%3Dsrpt_geohash+pt%3D'43.517030,-96.789603'+d%3D110.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=1 status=0 QTime=1 
   [junit4]   2> 183058 T868 oas.SolrTestCaseJ4.tearDown ###Ending 
testIntersectFilter {p0=srpt_geohash}
   [junit4]   2> 183060 T868 oas.SolrTestCaseJ4.setUp ###Starting 
testSpatialConfig {p0=srpt_geohash}
   [junit4]   2> 183061 T868 C281 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 183061 T868 C281 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {deleteByQuery=*:*} 0 0
   [junit4]   2> 183062 T868 C281 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 183062 T868 C281 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_s,generation=28}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@4ce837 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1823bf2),segFN=segments_t,generation=29}
   [junit4]   2> 183063 T868 C281 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 29
   [junit4]   2> 183063 T868 C281 oass.SolrIndexSearcher.<init> Opening 
Searcher@17f20fa[collection1] main
   [junit4]   2> 183064 T868 C281 oasu.DirectUpdateHandler2.commi

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

eadLeakControl.checkThreadLeaks WARNING Will linger awaiting termination of 2 
leaked thread(s).
   [junit4]   2> 25520 T867 ccr.ThreadLeakControl.checkThreadLeaks SEVERE 2 
threads leaked from SUITE scope at org.apache.solr.search.TestSolr4Spatial: 
   [junit4]   2>           1) Thread[id=870, 
name=searcherExecutor-488-thread-1, state=WAITING, group=TGRP-TestSolr4Spatial]
   [junit4]   2>                at sun.misc.Unsafe.park(Native Method)
   [junit4]   2>                at 
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
   [junit4]   2>                at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
   [junit4]   2>                at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
   [junit4]   2>                at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
   [junit4]   2>                at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
   [junit4]   2>                at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   [junit4]   2>                at java.lang.Thread.run(Thread.java:745)
   [junit4]   2>           2) Thread[id=871, name=Thread-306, state=WAITING, 
group=TGRP-TestSolr4Spatial]
   [junit4]   2>                at java.lang.Object.wait(Native Method)
   [junit4]   2>                at java.lang.Object.wait(Object.java:502)
   [junit4]   2>                at 
org.apache.solr.core.CloserThread.run(CoreContainer.java:902)
   [junit4]   2> 25521 T867 ccr.ThreadLeakControl.tryToInterruptAll Starting to 
interrupt leaked threads:
   [junit4]   2>           1) Thread[id=870, 
name=searcherExecutor-488-thread-1, state=WAITING, group=TGRP-TestSolr4Spatial]
   [junit4]   2>           2) Thread[id=871, name=Thread-306, state=WAITING, 
group=TGRP-TestSolr4Spatial]
   [junit4]   2> 28529 T867 ccr.ThreadLeakControl.tryToInterruptAll SEVERE 
There are still zombie threads that couldn't be terminated:
   [junit4]   2>           1) Thread[id=870, 
name=searcherExecutor-488-thread-1, state=WAITING, group=TGRP-TestSolr4Spatial]
   [junit4]   2>                at sun.misc.Unsafe.park(Native Method)
   [junit4]   2>                at 
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
   [junit4]   2>                at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
   [junit4]   2>                at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
   [junit4]   2>                at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
   [junit4]   2>                at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
   [junit4]   2>                at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   [junit4]   2>                at java.lang.Thread.run(Thread.java:745)
   [junit4]   2>           2) Thread[id=871, name=Thread-306, state=WAITING, 
group=TGRP-TestSolr4Spatial]
   [junit4]   2>                at java.lang.Object.wait(Native Method)
   [junit4]   2>                at java.lang.Object.wait(Object.java:502)
   [junit4]   2>                at 
org.apache.solr.core.CloserThread.run(CoreContainer.java:902)
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene50): 
{bbox__xdl=PostingsFormat(name=Memory doPackFST= false), 
srpt_geohash=PostingsFormat(name=Memory doPackFST= false), 
bbox__maxX=BlockTreeOrds(blocksize=128), 
bbox__maxY=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 bbox__minX=PostingsFormat(name=Memory doPackFST= false), 
bbox__minY=Lucene50(blocksize=128), 
pointvector__y=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 pointvector__x=BlockTreeOrds(blocksize=128), id=PostingsFormat(name=Memory 
doPackFST= false), srpt_quad=PostingsFormat(name=Memory doPackFST= false), 
stqpt_geohash=Lucene50(blocksize=128)}, 
docValues:{bbox__maxX=DocValuesFormat(name=Direct), 
bbox__maxY=DocValuesFormat(name=Memory), 
bbox__minX=DocValuesFormat(name=Asserting), 
bbox__minY=DocValuesFormat(name=Lucene50)}, sim=DefaultSimilarity, 
locale=zh_SG, timezone=Indian/Reunion
   [junit4]   2> NOTE: Linux 3.13.0-45-generic i386/Oracle Corporation 1.9.0-ea 
(32-bit)/cpus=8,threads=3,free=121044944,total=301989888
   [junit4]   2> NOTE: All tests run in this JVM: [TestSortingResponseWriter, 
TestNRTOpen, TestJoin, TestFreeTextSuggestions, RAMDirectoryFactoryTest, 
DateRangeFieldTest, PluginInfoTest, TestTrie, TestClusterStateMutator, 
SpellCheckComponentTest, TestNoOpRegenerator, TestFileDictionaryLookup, 
QueryResultKeyTest, DistributedExpandComponentTest, MigrateRouteKeyTest, 
TestReplicaProperties, TestCoreDiscovery, TestImplicitCoreProperties, 
SolrTestCaseJ4Test, ExternalCollectionsTest, PolyFieldTest, 
TestPHPSerializedResponseWriter, TestSolr4Spatial]
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestSolr4Spatial 
-Dtests.seed=9D5B345CFDE272E6 -Dtests.multiplier=3 -Dtests.slow=true 
-Dtests.locale=zh_SG -Dtests.timezone=Indian/Reunion -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.00s J1 | TestSolr4Spatial (suite) <<<
   [junit4]    > Throwable #1: java.lang.RuntimeException: 
SolrCore.getOpenCount()==6
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([9D5B345CFDE272E6]:0)
   [junit4]    >        at 
org.apache.solr.util.TestHarness.close(TestHarness.java:356)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.deleteCore(SolrTestCaseJ4.java:683)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:226)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)Throwable #2: 
com.carrotsearch.randomizedtesting.ThreadLeakError: 2 threads leaked from SUITE 
scope at org.apache.solr.search.TestSolr4Spatial: 
   [junit4]    >    1) Thread[id=870, name=searcherExecutor-488-thread-1, 
state=WAITING, group=TGRP-TestSolr4Spatial]
   [junit4]    >         at sun.misc.Unsafe.park(Native Method)
   [junit4]    >         at 
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
   [junit4]    >         at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
   [junit4]    >         at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
   [junit4]    >         at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
   [junit4]    >         at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
   [junit4]    >         at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   [junit4]    >         at java.lang.Thread.run(Thread.java:745)
   [junit4]    >    2) Thread[id=871, name=Thread-306, state=WAITING, 
group=TGRP-TestSolr4Spatial]
   [junit4]    >         at java.lang.Object.wait(Native Method)
   [junit4]    >         at java.lang.Object.wait(Object.java:502)
   [junit4]    >         at 
org.apache.solr.core.CloserThread.run(CoreContainer.java:902)
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([9D5B345CFDE272E6]:0)Throwable #3: 
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie 
threads that couldn't be terminated:
   [junit4]    >    1) Thread[id=870, name=searcherExecutor-488-thread-1, 
state=WAITING, group=TGRP-TestSolr4Spatial]
   [junit4]    >         at sun.misc.Unsafe.park(Native Method)
   [junit4]    >         at 
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
   [junit4]    >         at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
   [junit4]    >         at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
   [junit4]    >         at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
   [junit4]    >         at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
   [junit4]    >         at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   [junit4]    >         at java.lang.Thread.run(Thread.java:745)
   [junit4]    >    2) Thread[id=871, name=Thread-306, state=WAITING, 
group=TGRP-TestSolr4Spatial]
   [junit4]    >         at java.lang.Object.wait(Native Method)
   [junit4]    >         at java.lang.Object.wait(Object.java:502)
   [junit4]    >         at 
org.apache.solr.core.CloserThread.run(CoreContainer.java:902)
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([9D5B345CFDE272E6]:0)
   [junit4] Completed on J1 in 28.60s, 45 tests, 3 errors, 2 skipped <<< 
FAILURES!

[...truncated 1289 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:519: The following 
error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:467: The following 
error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:61: The following 
error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/extra-targets.xml:39: The 
following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build.xml:191: The 
following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/common-build.xml:510: 
The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:1351:
 The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:958: 
There were test failures: 468 suites, 1868 tests, 3 suite-level errors, 1323 
ignored (15 assumptions)

Total time: 57 minutes 45 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 32bit/jdk1.9.0-ea-b47 -client 
-XX:+UseG1GC
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any


---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to