Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/4507/
Java: 64bit/jdk1.8.0_31 -XX:-UseCompressedOops -XX:+UseSerialGC

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([F26989B51F38C25E]: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:483)
        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=6326, name=Thread-2371, 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=6325, name=searcherExecutor-3225-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=6326, name=Thread-2371, 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=6325, name=searcherExecutor-3225-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([F26989B51F38C25E]: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=6326, name=Thread-2371, 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=6325, name=searcherExecutor-3225-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=6326, name=Thread-2371, 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=6325, name=searcherExecutor-3225-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([F26989B51F38C25E]:0)




Build Log:
[...truncated 9409 lines...]
   [junit4] Suite: org.apache.solr.search.TestSolr4Spatial
   [junit4]   2> Creating dataDir: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestSolr4Spatial
 F26989B51F38C25E-001\init-core-data-001
   [junit4]   2> 1315942 T6323 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl 
(false) and clientAuth (true)
   [junit4]   2> 1315942 T6323 oas.SolrTestCaseJ4.initCore ####initCore
   [junit4]   2> 1315942 T6323 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\'
   [junit4]   2> 1315945 T6323 oasc.SolrResourceLoader.replaceClassLoader 
Adding 
'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/.svn/'
 to classloader
   [junit4]   2> 1315945 T6323 oasc.SolrResourceLoader.replaceClassLoader 
Adding 
'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 1315945 T6323 oasc.SolrResourceLoader.replaceClassLoader 
Adding 
'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 1316037 T6323 oasc.SolrConfig.refreshRequestParams current 
version of requestparams : -1
   [junit4]   2> 1316038 T6323 oasc.SolrConfig.<init> Using Lucene 
MatchVersion: 6.0.0
   [junit4]   2> 1316047 T6323 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig-basic.xml
   [junit4]   2> 1316048 T6323 oass.IndexSchema.readSchema Reading Solr Schema 
from 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\schema-spatial.xml
   [junit4]   2> 1316053 T6323 oass.IndexSchema.readSchema [null] Schema 
name=test
   [junit4]   2> 1316148 T6323 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 1316148 T6323 oasc.SolrResourceLoader.locateSolrHome JNDI not 
configured for solr (NoInitialContextEx)
   [junit4]   2> 1316148 T6323 oasc.SolrResourceLoader.locateSolrHome using 
system property solr.solr.home: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr
   [junit4]   2> 1316148 T6323 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\'
   [junit4]   2> 1316180 T6323 oasc.CoreContainer.<init> New CoreContainer 
981175540
   [junit4]   2> 1316180 T6323 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\]
   [junit4]   2> 1316180 T6323 oasc.CoreContainer.load loading shared library: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\lib
   [junit4]   2> 1316180 T6323 oasc.SolrResourceLoader.addToClassLoader WARN 
Can't find (or read) directory to add to classloader: lib (resolved as: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\lib).
   [junit4]   2> 1316190 T6323 oashc.HttpShardHandlerFactory.getParameter 
Setting socketTimeout to: 600000
   [junit4]   2> 1316190 T6323 oashc.HttpShardHandlerFactory.getParameter 
Setting urlScheme to: null
   [junit4]   2> 1316190 T6323 oashc.HttpShardHandlerFactory.getParameter 
Setting connTimeout to: 60000
   [junit4]   2> 1316190 T6323 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnectionsPerHost to: 20
   [junit4]   2> 1316190 T6323 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnections to: 10000
   [junit4]   2> 1316190 T6323 oashc.HttpShardHandlerFactory.getParameter 
Setting corePoolSize to: 0
   [junit4]   2> 1316190 T6323 oashc.HttpShardHandlerFactory.getParameter 
Setting maximumPoolSize to: 2147483647
   [junit4]   2> 1316190 T6323 oashc.HttpShardHandlerFactory.getParameter 
Setting maxThreadIdleTime to: 5
   [junit4]   2> 1316190 T6323 oashc.HttpShardHandlerFactory.getParameter 
Setting sizeOfQueue to: -1
   [junit4]   2> 1316190 T6323 oashc.HttpShardHandlerFactory.getParameter 
Setting fairnessPolicy to: false
   [junit4]   2> 1316190 T6323 oashc.HttpShardHandlerFactory.getParameter 
Setting useRetries to: false
   [junit4]   2> 1316190 T6323 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=30000&connTimeout=30000&retry=true
   [junit4]   2> 1316190 T6323 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1316190 T6323 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1316193 T6323 oasc.CoreContainer.load Node Name: testNode
   [junit4]   2> 1316193 T6324 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\'
   [junit4]   2> 1316194 T6324 oasc.SolrResourceLoader.replaceClassLoader 
Adding 
'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/.svn/'
 to classloader
   [junit4]   2> 1316194 T6324 oasc.SolrResourceLoader.replaceClassLoader 
Adding 
'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 1316194 T6324 oasc.SolrResourceLoader.replaceClassLoader 
Adding 
'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 1316247 T6324 oasc.SolrConfig.refreshRequestParams current 
version of requestparams : -1
   [junit4]   2> 1316251 T6324 oasc.SolrConfig.<init> Using Lucene 
MatchVersion: 6.0.0
   [junit4]   2> 1316258 T6324 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig-basic.xml
   [junit4]   2> 1316258 T6324 oass.IndexSchema.readSchema Reading Solr Schema 
from 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\schema-spatial.xml
   [junit4]   2> 1316262 T6324 oass.IndexSchema.readSchema [collection1] Schema 
name=test
   [junit4]   2> 1316280 T6324 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 1316280 T6324 oasc.CoreContainer.create Creating SolrCore 
'collection1' using configuration from instancedir 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\
   [junit4]   2> 1316280 T6324 oasc.SolrCore.initDirectoryFactory 
org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1316280 T6324 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\,
 
dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestSolr4Spatial
 F26989B51F38C25E-001\init-core-data-001\
   [junit4]   2> 1316280 T6324 oasc.SolrCore.<init> JMX monitoring not detected 
for core: collection1
   [junit4]   2> 1316281 T6324 oasc.CachingDirectoryFactory.get return new 
directory for 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestSolr4Spatial
 F26989B51F38C25E-001\init-core-data-001\
   [junit4]   2> 1316281 T6324 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestSolr4Spatial
 F26989B51F38C25E-001\init-core-data-001\index/
   [junit4]   2> 1316282 T6324 oasc.SolrCore.initIndex WARN [collection1] Solr 
index directory 
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestSolr4Spatial
 F26989B51F38C25E-001\init-core-data-001\index' doesn't exist. Creating new 
index...
   [junit4]   2> 1316282 T6324 oasc.CachingDirectoryFactory.get return new 
directory for 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestSolr4Spatial
 F26989B51F38C25E-001\init-core-data-001\index
   [junit4]   2> 1316282 T6324 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=10, maxMergeAtOnceExplicit=18, maxMergedSegmentMB=24.7275390625, 
floorSegmentMB=0.369140625, forceMergeDeletesPctAllowed=0.3550239353087792, 
segmentsPerTier=50.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1316283 T6324 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_1,generation=1}
   [junit4]   2> 1316283 T6324 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 1316285 T6324 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1316286 T6324 oasc.RequestHandlers.initHandlersFromConfig 
created /update: solr.UpdateRequestHandler
   [junit4]   2> 1316286 T6324 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 1316286 T6324 oasc.RequestHandlers.initHandlersFromConfig 
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 1316286 T6324 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 1316286 T6324 oasc.RequestHandlers.initHandlersFromConfig 
created /config: org.apache.solr.handler.SolrConfigHandler
   [junit4]   2> 1316286 T6324 oasc.RequestHandlers.initHandlersFromConfig 
created /schema: org.apache.solr.handler.SchemaHandler
   [junit4]   2> 1316286 T6324 oasc.RequestHandlers.initHandlersFromConfig 
created /replication: org.apache.solr.handler.ReplicationHandler
   [junit4]   2> 1316286 T6324 oasc.RequestHandlers.initHandlersFromConfig 
created /get: org.apache.solr.handler.RealTimeGetHandler
   [junit4]   2> 1316286 T6324 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
   [junit4]   2> 1316288 T6324 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
   [junit4]   2> 1316290 T6324 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
   [junit4]   2> 1316291 T6324 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
   [junit4]   2> 1316291 T6324 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
   [junit4]   2> 1316291 T6324 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/properties: 
org.apache.solr.handler.admin.PropertiesRequestHandler
   [junit4]   2> 1316292 T6324 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
   [junit4]   2> 1316292 T6324 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/file: org.apache.solr.handler.admin.ShowFileRequestHandler
   [junit4]   2> 1316292 T6324 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/ping: org.apache.solr.handler.PingRequestHandler
   [junit4]   2> 1316292 T6324 oasc.RequestHandlers.initHandlersFromConfig 
created standard: solr.StandardRequestHandler
   [junit4]   2> 1316299 T6324 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1316300 T6324 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1316301 T6324 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1316302 T6324 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1316303 T6324 oasc.SolrCore.initStatsCache Using default 
statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1316303 T6324 oasu.CommitTracker.<init> Hard AutoCommit: 
disabled
   [junit4]   2> 1316303 T6324 oasu.CommitTracker.<init> Soft AutoCommit: 
disabled
   [junit4]   2> 1316303 T6324 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=44, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 1316303 T6324 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_1,generation=1}
   [junit4]   2> 1316303 T6324 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 1316303 T6324 oass.SolrIndexSearcher.<init> Opening 
Searcher@640dae8b[collection1] main
   [junit4]   2> 1316304 T6324 oasr.ManagedResourceStorage.newStorageIO WARN 
Cannot write to config directory 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf;
 switching to use InMemory storage instead.
   [junit4]   2> 1316304 T6324 oasr.RestManager.init Initializing RestManager 
with initArgs: {}
   [junit4]   2> 1316310 T6324 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using InMemoryStorage
   [junit4]   2> 1316310 T6324 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 1316310 T6324 oash.ReplicationHandler.inform Commits will be 
reserved for  10000
   [junit4]   2> 1316310 T6325 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@640dae8b[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1316310 T6324 oasc.CoreContainer.registerCore registering 
core: collection1
   [junit4]   2> 1316311 T6323 oas.SolrTestCaseJ4.initCore ####initCore end
   [junit4]   2> 1316333 T6323 oas.SolrTestCaseJ4.setUp ###Starting testSort 
{p0=bbox}
   [junit4]   2> ASYNC  NEW_CORE C1682 name=collection1 
org.apache.solr.core.SolrCore@201807df
   [junit4]   2> 1316334 T6323 C1682 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1316334 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 1316336 T6323 C1682 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1316339 T6323 C1682 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_1,generation=1}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_2,generation=2}
   [junit4]   2> 1316340 T6323 C1682 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 2
   [junit4]   2> 1316342 T6323 C1682 oass.SolrIndexSearcher.<init> Opening 
Searcher@244cee22[collection1] main
   [junit4]   2> 1316342 T6323 C1682 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1316343 T6325 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@244cee22[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1316343 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 7
   [junit4]   2> 1316361 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[100]} 0 18
   [junit4]   2> 1316361 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[101]} 0 0
   [junit4]   2> 1316361 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[999]} 0 0
   [junit4]   2> 1316361 T6323 C1682 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1316366 T6323 C1682 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_2,generation=2}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_3,generation=3}
   [junit4]   2> 1316366 T6323 C1682 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 3
   [junit4]   2> 1316366 T6323 C1682 oass.SolrIndexSearcher.<init> Opening 
Searcher@216de277[collection1] main
   [junit4]   2> 1316367 T6323 C1682 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1316370 T6325 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@216de277[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c3)))}
   [junit4]   2> 1316370 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 9
   [junit4]   2> 1316384 T6323 C1682 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=14 
   [junit4]   2> 1316391 T6323 C1682 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=7 
   [junit4]   2> 1316403 T6323 C1682 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=6 
   [junit4]   2> 1316403 T6323 C1682 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> 1316418 T6323 C1682 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=14 
   [junit4]   2> 1316434 T6323 C1682 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=0 
   [junit4]   2> 1316450 T6323 C1682 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=16 
   [junit4]   2> 1316450 T6323 oas.SolrTestCaseJ4.tearDown ###Ending testSort 
{p0=bbox}
   [junit4]   2> 1316456 T6323 oas.SolrTestCaseJ4.setUp ###Starting 
testSortMultiVal {p0=bbox}
   [junit4]   2> 1316456 T6323 C1682 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1316456 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
   [junit4]   2> 1316456 T6323 C1682 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1316458 T6323 C1682 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_3,generation=3}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_4,generation=4}
   [junit4]   2> 1316458 T6323 C1682 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 4
   [junit4]   2> 1316458 T6323 C1682 oass.SolrIndexSearcher.<init> Opening 
Searcher@2b6df63a[collection1] main
   [junit4]   2> 1316458 T6323 C1682 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1316459 T6325 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@2b6df63a[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1316459 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 3
   [junit4]   2> 1316459 T6323 oas.SolrTestCaseJ4.tearDown ###Ending 
testSortMultiVal {p0=bbox}
   [junit4] IGNOR/A 0.03s | TestSolr4Spatial.testSortMultiVal {p0=bbox}
   [junit4]    > Assumption #1: Multivalue not supported for this field
   [junit4]   2> 1316482 T6323 oas.SolrTestCaseJ4.setUp ###Starting 
testBadShapeParse400 {p0=bbox}
   [junit4]   2> 1316483 T6323 C1682 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1316483 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 1316483 T6323 C1682 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1316483 T6323 C1682 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_4,generation=4}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_5,generation=5}
   [junit4]   2> 1316483 T6323 C1682 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 5
   [junit4]   2> 1316483 T6323 C1682 oass.SolrIndexSearcher.<init> Opening 
Searcher@4354e89a[collection1] main
   [junit4]   2> 1316484 T6323 C1682 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1316485 T6325 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@4354e89a[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1316485 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 2
   [junit4]   2> 1316486 T6323 C1682 oasc.SolrException.log Ignoring exception 
matching .
   [junit4]   2> 1316486 T6323 C1682 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> 1316488 T6323 C1682 oasc.SolrException.log Ignoring exception 
matching .
   [junit4]   2> 1316488 T6323 C1682 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=2 
   [junit4]   2> 1316488 T6323 C1682 oasc.SolrException.log Ignoring exception 
matching .
   [junit4]   2> 1316489 T6323 C1682 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> 1316490 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {} 0 0
   [junit4]   2> 1316490 T6323 C1682 oasc.SolrException.log Ignoring exception 
matching NonexistentShape
   [junit4]   2> 1316491 T6323 oas.SolrTestCaseJ4.tearDown ###Ending 
testBadShapeParse400 {p0=bbox}
   [junit4]   2> 1316498 T6323 oas.SolrTestCaseJ4.setUp ###Starting 
testIntersectFilter {p0=bbox}
   [junit4]   2> 1316498 T6323 C1682 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1316498 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
   [junit4]   2> 1316498 T6323 C1682 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1316498 T6323 C1682 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_5,generation=5}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_6,generation=6}
   [junit4]   2> 1316498 T6323 C1682 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 6
   [junit4]   2> 1316498 T6323 C1682 oass.SolrIndexSearcher.<init> Opening 
Searcher@3c4d1b63[collection1] main
   [junit4]   2> 1316498 T6323 C1682 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1316499 T6325 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@3c4d1b63[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1316499 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 1
   [junit4]   2> 1316499 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[1]} 0 0
   [junit4]   2> 1316505 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[2]} 0 0
   [junit4]   2> 1316506 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[3]} 0 0
   [junit4]   2> 1316508 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[4]} 0 2
   [junit4]   2> 1316508 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[5]} 0 0
   [junit4]   2> 1316508 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[6]} 0 0
   [junit4]   2> 1316509 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[7]} 0 0
   [junit4]   2> 1316510 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[8]} 0 0
   [junit4]   2> 1316511 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[9]} 0 0
   [junit4]   2> 1316511 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[10]} 0 0
   [junit4]   2> 1316511 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[11]} 0 0
   [junit4]   2> 1316513 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[12]} 0 0
   [junit4]   2> 1316513 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[13]} 0 0
   [junit4]   2> 1316514 T6323 C1682 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1316521 T6323 C1682 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_6,generation=6}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_7,generation=7}
   [junit4]   2> 1316521 T6323 C1682 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 7
   [junit4]   2> 1316522 T6323 C1682 oass.SolrIndexSearcher.<init> Opening 
Searcher@52187b56[collection1] main
   [junit4]   2> 1316522 T6323 C1682 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1316522 T6325 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@52187b56[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.0.0):c13)))}
   [junit4]   2> 1316525 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 11
   [junit4]   2> 1316528 T6323 C1682 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dbbox+score%3Ddistance}Intersects(ENVELOPE(-0.034898260626377464,+0.23489826062637748,+0.23489805516424955,+-0.03489805516424954))&rows=1000&wt=xml}
 hits=2 status=0 QTime=3 
   [junit4]   2> 1316532 T6323 C1682 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=3 
   [junit4]   2> 1316532 T6323 C1682 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1316532 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
   [junit4]   2> 1316533 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[14]} 0 0
   [junit4]   2> 1316533 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[15]} 0 0
   [junit4]   2> 1316534 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[16]} 0 0
   [junit4]   2> 1316534 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[17]} 0 0
   [junit4]   2> 1316536 T6323 C1682 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1316539 T6323 C1682 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_7,generation=7}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_8,generation=8}
   [junit4]   2> 1316540 T6323 C1682 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 8
   [junit4]   2> 1316542 T6323 C1682 oass.SolrIndexSearcher.<init> Opening 
Searcher@5c5119fd[collection1] main
   [junit4]   2> 1316542 T6323 C1682 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1316542 T6325 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@5c5119fd[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(6.0.0):c4)))}
   [junit4]   2> 1316543 T6323 C1682 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 7
   [junit4]   2> 1316543 T6323 C1682 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=0 
   [junit4]   2> 1316545 T6323 C1682 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!bbox+sfield%3Dbbox+pt%3D'0,0'+d%3D3000.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=3 status=0 QTime=1 
   [junit4]   2> 1316547 T6323 C1682 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dbbox+score%3Dnone}Intersects(ENVELOPE(-98.15383081481679,+-95.42537518518321,+44.50628240453783,+42.52777759546217))&rows=1000&wt=xml}
 hits=1 status=0 QTime=2 
   [junit4]   2> 1316548 T6323 C1682 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!bbox+sfield%3Dbbox+pt%3D'43.517030,-96.789603'+d%3D110.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=1 status=0 QTime=1 
   [junit4]   2> 1316548 T6323 oas.SolrTestCaseJ4.tearDown ###Ending 
testIntersectFilter {p0=bbox}
   [junit4]   2> 1316568 T6323 oas.SolrTestCaseJ4.setUp ###Starting 
testRangeSyntax {p0=bbox}
   [junit4]   2> ASYNC  NEW_CORE C1683 name=collection1 
org.apache.solr.core.SolrCore@201807df
   [junit4]   2> 1316568 T6323 C1683 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1316570 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 2
   [junit4]   2> 1316570 T6323 C1683 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1316570 T6323 C1683 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_8,generation=8}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_9,generation=9}
   [junit4]   2> 1316570 T6323 C1683 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 9
   [junit4]   2> 1316570 T6323 C1683 oass.SolrIndexSearcher.<init> Opening 
Searcher@3b637aed[collection1] main
   [junit4]   2> 1316571 T6323 C1683 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1316572 T6325 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@3b637aed[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1316573 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 3
   [junit4]   2> 1316573 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[1]} 0 0
   [junit4]   2> 1316574 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[2]} 0 0
   [junit4]   2> 1316574 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[3]} 0 0
   [junit4]   2> 1316574 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[4]} 0 0
   [junit4]   2> 1316575 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[5]} 0 0
   [junit4]   2> 1316575 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[6]} 0 0
   [junit4]   2> 1316575 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[7]} 0 0
   [junit4]   2> 1316576 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[8]} 0 0
   [junit4]   2> 1316577 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[9]} 0 1
   [junit4]   2> 1316578 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[10]} 0 0
   [junit4]   2> 1316578 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[11]} 0 0
   [junit4]   2> 1316578 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[12]} 0 0
   [junit4]   2> 1316579 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[13]} 0 1
   [junit4]   2> 1316579 T6323 C1683 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1316584 T6323 C1683 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_9,generation=9}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_a,generation=10}
   [junit4]   2> 1316586 T6323 C1683 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 10
   [junit4]   2> 1316588 T6323 C1683 oass.SolrIndexSearcher.<init> Opening 
Searcher@4092b555[collection1] main
   [junit4]   2> 1316588 T6323 C1683 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1316588 T6325 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@4092b555[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(6.0.0):c13)))}
   [junit4]   2> 1316588 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 9
   [junit4]   2> 1316590 T6323 C1683 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=1 
   [junit4]   2> 1316590 T6323 oas.SolrTestCaseJ4.tearDown ###Ending 
testRangeSyntax {p0=bbox}
   [junit4]   2> 1316601 T6323 oas.SolrTestCaseJ4.setUp ###Starting 
checkResultFormat {p0=bbox}
   [junit4]   2> 1316602 T6323 C1683 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1316602 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 1316603 T6323 C1683 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1316603 T6323 C1683 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_a,generation=10}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_b,generation=11}
   [junit4]   2> 1316603 T6323 C1683 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 11
   [junit4]   2> 1316603 T6323 C1683 oass.SolrIndexSearcher.<init> Opening 
Searcher@6c977916[collection1] main
   [junit4]   2> 1316603 T6325 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@6c977916[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1316603 T6323 C1683 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1316603 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 0
   [junit4]   2> 1316603 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[11]} 0 0
   [junit4]   2> 1316604 T6323 C1683 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1316608 T6323 C1683 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_b,generation=11}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_c,generation=12}
   [junit4]   2> 1316608 T6323 C1683 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 12
   [junit4]   2> 1316610 T6323 C1683 oass.SolrIndexSearcher.<init> Opening 
Searcher@21eae312[collection1] main
   [junit4]   2> 1316610 T6325 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@21eae312[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(6.0.0):c1)))}
   [junit4]   2> 1316611 T6323 C1683 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1316611 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 7
   [junit4]   2> 1316612 T6323 C1683 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> 1316612 T6323 oas.SolrTestCaseJ4.tearDown ###Ending 
checkResultFormat {p0=bbox}
   [junit4]   2> 1316618 T6323 oas.SolrTestCaseJ4.setUp ###Starting 
testSpatialConfig {p0=bbox}
   [junit4]   2> 1316618 T6323 C1683 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1316618 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
   [junit4]   2> 1316618 T6323 C1683 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1316619 T6323 C1683 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_c,generation=12}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_d,generation=13}
   [junit4]   2> 1316619 T6323 C1683 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 13
   [junit4]   2> 1316619 T6323 C1683 oass.SolrIndexSearcher.<init> Opening 
Searcher@5914da60[collection1] main
   [junit4]   2> 1316620 T6325 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@5914da60[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1316620 T6323 C1683 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1316620 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 2
   [junit4]   2> 1316620 T6323 oas.SolrTestCaseJ4.tearDown ###Ending 
testSpatialConfig {p0=bbox}
   [junit4]   2> 1316626 T6323 oas.SolrTestCaseJ4.setUp ###Starting 
checkQueryEmptyIndex {p0=bbox}
   [junit4]   2> 1316627 T6323 C1683 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1316627 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 1316627 T6323 C1683 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1316643 T6323 C1683 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_d,generation=13}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_e,generation=14}
   [junit4]   2> 1316643 T6323 C1683 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 14
   [junit4]   2> 1316644 T6323 C1683 oass.SolrIndexSearcher.<init> Opening 
Searcher@1565ee80[collection1] main
   [junit4]   2> 1316644 T6325 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1565ee80[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1316644 T6323 C1683 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1316644 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 17
   [junit4]   2> 1316645 T6323 oas.SolrTestCaseJ4.tearDown ###Ending 
checkQueryEmptyIndex {p0=bbox}
   [junit4]   2> 1316649 T6323 oas.SolrTestCaseJ4.setUp ###Starting 
testBadScoreParam {p0=bbox}
   [junit4]   2> 1316649 T6323 C1683 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1316649 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
   [junit4]   2> 1316650 T6323 C1683 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1316650 T6323 C1683 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_e,generation=14}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_f,generation=15}
   [junit4]   2> 1316650 T6323 C1683 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 15
   [junit4]   2> 1316650 T6323 C1683 oass.SolrIndexSearcher.<init> Opening 
Searcher@a6298f4[collection1] main
   [junit4]   2> 1316650 T6325 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@a6298f4[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1316652 T6323 C1683 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1316652 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 2
   [junit4]   2> 1316652 T6323 C1683 oasc.SolrException.log Ignoring exception 
matching .
   [junit4]   2> 1316652 T6323 C1683 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q={!bbox+sfield%3Dbbox+score%3Dbogus+filter%3Dfalse+pt%3D0.0,0.0+d%3D0.0}&qt=standard&start=0&rows=20&version=2.2}
 status=400 QTime=0 
   [junit4]   2> 1316654 T6323 oas.SolrTestCaseJ4.tearDown ###Ending 
testBadScoreParam {p0=bbox}
   [junit4]   2> 1316656 T6323 oas.SolrTestCaseJ4.setUp ###Starting testSort 
{p0=pointvector}
   [junit4]   2> 1316656 T6323 C1683 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1316656 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
   [junit4]   2> 1316658 T6323 C1683 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1316658 T6323 C1683 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_f,generation=15}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_g,generation=16}
   [junit4]   2> 1316658 T6323 C1683 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 16
   [junit4]   2> 1316659 T6323 C1683 oass.SolrIndexSearcher.<init> Opening 
Searcher@61a0ad27[collection1] main
   [junit4]   2> 1316659 T6325 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@61a0ad27[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1316659 T6323 C1683 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1316659 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 1
   [junit4]   2> 1316670 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[100]} 0 11
   [junit4]   2> 1316671 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[101]} 0 1
   [junit4]   2> 1316671 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[999]} 0 0
   [junit4]   2> 1316671 T6323 C1683 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1316671 T6323 C1683 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_g,generation=16}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_h,generation=17}
   [junit4]   2> 1316671 T6323 C1683 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 17
   [junit4]   2> 1316673 T6323 C1683 oass.SolrIndexSearcher.<init> Opening 
Searcher@34e1350e[collection1] main
   [junit4]   2> 1316673 T6325 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@34e1350e[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(6.0.0):c3)))}
   [junit4]   2> 1316673 T6323 C1683 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1316673 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 2
   [junit4]   2> 1316686 T6323 C1683 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q={!+++}pointvector:"Intersects(BUFFER(POINT(4.0+3.0),9.0))"&fl=id,score&wt=xml}
 hits=2 status=0 QTime=12 
   [junit4]   2> 1316689 T6323 C1683 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q={!+score%3Ddistance++}pointvector:"Intersects(BUFFER(POINT(4.0+3.0),9.0))"&fl=id,score&sort=score+asc&wt=xml}
 hits=2 status=0 QTime=3 
   [junit4]   2> 1316694 T6323 C1683 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q={!geofilt+sfield%3Dpointvector+score%3DrecipDistance++pt%3D3.0,4.0+d%3D9.0}&fl=id,score&sort=score+desc&wt=xml}
 hits=2 status=0 QTime=4 
   [junit4]   2> 1316694 T6323 C1683 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q={!geofilt+sfield%3Dpointvector+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> 1316696 T6323 C1683 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q={!geofilt+sfield%3Dpointvector+score%3Ddistance++pt%3D4.0,0.0+d%3D9.0}&fl=id,score&sort=score+asc&wt=xml}
 hits=2 status=0 QTime=2 
   [junit4]   2> 1316712 T6323 C1683 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=-id:999&fl=id,score&sort=query($sortQuery)+asc&wt=xml&sortQuery={!geofilt+sfield%3Dpointvector+score%3Ddistance++pt%3D3.0,4.0+d%3D9.0}}
 hits=2 status=0 QTime=11 
   [junit4]   2> 1316713 T6323 C1683 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=-id:999&fl=id,score&sort=query($sortQuery)+asc&wt=xml&sortQuery={!geofilt+sfield%3Dpointvector+score%3Ddistance++pt%3D4.0,0.0+d%3D9.0}}
 hits=2 status=0 QTime=1 
   [junit4]   2> 1316713 T6323 oas.SolrTestCaseJ4.tearDown ###Ending testSort 
{p0=pointvector}
   [junit4]   2> 1316719 T6323 oas.SolrTestCaseJ4.setUp ###Starting 
testSortMultiVal {p0=pointvector}
   [junit4]   2> 1316719 T6323 C1683 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1316719 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
   [junit4]   2> 1316721 T6323 C1683 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1316721 T6323 C1683 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_h,generation=17}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_i,generation=18}
   [junit4]   2> 1316721 T6323 C1683 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 18
   [junit4]   2> 1316723 T6323 C1683 oass.SolrIndexSearcher.<init> Opening 
Searcher@1a653f87[collection1] main
   [junit4]   2> 1316723 T6323 C1683 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1316723 T6325 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1a653f87[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1316723 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 2
   [junit4]   2> 1316724 T6323 oas.SolrTestCaseJ4.tearDown ###Ending 
testSortMultiVal {p0=pointvector}
   [junit4] IGNOR/A 0.01s | TestSolr4Spatial.testSortMultiVal {p0=pointvector}
   [junit4]    > Assumption #1: Multivalue not supported for this field
   [junit4]   2> 1316731 T6323 oas.SolrTestCaseJ4.setUp ###Starting 
testBadShapeParse400 {p0=pointvector}
   [junit4]   2> 1316731 T6323 C1683 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1316731 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
   [junit4]   2> 1316733 T6323 C1683 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1316734 T6323 C1683 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_i,generation=18}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_j,generation=19}
   [junit4]   2> 1316734 T6323 C1683 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 19
   [junit4]   2> 1316735 T6323 C1683 oass.SolrIndexSearcher.<init> Opening 
Searcher@1301ebf3[collection1] main
   [junit4]   2> 1316735 T6323 C1683 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1316736 T6325 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1301ebf3[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1316736 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 4
   [junit4]   2> 1316737 T6323 C1683 oasc.SolrException.log Ignoring exception 
matching .
   [junit4]   2> 1316738 T6323 C1683 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id,pointvector&fq={!field+f%3Dpointvector}Intersects(NonexistentShape(89.9,-130+d%3D9))&rows=1000&wt=xml}
 status=400 QTime=2 
   [junit4]   2> 1316739 T6323 C1683 oasc.SolrException.log Ignoring exception 
matching .
   [junit4]   2> 1316739 T6323 C1683 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id,pointvector&fq={!field+f%3Dpointvector}Intersects(NonexistentShape(89.9,-130+d%3D9&rows=1000&wt=xml}
 status=400 QTime=1 
   [junit4]   2> 1316739 T6323 C1683 oasc.SolrException.log Ignoring exception 
matching .
   [junit4]   2> 1316740 T6323 C1683 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id,pointvector&fq={!field+f%3Dpointvector}Intersectssss&rows=1000&wt=xml}
 status=400 QTime=1 
   [junit4]   2> 1316740 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {} 0 0
   [junit4]   2> 1316742 T6323 C1683 oasc.SolrException.log Ignoring exception 
matching NonexistentShape
   [junit4]   2> 1316743 T6323 oas.SolrTestCaseJ4.tearDown ###Ending 
testBadShapeParse400 {p0=pointvector}
   [junit4]   2> 1316751 T6323 oas.SolrTestCaseJ4.setUp ###Starting 
testIntersectFilter {p0=pointvector}
   [junit4]   2> 1316752 T6323 C1683 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1316752 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 1316754 T6323 C1683 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1316754 T6323 C1683 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_j,generation=19}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_k,generation=20}
   [junit4]   2> 1316754 T6323 C1683 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 20
   [junit4]   2> 1316754 T6323 C1683 oass.SolrIndexSearcher.<init> Opening 
Searcher@1c0f821e[collection1] main
   [junit4]   2> 1316754 T6323 C1683 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1316755 T6325 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1c0f821e[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1316756 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 3
   [junit4]   2> 1316757 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[1]} 0 1
   [junit4]   2> 1316758 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[2]} 0 0
   [junit4]   2> 1316759 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[3]} 0 1
   [junit4]   2> 1316759 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[4]} 0 0
   [junit4]   2> 1316760 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[5]} 0 0
   [junit4]   2> 1316761 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[6]} 0 1
   [junit4]   2> 1316761 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[7]} 0 0
   [junit4]   2> 1316761 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[8]} 0 0
   [junit4]   2> 1316762 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[9]} 0 0
   [junit4]   2> 1316763 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[10]} 0 0
   [junit4]   2> 1316764 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[11]} 0 0
   [junit4]   2> 1316765 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[12]} 0 0
   [junit4]   2> 1316766 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[13]} 0 1
   [junit4]   2> 1316766 T6323 C1683 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1316770 T6323 C1683 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_k,generation=20}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_l,generation=21}
   [junit4]   2> 1316771 T6323 C1683 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 21
   [junit4]   2> 1316772 T6323 C1683 oass.SolrIndexSearcher.<init> Opening 
Searcher@1fd41bcb[collection1] main
   [junit4]   2> 1316772 T6323 C1683 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1316774 T6325 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1fd41bcb[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_6(6.0.0):c13)))}
   [junit4]   2> 1316775 T6323 C1683 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 9
   [junit4]   2> 1316776 T6323 C1683 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dpointvector+score%3Ddistance}Intersects(BUFFER(POINT(1.0+1.0),1.5738106435829113))&rows=1000&wt=xml}
 hits=3 status=0 QTime=1 
   [junit4]   2> 1316778 T6323 C1683 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dpointvector+pt%3D'1,1'+d%3D175.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=3 status=0 QTime=2 
   [junit4]   2> 1316780 T6323 C1683 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dpointvector}Intersects(BUFFER(POINT(179.8+0.0),1.798640735523327))&rows=1000&wt=xml}
 hits=2 status=0 QTime=2 
   [junit4]   2> 1316782 T6323 C1683 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dpointvector+pt%3D'0,179.8'+d%3D200.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=2 status=0 QTime=1 
   [junit4]   2> 1316784 T6323 C1683 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dpointvector+score%3Dnone}Intersects(BUFFER(POINT(50.0+89.8),1.798640735523327))&rows=1000&wt=xml}
 hits=2 status=0 QTime=2 
   [junit4]   2> 1316784 T6323 C1683 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dpointvector+pt%3D'89.8,+50'+d%3D200.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=2 status=0 QTime=0 
   [junit4]   2> 1316786 T6323 C1683 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dpointvector}Intersects(BUFFER(POINT(50.0+-89.8),1.798640735523327))&rows=1000&wt=xml}
 hits=2 status=0 QTime=2 
   [junit4]   2> 1316788 T6323 C1683 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dpointvector+pt%3D'-89.8,+50'+d%3D200.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=2 status=0 QTime=1 
   [junit4]   2> 1316789 T6323 C1683 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dpointvector}Intersects(BUFFER(POINT(-80.0+33.0),2.6979611032849906))&rows=1000&wt=xml}
 hits=2 status=0 QTime=1 
   [junit4]   2> 1316791 T6323 C1683 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dpointvector+pt%3D'33.0,-80.0'+d%3D300.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=2 status=0 QTime=2 
   [junit4]   2> 1316791 T6323 C1683 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dpointvector+score%3DrecipDistance}Intersects(BUFFER(POINT(1.0+1.0),44.96601838808318))&rows=1000&wt=xml}
 hits=3 status=0 QTime=0 
   [junit4]   2> 1316793 T6323 C1683 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dpointvector+pt%3D'1,1'+d%3D5000.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=3 status=0 QTime=2 
   [junit4]   2> ASYNC  NEW_CORE C1684 name=collection1 
org.apache.solr.core.SolrCore@201807df
   [junit4]   2> 1316848 T6323 C1684 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dpointvector+score%3DrecipDistance}Intersects(ENVELOPE(-0.034898260626377464,+0.23489826062637748,+0.23489805516424955,+-0.03489805516424954))&rows=1000&wt=xml}
 hits=2 status=0 QTime=2 
   [junit4]   2> 1316849 T6323 C1684 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!bbox+sfield%3Dpointvector+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> 1316851 T6323 C1684 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1316851 T6323 C1684 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
   [junit4]   2> 1316851 T6323 C1684 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[14]} 0 0
   [junit4]   2> 1316851 T6323 C1684 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[15]} 0 0
   [junit4]   2> 1316852 T6323 C1684 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[16]} 0 0
   [junit4]   2> 1316852 T6323 C1684 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[17]} 0 0
   [junit4]   2> 1316852 T6323 C1684 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1316854 T6323 C1684 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_l,generation=21}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_m,generation=22}
   [junit4]   2> 1316854 T6323 C1684 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 22
   [junit4]   2> 1316854 T6323 C1684 oass.SolrIndexSearcher.<init> Opening 
Searcher@521ac4d1[collection1] main
   [junit4]   2> 1316856 T6323 C1684 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1316856 T6325 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@521ac4d1[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_7(6.0.0):c4)))}
   [junit4]   2> 1316857 T6323 C1684 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 5
   [junit4]   2> 1316859 T6323 C1684 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dpointvector+score%3Ddistance}Intersects(BUFFER(POINT(0.0+0.0),8.993203677616636))&rows=1000&wt=xml}
 hits=1 status=0 QTime=1 
   [junit4]   2> 1316859 T6323 C1684 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dpointvector+pt%3D'0,0'+d%3D1000.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=1 status=0 QTime=0 
   [junit4]   2> 1316859 T6323 C1684 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dpointvector+score%3DrecipDistance}Intersects(BUFFER(POINT(0.0+0.0),17.986407355233272))&rows=1000&wt=xml}
 hits=2 status=0 QTime=0 
   [junit4]   2> 1316860 T6323 C1684 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dpointvector+pt%3D'0,0'+d%3D2000.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=2 status=0 QTime=0 
   [junit4]   2> 1316860 T6323 C1684 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dpointvector}Intersects(ENVELOPE(-26.979611032849906,+26.979611032849906,+26.979611032849906,+-26.979611032849906))&rows=1000&wt=xml}
 hits=3 status=0 QTime=0 
   [junit4]   2> 1316861 T6323 C1684 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!bbox+sfield%3Dpointvector+pt%3D'0,0'+d%3D3000.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=3 status=0 QTime=0 
   [junit4]   2> 1316864 T6323 C1684 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dpointvector+score%3DrecipDistance}Intersects(BUFFER(POINT(0.0+0.0),26.98860423652752))&rows=1000&wt=xml}
 hits=3 status=0 QTime=1 
   [junit4]   2> 1316864 T6323 C1684 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dpointvector+pt%3D'0,0'+d%3D3001.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=3 status=0 QTime=0 
   [junit4]   2> 1316864 T6323 C1684 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dpointvector+score%3Ddistance}Intersects(BUFFER(POINT(0.0+0.0),26.980510353217664))&rows=1000&wt=xml}
 hits=3 status=0 QTime=0 
   [junit4]   2> 1316865 T6323 C1684 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dpointvector+pt%3D'0,0'+d%3D3000.1+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=3 status=0 QTime=0 
   [junit4]   2> 1316866 T6323 C1684 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dpointvector+score%3Dnone}Intersects(BUFFER(POINT(-96.789603+43.51703),0.9802592008602133))&rows=1000&wt=xml}
 hits=0 status=0 QTime=0 
   [junit4]   2> 1316867 T6323 C1684 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dpointvector+pt%3D'43.517030,-96.789603'+d%3D109.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=0 status=0 QTime=0 
   [junit4]   2> 1316868 T6323 C1684 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dpointvector}Intersects(BUFFER(POINT(-96.789603+43.51703),0.9892524045378299))&rows=1000&wt=xml}
 hits=0 status=0 QTime=1 
   [junit4]   2> 1316868 T6323 C1684 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!geofilt+sfield%3Dpointvector+pt%3D'43.517030,-96.789603'+d%3D110.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=0 status=0 QTime=0 
   [junit4]   2> 1316870 T6323 C1684 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!field+f%3Dpointvector+score%3Ddistance}Intersects(ENVELOPE(-98.15383081481679,+-95.42537518518321,+44.50628240453783,+42.52777759546217))&rows=1000&wt=xml}
 hits=1 status=0 QTime=0 
   [junit4]   2> 1316872 T6323 C1684 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!bbox+sfield%3Dpointvector+pt%3D'43.517030,-96.789603'+d%3D110.0+sphere_radius%3D6371.0087714}&rows=1000&wt=xml}
 hits=1 status=0 QTime=2 
   [junit4]   2> 1316872 T6323 oas.SolrTestCaseJ4.tearDown ###Ending 
testIntersectFilter {p0=pointvector}
   [junit4]   2> 1316879 T6323 oas.SolrTestCaseJ4.setUp ###Starting 
testRangeSyntax {p0=pointvector}
   [junit4]   2> 1316879 T6323 C1684 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1316879 T6323 C1684 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
   [junit4]   2> 1316880 T6323 C1684 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1316880 T6323 C1684 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_m,generation=22}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_n,generation=23}
   [junit4]   2> 1316880 T6323 C1684 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 23
   [junit4]   2> 1316880 T6323 C1684 oass.SolrIndexSearcher.<init> Opening 
Searcher@1a1e6a18[collection1] main
   [junit4]   2> 1316880 T6323 C1684 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1316881 T6325 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1a1e6a18[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1316881 T6323 C1684 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 1
   [junit4]   2> 1316881 T6323 C1684 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[1]} 0 0
   [junit4]   2> 1316881 T6323 C1684 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[2]} 0 0
   [junit4]   2> 1316882 T6323 C1684 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[3]} 0 0
   [junit4]   2> 1316883 T6323 C1684 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[4]} 0 0
   [junit4]   2> 1316883 T6323 C1684 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[5]} 0 0
   [junit4]   2> 1316883 T6323 C1684 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[6]} 0 0
   [junit4]   2> 1316883 T6323 C1684 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[7]} 0 0
   [junit4]   2> 1316883 T6323 C1684 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[8]} 0 0
   [junit4]   2> 1316885 T6323 C1684 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[9]} 0 0
   [junit4]   2> 1316885 T6323 C1684 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[10]} 0 0
   [junit4]   2> 1316886 T6323 C1684 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[11]} 0 0
   [junit4]   2> 1316886 T6323 C1684 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[12]} 0 0
   [junit4]   2> 1316886 T6323 C1684 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[13]} 0 0
   [junit4]   2> 1316886 T6323 C1684 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1316891 T6323 C1684 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_n,generation=23}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_o,generation=24}
   [junit4]   2> 1316891 T6323 C1684 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 24
   [junit4]   2> 1316893 T6323 C1684 oass.SolrIndexSearcher.<init> Opening 
Searcher@28990a11[collection1] main
   [junit4]   2> 1316893 T6323 C1684 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1316893 T6325 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@28990a11[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_8(6.0.0):c13)))}
   [junit4]   2> 1316893 T6323 C1684 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 7
   [junit4]   2> 1316894 T6323 C1684 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id&fq={!+score%3Dnone+df%3Dpointvector}[32,-80+TO+"33+,+-79"]&rows=1000&wt=xml}
 hits=1 status=0 QTime=0 
   [junit4]   2> 1316896 T6323 oas.SolrTestCaseJ4.tearDown ###Ending 
testRangeSyntax {p0=pointvector}
   [junit4]   2> 1316902 T6323 oas.SolrTestCaseJ4.setUp ###Starting 
checkResultFormat {p0=pointvector}
   [junit4]   2> 1316902 T6323 C1684 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1316902 T6323 C1684 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
   [junit4]   2> 1316902 T6323 C1684 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1316902 T6323 C1684 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_o,generation=24}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_p,generation=25}
   [junit4]   2> 1316902 T6323 C1684 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 25
   [junit4]   2> 1316904 T6323 C1684 oass.SolrIndexSearcher.<init> Opening 
Searcher@325162fd[collection1] main
   [junit4]   2> 1316904 T6323 C1684 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1316904 T6325 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@325162fd[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1316904 T6323 C1684 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 2
   [junit4]   2> 1316904 T6323 C1684 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {add=[11]} 0 0
   [junit4]   2> 1316905 T6323 C1684 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1316906 T6323 C1684 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_p,generation=25}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_q,generation=26}
   [junit4]   2> 1316907 T6323 C1684 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 26
   [junit4]   2> 1316907 T6323 C1684 oass.SolrIndexSearcher.<init> Opening 
Searcher@6e7ef22d[collection1] main
   [junit4]   2> 1316910 T6323 C1684 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1316910 T6325 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@6e7ef22d[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_9(6.0.0):c1)))}
   [junit4]   2> 1316910 T6323 C1684 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 5
   [junit4]   2> 1316910 T6323 C1684 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={q=*:*&fl=id,pointvector&fq={!bbox+sfield%3Dpointvector+pt%3D89.9,-130+d%3D9}&rows=1000&wt=xml}
 hits=1 status=0 QTime=0 
   [junit4]   2> 1316910 T6323 oas.SolrTestCaseJ4.tearDown ###Ending 
checkResultFormat {p0=pointvector}
   [junit4]   2> 1316916 T6323 oas.SolrTestCaseJ4.setUp ###Starting 
testSpatialConfig {p0=pointvector}
   [junit4]   2> 1316917 T6323 C1684 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1316917 T6323 C1684 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
   [junit4]   2> 1316917 T6323 C1684 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1316918 T6323 C1684 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_q,generation=26}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@466cc80b),segFN=segments_r,generation=27}
   [junit4]   2> 1316918 T6323 C1684 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 27
   [junit4]   2> 1316918 T6323 C1684 oass.SolrIndexSearcher.<init> Opening 
Searcher@12cac3c[collection1] main
   [junit4]   2> 1316919 T6323 C1684 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 1316919 T6325 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@12cac3c[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1316919 T6323 C1684 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {commit=} 0 2
   [junit4]   2> 1316919 T6323 oas.SolrTestCaseJ4.tearDown ###Ending 
testSpatialConfig {p0=pointvector}
   [junit4]   2> 1316926 T6323 oas.SolrTestCaseJ4.setUp ###Starting 
checkQueryEmptyIndex {p0=pointvector}
   [junit4]   2> 1316926 T6323 C1684 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1316926 T6323 C1684 oasup.LogUpdateProcessor.finish 
[collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
   [junit4]   2> 1316927 T6323 C1684 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1316927 T6323 C1684 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7060cc6d lockFactory=org.apache.

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

ava.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=Asserting(Lucene50): 
{bbox__xdl=BlockTreeOrds(blocksize=128), 
srpt_geohash=BlockTreeOrds(blocksize=128), 
bbox__maxX=PostingsFormat(name=Memory doPackFST= true), 
bbox__maxY=Lucene50(blocksize=128), bbox__minX=BlockTreeOrds(blocksize=128), 
bbox__minY=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 pointvector__y=Lucene50(blocksize=128), 
pointvector__x=PostingsFormat(name=Memory doPackFST= true), 
id=BlockTreeOrds(blocksize=128), srpt_quad=BlockTreeOrds(blocksize=128), 
stqpt_geohash=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128)))},
 docValues:{bbox__maxX=DocValuesFormat(name=Asserting), 
bbox__maxY=DocValuesFormat(name=Memory), 
bbox__minX=DocValuesFormat(name=Lucene50), 
bbox__minY=DocValuesFormat(name=Lucene50)}, sim=DefaultSimilarity, 
locale=th_TH_TH_#u-nu-thai, timezone=Indian/Kerguelen
   [junit4]   2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.8.0_31 
(64-bit)/cpus=2,threads=3,free=44560024,total=244457472
   [junit4]   2> NOTE: All tests run in this JVM: 
[TestReversedWildcardFilterFactory, TestSerializedLuceneMatchVersion, 
TestSolrConfigHandlerCloud, SolrIndexConfigTest, AssignTest, 
TestIndexingPerformance, OutOfBoxZkACLAndCredentialsProvidersTest, 
StandardRequestHandlerTest, UnloadDistributedZkTest, TestQuerySenderListener, 
RequestLoggingTest, HdfsWriteToMultipleCollectionsTest, DateMathParserTest, 
TestHdfsUpdateLog, TestBinaryResponseWriter, DistributedTermsComponentTest, 
DirectSolrSpellCheckerTest, TestDynamicLoading, DistributedExpandComponentTest, 
PreAnalyzedUpdateProcessorTest, TestBinaryField, TestBlobHandler, 
TestReloadAndDeleteDocs, TestUpdate, PingRequestHandlerTest, 
TestStressVersions, RecoveryZkTest, SolrRequestParserTest, 
TestSolrDynamicMBean, TestMiniSolrCloudCluster, AliasIntegrationTest, 
ResponseLogComponentTest, TestOrdValues, LeaderElectionTest, 
ShardRoutingCustomTest, TestDistributedSearch, TestCollapseQParserPlugin, 
TestSolrCoreProperties, TestSolrJ, DeleteShardTest, ClusterStateTest, 
CloudMLTQParserTest, TestSearcherReuse, HdfsSyncSliceTest, 
DistributedIntervalFacetingTest, TestFieldTypeResource, ConnectionManagerTest, 
TestMiniSolrCloudClusterSSL, TestDFRSimilarityFactory, TestSolrConfigHandler, 
SolrPluginUtilsTest, DocumentBuilderTest, CacheHeaderTest, TestComponentsName, 
TestSweetSpotSimilarityFactory, IndexBasedSpellCheckerTest, 
FieldAnalysisRequestHandlerTest, TestNonDefinedSimilarityFactory, 
DistributedQueryComponentCustomSortTest, TestIntervalFaceting, 
TestOmitPositions, TestStressRecovery, PluginInfoTest, BadIndexSchemaTest, 
TestExceedMaxTermLength, TestCodecSupport, DefaultValueUpdateProcessorTest, 
RequiredFieldsTest, TestNRTOpen, DocValuesTest, TestRawResponseWriter, 
DistributedFacetPivotLargeTest, ZkNodePropsTest, 
TriLevelCompositeIdRoutingTest, TestDistributedGrouping, 
TestDistributedMissingSort, CachingDirectoryFactoryTest, EnumFieldTest, 
TestUniqueKeyFieldResource, ScriptEngineTest, DirectUpdateHandlerTest, 
RAMDirectoryFactoryTest, TestPseudoReturnFields, PrimUtilsTest, DOMUtilTest, 
SuggesterTSTTest, DateRangeFieldTest, TestManagedSchema, 
TestAtomicUpdateErrorCases, TestSolrXml, TestFunctionQuery, 
SharedFSAutoReplicaFailoverTest, AnalysisAfterCoreReloadTest, 
ExternalFileFieldSortTest, AlternateDirectoryTest, UUIDFieldTest, 
DocValuesMissingTest, TestClusterStateMutator, TestRecovery, 
SimplePostToolTest, SyncSliceTest, SimpleCollectionCreateDeleteTest, 
TestFastWriter, TestPerFieldSimilarity, TestBulkSchemaAPI, 
MultiThreadedOCPTest, OutputWriterTest, ReturnFieldsTest, 
LeaderElectionIntegrationTest, TestRecoveryHdfs, TestConfigOverlay, 
BufferStoreTest, HighlighterTest, TestSchemaManager, TestInitQParser, 
TermsComponentTest, NumericFieldsTest, FastVectorHighlighterTest, 
TestPartialUpdateDeduplication, LeaderFailoverAfterPartitionTest, 
SynonymTokenizerTest, TestLRUCache, TestReplicationHandlerBackup, 
OpenCloseCoreStressTest, TestTrackingShardHandlerFactory, 
TestOverriddenPrefixQueryForCustomFieldType, AtomicUpdatesTest, 
CircularListTest, CSVRequestHandlerTest, TestFuzzyAnalyzedSuggestions, 
TestSystemIdResolver, DistributedQueryComponentOptimizationTest, SampleTest, 
RemoteQueryErrorTest, TestDefaultSimilarityFactory, HttpPartitionTest, 
HdfsUnloadDistributedZkTest, TestXIncludeConfig, NoCacheHeaderTest, 
TestSolr4Spatial]
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestSolr4Spatial 
-Dtests.seed=F26989B51F38C25E -Dtests.slow=true 
-Dtests.locale=th_TH_TH_#u-nu-thai -Dtests.timezone=Indian/Kerguelen 
-Dtests.asserts=true -Dtests.file.encoding=Cp1252
   [junit4] ERROR   0.00s | TestSolr4Spatial (suite) <<<
   [junit4]    > Throwable #1: java.lang.RuntimeException: 
SolrCore.getOpenCount()==6
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([F26989B51F38C25E]: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=6326, name=Thread-2371, 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=6325, name=searcherExecutor-3225-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([F26989B51F38C25E]:0)Throwable #3: 
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie 
threads that couldn't be terminated:
   [junit4]    >    1) Thread[id=6326, name=Thread-2371, 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=6325, name=searcherExecutor-3225-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([F26989B51F38C25E]:0)
   [junit4] Completed in 28.80s, 45 tests, 3 errors, 2 skipped <<< FAILURES!

[...truncated 972 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:519: The 
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:467: The 
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:61: The 
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\extra-targets.xml:39: 
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:191: 
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:510:
 The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1351:
 The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:958:
 There were test failures: 468 suites, 1868 tests, 3 suite-level errors, 1209 
ignored (22 assumptions)

Total time: 57 minutes 9 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 64bit/jdk1.8.0_31 
-XX:-UseCompressedOops -XX:+UseSerialGC
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any


---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to