Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/11883/
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([3FA4C8399F64215A]: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.GeneratedMethodAccessor32.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=11022, name=Thread-3973, 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)    2) 
Thread[id=11021, name=searcherExecutor-4338-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)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 2 threads leaked from SUITE 
scope at org.apache.solr.search.TestSolr4Spatial: 
   1) Thread[id=11022, name=Thread-3973, 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)
   2) Thread[id=11021, name=searcherExecutor-4338-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)
        at __randomizedtesting.SeedInfo.seed([3FA4C8399F64215A]: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=11022, name=Thread-3973, 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)    2) 
Thread[id=11021, name=searcherExecutor-4338-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)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie 
threads that couldn't be terminated:
   1) Thread[id=11022, name=Thread-3973, 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)
   2) Thread[id=11021, name=searcherExecutor-4338-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)
        at __randomizedtesting.SeedInfo.seed([3FA4C8399F64215A]:0)




Build Log:
[...truncated 9782 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/J0/temp/solr.search.TestSolr4Spatial
 3FA4C8399F64215A-001/init-core-data-001
   [junit4]   2> 1575509 T11019 oas.SolrTestCaseJ4.buildSSLConfig Randomized 
ssl (false) and clientAuth (false)
   [junit4]   2> 1575510 T11019 oas.SolrTestCaseJ4.initCore ####initCore
   [junit4]   2> 1575510 T11019 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 1575511 T11019 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> 1575511 T11019 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> 1575511 T11019 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> 1575536 T11019 oasc.SolrConfig.refreshRequestParams current 
version of requestparams : -1
   [junit4]   2> 1575540 T11019 oasc.SolrConfig.<init> Using Lucene 
MatchVersion: 6.0.0
   [junit4]   2> 1575547 T11019 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig-basic.xml
   [junit4]   2> 1575548 T11019 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> 1575552 T11019 oass.IndexSchema.readSchema [null] Schema 
name=test
   [junit4]   2> 1575564 T11019 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 1575565 T11019 oasc.SolrResourceLoader.locateSolrHome JNDI not 
configured for solr (NoInitialContextEx)
   [junit4]   2> 1575566 T11019 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> 1575566 T11019 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/'
   [junit4]   2> 1575584 T11019 oasc.CoreContainer.<init> New CoreContainer 
18406532
   [junit4]   2> 1575584 T11019 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/]
   [junit4]   2> 1575584 T11019 oasc.CoreContainer.load loading shared library: 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/lib
   [junit4]   2> 1575585 T11019 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> 1575592 T11019 oashc.HttpShardHandlerFactory.getParameter 
Setting socketTimeout to: 600000
   [junit4]   2> 1575592 T11019 oashc.HttpShardHandlerFactory.getParameter 
Setting urlScheme to: null
   [junit4]   2> 1575592 T11019 oashc.HttpShardHandlerFactory.getParameter 
Setting connTimeout to: 60000
   [junit4]   2> 1575593 T11019 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnectionsPerHost to: 20
   [junit4]   2> 1575593 T11019 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnections to: 10000
   [junit4]   2> 1575593 T11019 oashc.HttpShardHandlerFactory.getParameter 
Setting corePoolSize to: 0
   [junit4]   2> 1575594 T11019 oashc.HttpShardHandlerFactory.getParameter 
Setting maximumPoolSize to: 2147483647
   [junit4]   2> 1575594 T11019 oashc.HttpShardHandlerFactory.getParameter 
Setting maxThreadIdleTime to: 5
   [junit4]   2> 1575594 T11019 oashc.HttpShardHandlerFactory.getParameter 
Setting sizeOfQueue to: -1
   [junit4]   2> 1575595 T11019 oashc.HttpShardHandlerFactory.getParameter 
Setting fairnessPolicy to: false
   [junit4]   2> 1575595 T11019 oashc.HttpShardHandlerFactory.getParameter 
Setting useRetries to: false
   [junit4]   2> 1575596 T11019 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=30000&connTimeout=30000&retry=true
   [junit4]   2> 1575596 T11019 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1575597 T11019 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1575597 T11019 oasc.CoreContainer.load Node Name: testNode
   [junit4]   2> 1575598 T11020 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 1575599 T11020 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> 1575599 T11020 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> 1575599 T11020 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> 1575618 T11020 oasc.SolrConfig.refreshRequestParams current 
version of requestparams : -1
   [junit4]   2> 1575623 T11020 oasc.SolrConfig.<init> Using Lucene 
MatchVersion: 6.0.0
   [junit4]   2> 1575632 T11020 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig-basic.xml
   [junit4]   2> 1575632 T11020 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> 1575636 T11020 oass.IndexSchema.readSchema [collection1] 
Schema name=test
   [junit4]   2> 1575646 T11020 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 1575647 T11020 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> 1575647 T11020 oasc.SolrCore.initDirectoryFactory 
org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1575648 T11020 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/J0/temp/solr.search.TestSolr4Spatial
 3FA4C8399F64215A-001/init-core-data-001/
   [junit4]   2> 1575648 T11020 oasc.SolrCore.<init> JMX monitoring not 
detected for core: collection1
   [junit4]   2> 1575648 T11020 oasc.CachingDirectoryFactory.get return new 
directory for 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.TestSolr4Spatial
 3FA4C8399F64215A-001/init-core-data-001
   [junit4]   2> 1575649 T11020 oasc.SolrCore.getNewIndexDir New index 
directory detected: old=null 
new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.TestSolr4Spatial
 3FA4C8399F64215A-001/init-core-data-001/index/
   [junit4]   2> 1575649 T11020 oasc.SolrCore.initIndex WARN [collection1] Solr 
index directory 
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.TestSolr4Spatial
 3FA4C8399F64215A-001/init-core-data-001/index' doesn't exist. Creating new 
index...
   [junit4]   2> 1575649 T11020 oasc.CachingDirectoryFactory.get return new 
directory for 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.TestSolr4Spatial
 3FA4C8399F64215A-001/init-core-data-001/index
   [junit4]   2> 1575650 T11020 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=13, maxMergeAtOnceExplicit=10, maxMergedSegmentMB=42.3154296875, 
floorSegmentMB=0.458984375, forceMergeDeletesPctAllowed=7.774919894872932, 
segmentsPerTier=13.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6150451347876604
   [junit4]   2> 1575651 T11020 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_1,generation=1}
   [junit4]   2> 1575651 T11020 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 1575652 T11020 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1575652 T11020 oasc.RequestHandlers.initHandlersFromConfig 
created /update: solr.UpdateRequestHandler
   [junit4]   2> 1575652 T11020 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 1575653 T11020 oasc.RequestHandlers.initHandlersFromConfig 
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 1575653 T11020 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 1575653 T11020 oasc.RequestHandlers.initHandlersFromConfig 
created /config: org.apache.solr.handler.SolrConfigHandler
   [junit4]   2> 1575654 T11020 oasc.RequestHandlers.initHandlersFromConfig 
created /schema: org.apache.solr.handler.SchemaHandler
   [junit4]   2> 1575654 T11020 oasc.RequestHandlers.initHandlersFromConfig 
created /replication: org.apache.solr.handler.ReplicationHandler
   [junit4]   2> 1575654 T11020 oasc.RequestHandlers.initHandlersFromConfig 
created /get: org.apache.solr.handler.RealTimeGetHandler
   [junit4]   2> 1575655 T11020 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
   [junit4]   2> 1575655 T11020 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
   [junit4]   2> 1575655 T11020 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
   [junit4]   2> 1575656 T11020 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
   [junit4]   2> 1575656 T11020 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
   [junit4]   2> 1575656 T11020 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/properties: 
org.apache.solr.handler.admin.PropertiesRequestHandler
   [junit4]   2> 1575657 T11020 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
   [junit4]   2> 1575657 T11020 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/file: org.apache.solr.handler.admin.ShowFileRequestHandler
   [junit4]   2> 1575657 T11020 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/ping: org.apache.solr.handler.PingRequestHandler
   [junit4]   2> 1575658 T11020 oasc.RequestHandlers.initHandlersFromConfig 
created standard: solr.StandardRequestHandler
   [junit4]   2> 1575659 T11020 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1575660 T11020 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1575660 T11020 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1575661 T11020 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1575662 T11020 oasc.SolrCore.initStatsCache Using default 
statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1575662 T11020 oasu.CommitTracker.<init> Hard AutoCommit: 
disabled
   [junit4]   2> 1575663 T11020 oasu.CommitTracker.<init> Soft AutoCommit: 
disabled
   [junit4]   2> 1575663 T11020 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=10, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.3319064062124627]
   [junit4]   2> 1575664 T11020 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_1,generation=1}
   [junit4]   2> 1575664 T11020 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 1575664 T11020 oass.SolrIndexSearcher.<init> Opening 
Searcher@4dd304[collection1] main
   [junit4]   2> 1575664 T11020 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> 1575665 T11020 oasr.RestManager.init Initializing RestManager 
with initArgs: {}
   [junit4]   2> 1575665 T11020 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using InMemoryStorage
   [junit4]   2> 1575665 T11020 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 1575665 T11020 oash.ReplicationHandler.inform Commits will be 
reserved for  10000
   [junit4]   2> 1575666 T11021 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@4dd304[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1575666 T11020 oasc.CoreContainer.registerCore registering 
core: collection1
   [junit4]   2> 1575667 T11019 oas.SolrTestCaseJ4.initCore ####initCore end
   [junit4]   2> 1575670 T11019 oas.SolrTestCaseJ4.setUp ###Starting testSort 
{p0=bbox}
   [junit4]   2> ASYNC  NEW_CORE C4389 name=collection1 
org.apache.solr.core.SolrCore@ee2688
   [junit4]   2> 1575670 T11019 C4389 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1575671 T11019 C4389 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 1575673 T11019 C4389 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1575674 T11019 C4389 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_1,generation=1}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_2,generation=2}
   [junit4]   2> 1575675 T11019 C4389 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 2
   [junit4]   2> 1575675 T11019 C4389 oass.SolrIndexSearcher.<init> Opening 
Searcher@1e5f9ad[collection1] main
   [junit4]   2> 1575676 T11019 C4389 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1575676 T11021 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1e5f9ad[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1575677 T11019 C4389 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 4
   [junit4]   2> 1575678 T11019 C4389 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[100]} 0 1
   [junit4]   2> 1575679 T11019 C4389 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[101]} 0 0
   [junit4]   2> 1575680 T11019 C4389 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[999]} 0 1
   [junit4]   2> 1575680 T11019 C4389 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1575683 T11019 C4389 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_2,generation=2}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_3,generation=3}
   [junit4]   2> 1575683 T11019 C4389 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 3
   [junit4]   2> 1575702 T11019 C4389 oass.SolrIndexSearcher.<init> Opening 
Searcher@116fcfb[collection1] main
   [junit4]   2> 1575703 T11021 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@116fcfb[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C3)))}
   [junit4]   2> 1575703 T11019 C4389 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1575704 T11019 C4389 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 24
   [junit4]   2> 1575709 T11019 C4389 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=4 
   [junit4]   2> 1575715 T11019 C4389 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=5 
   [junit4]   2> 1575719 T11019 C4389 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=3 
   [junit4]   2> 1575720 T11019 C4389 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=0 
   [junit4]   2> 1575722 T11019 C4389 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> 1575724 T11019 C4389 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=1 
   [junit4]   2> 1575726 T11019 C4389 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> 1575727 T11019 oas.SolrTestCaseJ4.tearDown ###Ending testSort 
{p0=bbox}
   [junit4]   2> 1575732 T11019 oas.SolrTestCaseJ4.setUp ###Starting 
testSortMultiVal {p0=bbox}
   [junit4]   2> 1575732 T11019 C4389 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1575733 T11019 C4389 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 1575734 T11019 C4389 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1575735 T11019 C4389 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_3,generation=3}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_4,generation=4}
   [junit4]   2> 1575735 T11019 C4389 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 4
   [junit4]   2> 1575736 T11019 C4389 oass.SolrIndexSearcher.<init> Opening 
Searcher@1a5441[collection1] main
   [junit4]   2> 1575736 T11019 C4389 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1575736 T11021 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1a5441[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1575737 T11019 C4389 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 3
   [junit4]   2> 1575738 T11019 oas.SolrTestCaseJ4.tearDown ###Ending 
testSortMultiVal {p0=bbox}
   [junit4] IGNOR/A 0.02s J0 | TestSolr4Spatial.testSortMultiVal {p0=bbox}
   [junit4]    > Assumption #1: Multivalue not supported for this field
   [junit4]   2> 1575748 T11019 oas.SolrTestCaseJ4.setUp ###Starting 
checkQueryEmptyIndex {p0=bbox}
   [junit4]   2> 1575749 T11019 C4389 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1575749 T11019 C4389 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
   [junit4]   2> 1575750 T11019 C4389 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1575751 T11019 C4389 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_4,generation=4}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_5,generation=5}
   [junit4]   2> 1575752 T11019 C4389 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 5
   [junit4]   2> 1575752 T11019 C4389 oass.SolrIndexSearcher.<init> Opening 
Searcher@f72deb[collection1] main
   [junit4]   2> 1575753 T11019 C4389 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1575753 T11021 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@f72deb[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1575754 T11019 C4389 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 4
   [junit4]   2> 1575755 T11019 oas.SolrTestCaseJ4.tearDown ###Ending 
checkQueryEmptyIndex {p0=bbox}
   [junit4]   2> 1575760 T11019 oas.SolrTestCaseJ4.setUp ###Starting 
testIntersectFilter {p0=bbox}
   [junit4]   2> 1575760 T11019 C4389 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1575761 T11019 C4389 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 1575762 T11019 C4389 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1575763 T11019 C4389 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_5,generation=5}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_6,generation=6}
   [junit4]   2> 1575763 T11019 C4389 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 6
   [junit4]   2> 1575764 T11019 C4389 oass.SolrIndexSearcher.<init> Opening 
Searcher@1928e43[collection1] main
   [junit4]   2> 1575765 T11019 C4389 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1575765 T11021 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1928e43[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1575765 T11019 C4389 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 3
   [junit4]   2> 1575767 T11019 C4389 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[1]} 0 1
   [junit4]   2> 1575768 T11019 C4389 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[2]} 0 0
   [junit4]   2> 1575769 T11019 C4389 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[3]} 0 0
   [junit4]   2> 1575770 T11019 C4389 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[4]} 0 0
   [junit4]   2> 1575771 T11019 C4389 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[5]} 0 0
   [junit4]   2> 1575772 T11019 C4389 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[6]} 0 0
   [junit4]   2> 1575773 T11019 C4389 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[7]} 0 0
   [junit4]   2> 1575774 T11019 C4389 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[8]} 0 0
   [junit4]   2> ASYNC  NEW_CORE C4390 name=collection1 
org.apache.solr.core.SolrCore@ee2688
   [junit4]   2> 1575784 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[9]} 0 1
   [junit4]   2> 1575786 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[10]} 0 0
   [junit4]   2> 1575787 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[11]} 0 0
   [junit4]   2> 1575788 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[12]} 0 0
   [junit4]   2> 1575789 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[13]} 0 0
   [junit4]   2> 1575790 T11019 C4390 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1575793 T11019 C4390 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_6,generation=6}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_7,generation=7}
   [junit4]   2> 1575794 T11019 C4390 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 7
   [junit4]   2> 1575796 T11019 C4390 oass.SolrIndexSearcher.<init> Opening 
Searcher@1370718[collection1] main
   [junit4]   2> 1575796 T11019 C4390 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1575796 T11021 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1370718[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.0.0):C13)))}
   [junit4]   2> 1575797 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 7
   [junit4]   2> 1575801 T11019 C4390 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> 1575804 T11019 C4390 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> 1575806 T11019 C4390 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1575807 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 1575808 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[14]} 0 1
   [junit4]   2> 1575809 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[15]} 0 0
   [junit4]   2> 1575810 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[16]} 0 0
   [junit4]   2> 1575811 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[17]} 0 0
   [junit4]   2> 1575812 T11019 C4390 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1575815 T11019 C4390 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_7,generation=7}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_8,generation=8}
   [junit4]   2> 1575815 T11019 C4390 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 8
   [junit4]   2> 1575817 T11019 C4390 oass.SolrIndexSearcher.<init> Opening 
Searcher@1900e4d[collection1] main
   [junit4]   2> 1575818 T11019 C4390 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1575818 T11021 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1900e4d[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(6.0.0):C4)))}
   [junit4]   2> 1575819 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 7
   [junit4]   2> 1575821 T11019 C4390 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dbbox}Intersects(ENVELOPE(-26.979611032849906,+26.979611032849906,+26.979611032849906,+-26.979611032849906))&rows=1000&wt=xml}
 hits=3 status=0 QTime=1 
   [junit4]   2> 1575823 T11019 C4390 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=0 
   [junit4]   2> 1575826 T11019 C4390 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dbbox+score%3Ddistance}Intersects(ENVELOPE(-98.15383081481679,+-95.42537518518321,+44.50628240453783,+42.52777759546217))&rows=1000&wt=xml}
 hits=1 status=0 QTime=0 
   [junit4]   2> 1575828 T11019 C4390 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=0 
   [junit4]   2> 1575830 T11019 oas.SolrTestCaseJ4.tearDown ###Ending 
testIntersectFilter {p0=bbox}
   [junit4]   2> 1575835 T11019 oas.SolrTestCaseJ4.setUp ###Starting 
testSpatialConfig {p0=bbox}
   [junit4]   2> 1575835 T11019 C4390 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1575836 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 1575837 T11019 C4390 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1575837 T11019 C4390 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_8,generation=8}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_9,generation=9}
   [junit4]   2> 1575838 T11019 C4390 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 9
   [junit4]   2> 1575839 T11019 C4390 oass.SolrIndexSearcher.<init> Opening 
Searcher@f783c[collection1] main
   [junit4]   2> 1575839 T11019 C4390 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1575839 T11021 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@f783c[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1575840 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 3
   [junit4]   2> 1575841 T11019 oas.SolrTestCaseJ4.tearDown ###Ending 
testSpatialConfig {p0=bbox}
   [junit4]   2> 1575846 T11019 oas.SolrTestCaseJ4.setUp ###Starting 
checkResultFormat {p0=bbox}
   [junit4]   2> 1575846 T11019 C4390 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1575847 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 1575848 T11019 C4390 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1575848 T11019 C4390 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_9,generation=9}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_a,generation=10}
   [junit4]   2> 1575849 T11019 C4390 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 10
   [junit4]   2> 1575850 T11019 C4390 oass.SolrIndexSearcher.<init> Opening 
Searcher@1fa974e[collection1] main
   [junit4]   2> 1575850 T11019 C4390 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1575850 T11021 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1fa974e[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1575851 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 3
   [junit4]   2> 1575853 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[11]} 0 1
   [junit4]   2> 1575853 T11019 C4390 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1575856 T11019 C4390 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_a,generation=10}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_b,generation=11}
   [junit4]   2> 1575857 T11019 C4390 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 11
   [junit4]   2> 1575858 T11019 C4390 oass.SolrIndexSearcher.<init> Opening 
Searcher@e2f6b7[collection1] main
   [junit4]   2> 1575859 T11019 C4390 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1575859 T11021 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@e2f6b7[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(6.0.0):C1)))}
   [junit4]   2> 1575860 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 7
   [junit4]   2> 1575862 T11019 C4390 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> 1575863 T11019 oas.SolrTestCaseJ4.tearDown ###Ending 
checkResultFormat {p0=bbox}
   [junit4]   2> 1575867 T11019 oas.SolrTestCaseJ4.setUp ###Starting 
testBadShapeParse400 {p0=bbox}
   [junit4]   2> 1575868 T11019 C4390 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1575868 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 1575869 T11019 C4390 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1575870 T11019 C4390 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_b,generation=11}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_c,generation=12}
   [junit4]   2> 1575870 T11019 C4390 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 12
   [junit4]   2> 1575871 T11019 C4390 oass.SolrIndexSearcher.<init> Opening 
Searcher@777818[collection1] main
   [junit4]   2> 1575872 T11019 C4390 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1575872 T11021 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@777818[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1575873 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 4
   [junit4]   2> 1575875 T11019 C4390 oasc.SolrException.log Ignoring exception 
matching .
   [junit4]   2> 1575875 T11019 C4390 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> 1575877 T11019 C4390 oasc.SolrException.log Ignoring exception 
matching .
   [junit4]   2> 1575877 T11019 C4390 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> 1575878 T11019 C4390 oasc.SolrException.log Ignoring exception 
matching .
   [junit4]   2> 1575879 T11019 C4390 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> 1575879 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {} 0 0
   [junit4]   2> 1575881 T11019 C4390 oasc.SolrException.log Ignoring exception 
matching NonexistentShape
   [junit4]   2> 1575881 T11019 oas.SolrTestCaseJ4.tearDown ###Ending 
testBadShapeParse400 {p0=bbox}
   [junit4]   2> 1575886 T11019 oas.SolrTestCaseJ4.setUp ###Starting 
testBadScoreParam {p0=bbox}
   [junit4]   2> 1575886 T11019 C4390 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1575887 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 1575888 T11019 C4390 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1575889 T11019 C4390 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_c,generation=12}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_d,generation=13}
   [junit4]   2> 1575889 T11019 C4390 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 13
   [junit4]   2> 1575890 T11019 C4390 oass.SolrIndexSearcher.<init> Opening 
Searcher@10effd1[collection1] main
   [junit4]   2> 1575890 T11019 C4390 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1575890 T11021 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@10effd1[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1575891 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 3
   [junit4]   2> 1575893 T11019 C4390 oasc.SolrException.log Ignoring exception 
matching .
   [junit4]   2> 1575893 T11019 C4390 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=1 
   [junit4]   2> 1575894 T11019 oas.SolrTestCaseJ4.tearDown ###Ending 
testBadScoreParam {p0=bbox}
   [junit4]   2> 1575898 T11019 oas.SolrTestCaseJ4.setUp ###Starting 
testRangeSyntax {p0=bbox}
   [junit4]   2> 1575899 T11019 C4390 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1575899 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
   [junit4]   2> 1575900 T11019 C4390 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1575901 T11019 C4390 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_d,generation=13}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_e,generation=14}
   [junit4]   2> 1575902 T11019 C4390 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 14
   [junit4]   2> 1575902 T11019 C4390 oass.SolrIndexSearcher.<init> Opening 
Searcher@15cf8ea[collection1] main
   [junit4]   2> 1575903 T11019 C4390 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1575903 T11021 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@15cf8ea[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1575904 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 4
   [junit4]   2> 1575906 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[1]} 0 1
   [junit4]   2> 1575907 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[2]} 0 1
   [junit4]   2> 1575907 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[3]} 0 0
   [junit4]   2> 1575908 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[4]} 0 0
   [junit4]   2> 1575909 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[5]} 0 0
   [junit4]   2> 1575910 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[6]} 0 0
   [junit4]   2> 1575911 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[7]} 0 0
   [junit4]   2> 1575912 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[8]} 0 0
   [junit4]   2> 1575913 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[9]} 0 0
   [junit4]   2> 1575914 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[10]} 0 0
   [junit4]   2> 1575915 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[11]} 0 0
   [junit4]   2> 1575916 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[12]} 0 0
   [junit4]   2> 1575917 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[13]} 0 1
   [junit4]   2> 1575917 T11019 C4390 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1575921 T11019 C4390 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_e,generation=14}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_f,generation=15}
   [junit4]   2> 1575922 T11019 C4390 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 15
   [junit4]   2> 1575923 T11019 C4390 oass.SolrIndexSearcher.<init> Opening 
Searcher@102675[collection1] main
   [junit4]   2> 1575924 T11019 C4390 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1575924 T11021 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@102675[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(6.0.0):C13)))}
   [junit4]   2> 1575925 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 8
   [junit4]   2> 1575927 T11019 C4390 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=2 
   [junit4]   2> 1575928 T11019 oas.SolrTestCaseJ4.tearDown ###Ending 
testRangeSyntax {p0=bbox}
   [junit4]   2> 1575932 T11019 oas.SolrTestCaseJ4.setUp ###Starting testSort 
{p0=stqpt_geohash}
   [junit4]   2> 1575933 T11019 C4390 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1575933 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
   [junit4]   2> 1575934 T11019 C4390 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1575935 T11019 C4390 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_f,generation=15}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_g,generation=16}
   [junit4]   2> 1575936 T11019 C4390 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 16
   [junit4]   2> 1575936 T11019 C4390 oass.SolrIndexSearcher.<init> Opening 
Searcher@c7c02[collection1] main
   [junit4]   2> 1575937 T11019 C4390 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1575937 T11021 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@c7c02[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1575938 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 4
   [junit4]   2> 1575939 T11019 C4390 
oass.AbstractSpatialPrefixTreeFieldType.newSpatialStrategy 
stqpt_geohash{class=org.apache.solr.schema.SpatialTermQueryPrefixTreeFieldType,analyzer=org.apache.solr.schema.FieldType$DefaultAnalyzer,args={distanceUnits=degrees,
 class=solr.SpatialTermQueryPrefixTreeFieldType, prefixTree=geohash}} strat: 
TermQueryPrefixTreeStrategy field:stqpt_geohash ctx=SpatialContext{geo=true, 
calculator=Haversine, 
worldBounds=Rect(minX=-180.0,maxX=180.0,minY=-90.0,maxY=90.0)} maxLevels: 11
   [junit4]   2> 1575941 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[100]} 0 2
   [junit4]   2> 1575942 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[101]} 0 1
   [junit4]   2> 1575943 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[999]} 0 1
   [junit4]   2> 1575943 T11019 C4390 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1575945 T11019 C4390 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_g,generation=16}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_h,generation=17}
   [junit4]   2> 1575946 T11019 C4390 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 17
   [junit4]   2> 1575947 T11019 C4390 oass.SolrIndexSearcher.<init> Opening 
Searcher@1109e4a[collection1] main
   [junit4]   2> 1575948 T11019 C4390 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1575948 T11021 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1109e4a[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(6.0.0):C3)))}
   [junit4]   2> 1575949 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 6
   [junit4]   2> 1576032 T11019 C4390 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q={!geofilt+sfield%3Dstqpt_geohash+++pt%3D3.0,4.0+d%3D9.0}&fl=id,score&wt=xml}
 hits=2 status=0 QTime=82 
   [junit4]   2> 1576092 T11019 C4390 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q={!+score%3Ddistance++}stqpt_geohash:"Intersects(BUFFER(POINT(4.0+3.0),9.0))"&fl=id,score&sort=score+asc&wt=xml}
 hits=2 status=0 QTime=59 
   [junit4]   2> 1576128 T11019 C4390 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q={!+score%3DrecipDistance++}stqpt_geohash:"Intersects(BUFFER(POINT(4.0+3.0),9.0))"&fl=id,score&sort=score+desc&wt=xml}
 hits=2 status=0 QTime=35 
   [junit4]   2> 1576130 T11019 C4390 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q={!geofilt+sfield%3Dstqpt_geohash+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=0 
   [junit4]   2> 1576167 T11019 C4390 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q={!+score%3Ddistance++}stqpt_geohash:"Intersects(BUFFER(POINT(0.0+4.0),9.0))"&fl=id,score&sort=score+asc&wt=xml}
 hits=2 status=0 QTime=36 
   [junit4]   2> 1576224 T11019 C4390 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=-id:999&fl=id,score&sort=query($sortQuery)+asc&wt=xml&sortQuery={!+score%3Ddistance++}stqpt_geohash:"Intersects(BUFFER(POINT(4.0+3.0),9.0))"}
 hits=2 status=0 QTime=56 
   [junit4]   2> 1576266 T11019 C4390 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=-id:999&fl=id,score&sort=query($sortQuery)+asc&wt=xml&sortQuery={!+score%3Ddistance++}stqpt_geohash:"Intersects(BUFFER(POINT(0.0+4.0),9.0))"}
 hits=2 status=0 QTime=41 
   [junit4]   2> 1576268 T11019 oas.SolrTestCaseJ4.tearDown ###Ending testSort 
{p0=stqpt_geohash}
   [junit4]   2> 1576273 T11019 oas.SolrTestCaseJ4.setUp ###Starting 
testSortMultiVal {p0=stqpt_geohash}
   [junit4]   2> 1576274 T11019 C4390 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1576274 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
   [junit4]   2> 1576276 T11019 C4390 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1576276 T11019 C4390 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_h,generation=17}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_i,generation=18}
   [junit4]   2> 1576277 T11019 C4390 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 18
   [junit4]   2> 1576278 T11019 C4390 oass.SolrIndexSearcher.<init> Opening 
Searcher@f6623b[collection1] main
   [junit4]   2> 1576278 T11021 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@f6623b[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1576279 T11019 C4390 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1576279 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 4
   [junit4]   2> 1576281 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[100]} 0 1
   [junit4]   2> 1576282 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[101]} 0 0
   [junit4]   2> 1576283 T11019 C4390 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1576285 T11019 C4390 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_i,generation=18}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_j,generation=19}
   [junit4]   2> 1576286 T11019 C4390 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 19
   [junit4]   2> 1576288 T11019 C4390 oass.SolrIndexSearcher.<init> Opening 
Searcher@a587c1[collection1] main
   [junit4]   2> 1576288 T11021 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@a587c1[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_6(6.0.0):C2)))}
   [junit4]   2> 1576289 T11019 C4390 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1576289 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 6
   [junit4]   2> 1576326 T11019 C4390 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q={!geofilt+sfield%3Dstqpt_geohash+score%3Ddistance++pt%3D3.0,4.0+d%3D9.0}&fl=id,score&sort=score+asc&wt=xml}
 hits=2 status=0 QTime=36 
   [junit4]   2> 1576327 T11019 oas.SolrTestCaseJ4.tearDown ###Ending 
testSortMultiVal {p0=stqpt_geohash}
   [junit4]   2> 1576332 T11019 oas.SolrTestCaseJ4.setUp ###Starting 
checkQueryEmptyIndex {p0=stqpt_geohash}
   [junit4]   2> 1576332 T11019 C4390 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1576333 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 1576334 T11019 C4390 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1576334 T11019 C4390 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_j,generation=19}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_k,generation=20}
   [junit4]   2> 1576335 T11019 C4390 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 20
   [junit4]   2> 1576336 T11019 C4390 oass.SolrIndexSearcher.<init> Opening 
Searcher@130bc01[collection1] main
   [junit4]   2> 1576336 T11019 C4390 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1576336 T11021 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@130bc01[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1576337 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 3
   [junit4]   2> 1576360 T11019 C4390 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dstqpt_geohash+score%3Ddistance}Intersects(BUFFER(POINT(0.0+0.0),0.8993203677616635))&rows=1000&wt=xml}
 hits=0 status=0 QTime=22 
   [junit4]   2> 1576382 T11019 C4390 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dstqpt_geohash+pt%3D'0,0'+d%3D100.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=0 status=0 QTime=14 
   [junit4]   2> 1576383 T11019 oas.SolrTestCaseJ4.tearDown ###Ending 
checkQueryEmptyIndex {p0=stqpt_geohash}
   [junit4]   2> 1576388 T11019 oas.SolrTestCaseJ4.setUp ###Starting 
testIntersectFilter {p0=stqpt_geohash}
   [junit4]   2> 1576389 T11019 C4390 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1576390 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 1576391 T11019 C4390 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1576391 T11019 C4390 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_k,generation=20}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_l,generation=21}
   [junit4]   2> 1576392 T11019 C4390 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 21
   [junit4]   2> 1576393 T11019 C4390 oass.SolrIndexSearcher.<init> Opening 
Searcher@effadb[collection1] main
   [junit4]   2> 1576393 T11019 C4390 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1576393 T11021 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@effadb[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1576394 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 3
   [junit4]   2> 1576396 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[1]} 0 1
   [junit4]   2> 1576397 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[2]} 0 1
   [junit4]   2> 1576398 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[3]} 0 1
   [junit4]   2> 1576399 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[4]} 0 1
   [junit4]   2> 1576400 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[5]} 0 1
   [junit4]   2> 1576401 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[6]} 0 1
   [junit4]   2> 1576402 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[7]} 0 1
   [junit4]   2> 1576403 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[8]} 0 1
   [junit4]   2> 1576404 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[9]} 0 1
   [junit4]   2> 1576404 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[10]} 0 0
   [junit4]   2> 1576405 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[11]} 0 0
   [junit4]   2> 1576406 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[12]} 0 0
   [junit4]   2> 1576407 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[13]} 0 0
   [junit4]   2> 1576408 T11019 C4390 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1576411 T11019 C4390 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_l,generation=21}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_m,generation=22}
   [junit4]   2> 1576412 T11019 C4390 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 22
   [junit4]   2> 1576413 T11019 C4390 oass.SolrIndexSearcher.<init> Opening 
Searcher@ca9a40[collection1] main
   [junit4]   2> 1576414 T11019 C4390 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1576414 T11021 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@ca9a40[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_7(6.0.0):C13)))}
   [junit4]   2> 1576415 T11019 C4390 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 7
   [junit4]   2> 1576422 T11019 C4390 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dstqpt_geohash+score%3Dnone}Intersects(BUFFER(POINT(1.0+1.0),1.5738106435829113))&rows=1000&wt=xml}
 hits=3 status=0 QTime=6 
   [junit4]   2> 1576432 T11019 C4390 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dstqpt_geohash+pt%3D'1,1'+d%3D175.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=3 status=0 QTime=7 
   [junit4]   2> 1576447 T11019 C4390 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dstqpt_geohash}Intersects(BUFFER(POINT(179.8+0.0),1.798640735523327))&rows=1000&wt=xml}
 hits=2 status=0 QTime=13 
   [junit4]   2> 1576460 T11019 C4390 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dstqpt_geohash+pt%3D'0,179.8'+d%3D200.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=2 status=0 QTime=11 
   [junit4]   2> 1577368 T11019 C4390 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dstqpt_geohash+score%3Ddistance}Intersects(BUFFER(POINT(50.0+89.8),1.798640735523327))&rows=1000&wt=xml}
 hits=2 status=0 QTime=906 
   [junit4]   2> 1578184 T11019 C4390 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dstqpt_geohash+pt%3D'89.8,+50'+d%3D200.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=2 status=0 QTime=815 
   [junit4]   2> ASYNC  NEW_CORE C4391 name=collection1 
org.apache.solr.core.SolrCore@ee2688
   [junit4]   2> 1579531 T11019 C4391 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dstqpt_geohash+score%3Ddistance}Intersects(BUFFER(POINT(50.0+-89.8),1.798640735523327))&rows=1000&wt=xml}
 hits=2 status=0 QTime=1345 
   [junit4]   2> 1580838 T11019 C4391 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dstqpt_geohash+pt%3D'-89.8,+50'+d%3D200.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=2 status=0 QTime=1304 
   [junit4]   2> 1580851 T11019 C4391 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dstqpt_geohash+score%3Ddistance}Intersects(BUFFER(POINT(-80.0+33.0),2.6979611032849906))&rows=1000&wt=xml}
 hits=2 status=0 QTime=11 
   [junit4]   2> 1580864 T11019 C4391 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dstqpt_geohash+pt%3D'33.0,-80.0'+d%3D300.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=2 status=0 QTime=11 
   [junit4]   2> 1580871 T11019 C4391 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dstqpt_geohash+score%3Ddistance}Intersects(BUFFER(POINT(1.0+1.0),44.96601838808318))&rows=1000&wt=xml}
 hits=3 status=0 QTime=6 
   [junit4]   2> 1580878 T11019 C4391 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dstqpt_geohash+pt%3D'1,1'+d%3D5000.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=3 status=0 QTime=5 
   [junit4]   2> 1580892 T11019 C4391 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dstqpt_geohash+score%3Ddistance}Intersects(ENVELOPE(-0.034898260626377464,+0.23489826062637748,+0.23489805516424955,+-0.03489805516424954))&rows=1000&wt=xml}
 hits=2 status=0 QTime=12 
   [junit4]   2> 1580906 T11019 C4391 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!bbox+sfield%3Dstqpt_geohash+pt%3D'0.1,0.1'+d%3D15.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=2 status=0 QTime=12 
   [junit4]   2> 1580907 T11019 C4391 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1580908 T11019 C4391 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 1580910 T11019 C4391 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[14]} 0 1
   [junit4]   2> 1580911 T11019 C4391 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[15]} 0 1
   [junit4]   2> 1580912 T11019 C4391 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[16]} 0 1
   [junit4]   2> 1580913 T11019 C4391 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[17]} 0 1
   [junit4]   2> 1580913 T11019 C4391 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1580916 T11019 C4391 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_m,generation=22}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_n,generation=23}
   [junit4]   2> 1580916 T11019 C4391 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 23
   [junit4]   2> 1580918 T11019 C4391 oass.SolrIndexSearcher.<init> Opening 
Searcher@158c1df[collection1] main
   [junit4]   2> 1580918 T11019 C4391 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1580918 T11021 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@158c1df[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_8(6.0.0):C4)))}
   [junit4]   2> 1580919 T11019 C4391 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 6
   [junit4]   2> 1580952 T11019 C4391 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dstqpt_geohash}Intersects(BUFFER(POINT(0.0+0.0),8.993203677616636))&rows=1000&wt=xml}
 hits=1 status=0 QTime=32 
   [junit4]   2> 1580985 T11019 C4391 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dstqpt_geohash+pt%3D'0,0'+d%3D1000.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=1 status=0 QTime=31 
   [junit4]   2> 1580998 T11019 C4391 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dstqpt_geohash+score%3Dnone}Intersects(BUFFER(POINT(0.0+0.0),17.986407355233272))&rows=1000&wt=xml}
 hits=2 status=0 QTime=11 
   [junit4]   2> 1581010 T11019 C4391 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dstqpt_geohash+pt%3D'0,0'+d%3D2000.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=2 status=0 QTime=11 
   [junit4]   2> 1581020 T11019 C4391 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dstqpt_geohash+score%3DrecipDistance}Intersects(ENVELOPE(-26.979611032849906,+26.979611032849906,+26.979611032849906,+-26.979611032849906))&rows=1000&wt=xml}
 hits=3 status=0 QTime=8 
   [junit4]   2> 1581030 T11019 C4391 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!bbox+sfield%3Dstqpt_geohash+pt%3D'0,0'+d%3D3000.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=3 status=0 QTime=8 
   [junit4]   2> 1581048 T11019 C4391 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dstqpt_geohash+score%3DrecipDistance}Intersects(BUFFER(POINT(0.0+0.0),26.98860423652752))&rows=1000&wt=xml}
 hits=3 status=0 QTime=16 
   [junit4]   2> 1581066 T11019 C4391 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dstqpt_geohash+pt%3D'0,0'+d%3D3001.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=3 status=0 QTime=16 
   [junit4]   2> 1581084 T11019 C4391 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dstqpt_geohash+score%3Dnone}Intersects(BUFFER(POINT(0.0+0.0),26.980510353217664))&rows=1000&wt=xml}
 hits=3 status=0 QTime=16 
   [junit4]   2> 1581102 T11019 C4391 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dstqpt_geohash+pt%3D'0,0'+d%3D3000.1+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=3 status=0 QTime=16 
   [junit4]   2> 1581126 T11019 C4391 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dstqpt_geohash+score%3DrecipDistance}Intersects(BUFFER(POINT(-96.789603+43.51703),0.9802592008602133))&rows=1000&wt=xml}
 hits=0 status=0 QTime=22 
   [junit4]   2> 1581149 T11019 C4391 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dstqpt_geohash+pt%3D'43.517030,-96.789603'+d%3D109.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=0 status=0 QTime=22 
   [junit4]   2> 1581172 T11019 C4391 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dstqpt_geohash+score%3Ddistance}Intersects(BUFFER(POINT(-96.789603+43.51703),0.9892524045378299))&rows=1000&wt=xml}
 hits=0 status=0 QTime=22 
   [junit4]   2> 1581195 T11019 C4391 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dstqpt_geohash+pt%3D'43.517030,-96.789603'+d%3D110.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=0 status=0 QTime=22 
   [junit4]   2> 1581210 T11019 C4391 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dstqpt_geohash+score%3Dnone}Intersects(ENVELOPE(-98.15383081481679,+-95.42537518518321,+44.50628240453783,+42.52777759546217))&rows=1000&wt=xml}
 hits=1 status=0 QTime=14 
   [junit4]   2> 1581225 T11019 C4391 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!bbox+sfield%3Dstqpt_geohash+pt%3D'43.517030,-96.789603'+d%3D110.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=1 status=0 QTime=13 
   [junit4]   2> 1581227 T11019 oas.SolrTestCaseJ4.tearDown ###Ending 
testIntersectFilter {p0=stqpt_geohash}
   [junit4]   2> 1581231 T11019 oas.SolrTestCaseJ4.setUp ###Starting 
testSpatialConfig {p0=stqpt_geohash}
   [junit4]   2> 1581232 T11019 C4391 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1581233 T11019 C4391 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 1581234 T11019 C4391 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1581234 T11019 C4391 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_n,generation=23}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_o,generation=24}
   [junit4]   2> 1581235 T11019 C4391 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 24
   [junit4]   2> 1581235 T11019 C4391 oass.SolrIndexSearcher.<init> Opening 
Searcher@144d592[collection1] main
   [junit4]   2> 1581236 T11019 C4391 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1581236 T11021 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@144d592[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1581237 T11019 C4391 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 4
   [junit4]   2> 1581238 T11019 oas.SolrTestCaseJ4.tearDown ###Ending 
testSpatialConfig {p0=stqpt_geohash}
   [junit4]   2> 1581242 T11019 oas.SolrTestCaseJ4.setUp ###Starting 
checkResultFormat {p0=stqpt_geohash}
   [junit4]   2> 1581242 T11019 C4391 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1581243 T11019 C4391 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 1581244 T11019 C4391 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1581244 T11019 C4391 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_o,generation=24}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_p,generation=25}
   [junit4]   2> 1581245 T11019 C4391 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 25
   [junit4]   2> 1581246 T11019 C4391 oass.SolrIndexSearcher.<init> Opening 
Searcher@13926fb[collection1] main
   [junit4]   2> 1581246 T11019 C4391 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1581246 T11021 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@13926fb[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1581247 T11019 C4391 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 3
   [junit4]   2> 1581248 T11019 C4391 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[11]} 0 0
   [junit4]   2> 1581249 T11019 C4391 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1581251 T11019 C4391 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_p,generation=25}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_q,generation=26}
   [junit4]   2> 1581251 T11019 C4391 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 26
   [junit4]   2> 1581252 T11019 C4391 oass.SolrIndexSearcher.<init> Opening 
Searcher@4ff687[collection1] main
   [junit4]   2> 1581253 T11019 C4391 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1581253 T11021 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@4ff687[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_9(6.0.0):C1)))}
   [junit4]   2> 1581254 T11019 C4391 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 5
   [junit4]   2> 1581341 T11019 C4391 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id,stqpt_geohash&fq={!bbox+sfield%3Dstqpt_geohash+pt%3D89.9,-130+d%3D9}&rows=1000&wt=xml}
 hits=1 status=0 QTime=86 
   [junit4]   2> 1581343 T11019 oas.SolrTestCaseJ4.tearDown ###Ending 
checkResultFormat {p0=stqpt_geohash}
   [junit4]   2> 1581348 T11019 oas.SolrTestCaseJ4.setUp ###Starting 
testBadShapeParse400 {p0=stqpt_geohash}
   [junit4]   2> 1581348 T11019 C4391 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1581349 T11019 C4391 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 1581350 T11019 C4391 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1581351 T11019 C4391 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_q,generation=26}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_r,generation=27}
   [junit4]   2> 1581351 T11019 C4391 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 27
   [junit4]   2> 1581352 T11019 C4391 oass.SolrIndexSearcher.<init> Opening 
Searcher@cfa999[collection1] main
   [junit4]   2> 1581352 T11019 C4391 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1581352 T11021 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@cfa999[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1581353 T11019 C4391 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 3
   [junit4]   2> 1581355 T11019 C4391 oasc.SolrException.log Ignoring exception 
matching .
   [junit4]   2> 1581356 T11019 C4391 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id,stqpt_geohash&fq={!field+f%3Dstqpt_geohash}Intersects(NonexistentShape(89.9,-130+d%3D9))&rows=1000&wt=xml}
 status=400 QTime=2 
   [junit4]   2> 1581357 T11019 C4391 oasc.SolrException.log Ignoring exception 
matching .
   [junit4]   2> 1581357 T11019 C4391 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id,stqpt_geohash&fq={!field+f%3Dstqpt_geohash}Intersects(NonexistentShape(89.9,-130+d%3D9&rows=1000&wt=xml}
 status=400 QTime=1 
   [junit4]   2> 1581358 T11019 C4391 oasc.SolrException.log Ignoring exception 
matching .
   [junit4]   2> 1581359 T11019 C4391 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id,stqpt_geohash&fq={!field+f%3Dstqpt_geohash}Intersectssss&rows=1000&wt=xml}
 status=400 QTime=1 
   [junit4]   2> 1581359 T11019 C4391 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {} 0 0
   [junit4]   2> 1581361 T11019 C4391 oasc.SolrException.log Ignoring exception 
matching NonexistentShape
   [junit4]   2> 1581361 T11019 oas.SolrTestCaseJ4.tearDown ###Ending 
testBadShapeParse400 {p0=stqpt_geohash}
   [junit4]   2> 1581365 T11019 oas.SolrTestCaseJ4.setUp ###Starting 
testBadScoreParam {p0=stqpt_geohash}
   [junit4]   2> 1581366 T11019 C4391 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1581367 T11019 C4391 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 1581367 T11019 C4391 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1581368 T11019 C4391 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_r,generation=27}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@145ae25 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ea7e41),segFN=segments_s,generation=28}
   [junit4]   2> 1581369 T11019 C4391 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 28
   [junit4]   2> 1581369 T11019 C4391 oass.SolrIndexSearcher.<init> Opening 
Searcher@7a45a1[collection1] main
   [junit4]   2> 1581370 T11019 C4391 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1581370 T11021 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@7a45a1[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1581371 T11019 C4391 oasup.LogUpda

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

All Starting to interrupt leaked threads:
   [junit4]   2>           1) Thread[id=11022, name=Thread-3973, state=WAITING, 
group=TGRP-TestSolr4Spatial]
   [junit4]   2>           2) Thread[id=11021, 
name=searcherExecutor-4338-thread-1, state=WAITING, group=TGRP-TestSolr4Spatial]
   [junit4]   2> 30386 T11018 ccr.ThreadLeakControl.tryToInterruptAll SEVERE 
There are still zombie threads that couldn't be terminated:
   [junit4]   2>           1) Thread[id=11022, name=Thread-3973, 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>           2) Thread[id=11021, 
name=searcherExecutor-4338-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> NOTE: test params are: codec=Lucene50, 
sim=RandomSimilarityProvider(queryNorm=true,coord=yes): {}, locale=fr_CH, 
timezone=Asia/Dacca
   [junit4]   2> NOTE: Linux 3.13.0-45-generic i386/Oracle Corporation 1.9.0-ea 
(32-bit)/cpus=8,threads=3,free=240933680,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [SuggesterTest, 
TestRandomDVFaceting, TestIBSimilarityFactory, TestStressLucene, 
IndexSchemaRuntimeFieldTest, BasicDistributedZkTest, 
DistributedFacetPivotLongTailTest, TestCloudPivotFacet, 
DistribJoinFromCollectionTest, TestSolrConfigHandler, DeleteReplicaTest, 
TestReplicationHandler, TestCharFilters, LeaderElectionTest, TestLFUCache, 
TestSolrXml, TestPostingsSolrHighlighter, PreAnalyzedUpdateProcessorTest, 
RemoteQueryErrorTest, TestCollapseQParserPlugin, SimpleFacetsTest, 
DocumentAnalysisRequestHandlerTest, TestDocBasedVersionConstraints, 
ScriptEngineTest, TestSweetSpotSimilarityFactory, TestBulkSchemaConcurrent, 
AnalysisAfterCoreReloadTest, BJQParserTest, TestGroupingSearch, RecoveryZkTest, 
TestDistributedMissingSort, TestDynamicLoading, DocValuesMultiTest, 
SliceStateTest, RequestHandlersTest, HdfsCollectionsAPIDistributedZkTest, 
TestSolrConfigHandlerConcurrent, SpatialHeatmapFacetsTest, 
PingRequestHandlerTest, TestCloudManagedSchema, TestHighlightDedupGrouping, 
HdfsDirectoryTest, UnloadDistributedZkTest, TestDocumentBuilder, 
TestBinaryResponseWriter, ZkCLITest, DistributedSpellCheckComponentTest, 
TestIndexSearcher, FieldAnalysisRequestHandlerTest, PrimUtilsTest, 
CursorMarkTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest, 
TestCloudManagedSchemaConcurrent, TestQueryUtils, TestExceedMaxTermLength, 
TestRawResponseWriter, TestExactStatsCache, TestReRankQParserPlugin, 
DocValuesTest, SolrIndexSplitterTest, AsyncMigrateRouteKeyTest, 
TestBM25SimilarityFactory, TestTrackingShardHandlerFactory, TestStressReorder, 
DistributedSuggestComponentTest, DistributedFacetPivotLargeTest, 
TestExactSharedStatsCache, TestMiniSolrCloudClusterSSL, 
TestSchemaVersionResource, UniqFieldsUpdateProcessorFactoryTest, 
TestSolrConfigHandlerCloud, TestMiniSolrCloudCluster, BufferStoreTest, 
PeerSyncTest, TestOrdValues, TestWordDelimiterFilterFactory, 
PreAnalyzedFieldTest, TestSolrDynamicMBean, TestCloudSchemaless, 
SimpleMLTQParserTest, TestCollationField, SOLR749Test, 
AnalysisErrorHandlingTest, TestSurroundQueryParser, 
TestComplexPhraseQParserPlugin, NumericFieldsTest, OutputWriterTest, 
InfoHandlerTest, TestFieldTypeResource, CachingDirectoryFactoryTest, 
TestArbitraryIndexDir, TestSolr4Spatial2, 
AddSchemaFieldsUpdateProcessorFactoryTest, TestRebalanceLeaders, 
BadComponentTest, HdfsRecoveryZkTest, TestXIncludeConfig, TestInitQParser, 
DefaultValueUpdateProcessorTest, DirectSolrConnectionTest, TestInitParams, 
CoreAdminRequestStatusTest, TestSort, UUIDFieldTest, TestAnalyzedSuggestions, 
HttpPartitionTest, TestOmitPositions, CircularListTest, SampleTest, 
DOMUtilTest, ActionThrottleTest, TestSerializedLuceneMatchVersion, 
TestCopyFieldCollectionResource, FullSolrCloudDistribCmdsTest, TestFaceting, 
TestHashPartitioner, HardAutoCommitTest, DistributedTermsComponentTest, 
TestRangeQuery, TestCoreContainer, TestSolr4Spatial]
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestSolr4Spatial 
-Dtests.seed=3FA4C8399F64215A -Dtests.multiplier=3 -Dtests.slow=true 
-Dtests.locale=fr_CH -Dtests.timezone=Asia/Dacca -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.00s J0 | TestSolr4Spatial (suite) <<<
   [junit4]    > Throwable #1: java.lang.RuntimeException: 
SolrCore.getOpenCount()==6
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([3FA4C8399F64215A]: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=11022, name=Thread-3973, 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]    >    2) Thread[id=11021, name=searcherExecutor-4338-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]    >        at 
__randomizedtesting.SeedInfo.seed([3FA4C8399F64215A]:0)Throwable #3: 
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie 
threads that couldn't be terminated:
   [junit4]    >    1) Thread[id=11022, name=Thread-3973, 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]    >    2) Thread[id=11021, name=searcherExecutor-4338-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]    >        at 
__randomizedtesting.SeedInfo.seed([3FA4C8399F64215A]:0)
   [junit4] Completed on J0 in 30.48s, 45 tests, 3 errors, 2 skipped <<< 
FAILURES!

[...truncated 626 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, 836 
ignored (21 assumptions)

Total time: 62 minutes 58 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