Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.1-Linux/263/
Java: 64bit/jdk1.8.0_40 -XX:-UseCompressedOops -XX:+UseParallelGC

1 tests failed.
FAILED:  org.apache.solr.search.facet.TestJsonFacets.testComplex

Error Message:
mismatch: 'accord'!='a' @ facets/makes/buckets/[0]/models/buckets/[1]/val

Stack Trace:
java.lang.RuntimeException: mismatch: 'accord'!='a' @ 
facets/makes/buckets/[0]/models/buckets/[1]/val
        at 
__randomizedtesting.SeedInfo.seed([96EEB6032CF4572D:7731B39F00BA1B4E]:0)
        at org.apache.solr.SolrTestCaseHS.matchJSON(SolrTestCaseHS.java:160)
        at org.apache.solr.SolrTestCaseHS.assertJQ(SolrTestCaseHS.java:142)
        at org.apache.solr.SolrTestCaseHS$Client.testJQ(SolrTestCaseHS.java:288)
        at 
org.apache.solr.search.facet.TestJsonFacets.testComplex(TestJsonFacets.java:155)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:497)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792)
        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 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
        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)




Build Log:
[...truncated 9719 lines...]
   [junit4] Suite: org.apache.solr.search.facet.TestJsonFacets
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/build/solr-core/test/J0/temp/solr.search.facet.TestJsonFacets
 96EEB6032CF4572D-001/init-core-data-001
   [junit4]   2> 154409 T635 oas.SolrTestCaseJ4.initCore ####initCore
   [junit4]   2> 154409 T635 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 154410 T635 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 154410 T635 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 154430 T635 oasc.SolrConfig.refreshRequestParams current 
version of requestparams : -1
   [junit4]   2> 154435 T635 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
5.1.0
   [junit4]   2> 154450 T635 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig-tlog.xml
   [junit4]   2> 154451 T635 oass.IndexSchema.readSchema Reading Solr Schema 
from 
/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/core/src/test-files/solr/collection1/conf/schema_latest.xml
   [junit4]   2> 154455 T635 oass.IndexSchema.readSchema [null] Schema 
name=example
   [junit4]   2> 154512 T635 oass.AbstractSpatialFieldType.init WARN units 
parameter is deprecated, please use distanceUnits instead for field types with 
class SpatialRecursivePrefixTreeFieldType
   [junit4]   2> 154515 T635 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 154521 T635 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 154523 T635 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 154525 T635 oasc.SolrResourceLoader.locateSolrHome JNDI not 
configured for solr (NoInitialContextEx)
   [junit4]   2> 154525 T635 oasc.SolrResourceLoader.locateSolrHome using 
system property solr.solr.home: 
/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/core/src/test-files/solr
   [junit4]   2> 154525 T635 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/core/src/test-files/solr/'
   [junit4]   2> 154535 T635 oasc.CoreContainer.<init> New CoreContainer 
143808625
   [junit4]   2> 154535 T635 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/core/src/test-files/solr/]
   [junit4]   2> 154535 T635 oasc.CoreContainer.load loading shared library: 
/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/core/src/test-files/solr/lib
   [junit4]   2> 154535 T635 oasc.SolrResourceLoader.addToClassLoader WARN 
Can't find (or read) directory to add to classloader: lib (resolved as: 
/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/core/src/test-files/solr/lib).
   [junit4]   2> 154541 T635 oashc.HttpShardHandlerFactory.getParameter Setting 
socketTimeout to: 600000
   [junit4]   2> 154541 T635 oashc.HttpShardHandlerFactory.getParameter Setting 
urlScheme to: null
   [junit4]   2> 154541 T635 oashc.HttpShardHandlerFactory.getParameter Setting 
connTimeout to: 60000
   [junit4]   2> 154542 T635 oashc.HttpShardHandlerFactory.getParameter Setting 
maxConnectionsPerHost to: 20
   [junit4]   2> 154542 T635 oashc.HttpShardHandlerFactory.getParameter Setting 
maxConnections to: 10000
   [junit4]   2> 154542 T635 oashc.HttpShardHandlerFactory.getParameter Setting 
corePoolSize to: 0
   [junit4]   2> 154542 T635 oashc.HttpShardHandlerFactory.getParameter Setting 
maximumPoolSize to: 2147483647
   [junit4]   2> 154542 T635 oashc.HttpShardHandlerFactory.getParameter Setting 
maxThreadIdleTime to: 5
   [junit4]   2> 154542 T635 oashc.HttpShardHandlerFactory.getParameter Setting 
sizeOfQueue to: -1
   [junit4]   2> 154542 T635 oashc.HttpShardHandlerFactory.getParameter Setting 
fairnessPolicy to: false
   [junit4]   2> 154543 T635 oashc.HttpShardHandlerFactory.getParameter Setting 
useRetries to: false
   [junit4]   2> 154543 T635 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=30000&connTimeout=30000&retry=true
   [junit4]   2> 154543 T635 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 154544 T635 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 154544 T635 oasc.CoreContainer.load Node Name: testNode
   [junit4]   2> 154544 T635 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: 
{name=collection1, config=solrconfig-tlog.xml, transient=false, 
schema=schema_latest.xml, loadOnStartup=true, instanceDir=collection1, 
collection=collection1, 
absoluteInstDir=/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/core/src/test-files/solr/collection1/,
 
dataDir=/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/build/solr-core/test/J0/temp/solr.search.facet.TestJsonFacets
 96EEB6032CF4572D-001/init-core-data-001, shard=shard1}
   [junit4]   2> 154545 T636 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 154546 T636 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 154546 T636 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 154561 T636 oasc.SolrConfig.refreshRequestParams current 
version of requestparams : -1
   [junit4]   2> 154566 T636 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
5.1.0
   [junit4]   2> 154575 T636 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig-tlog.xml
   [junit4]   2> 154576 T636 oass.IndexSchema.readSchema Reading Solr Schema 
from 
/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/core/src/test-files/solr/collection1/conf/schema_latest.xml
   [junit4]   2> 154580 T636 oass.IndexSchema.readSchema [collection1] Schema 
name=example
   [junit4]   2> 154650 T636 oass.AbstractSpatialFieldType.init WARN units 
parameter is deprecated, please use distanceUnits instead for field types with 
class SpatialRecursivePrefixTreeFieldType
   [junit4]   2> 154653 T636 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 154658 T636 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 154660 T636 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 154661 T636 oasc.CoreContainer.create Creating SolrCore 
'collection1' using configuration from instancedir 
/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 154661 T636 oasc.SolrCore.initDirectoryFactory 
org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 154662 T636 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/core/src/test-files/solr/collection1/,
 
dataDir=/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/build/solr-core/test/J0/temp/solr.search.facet.TestJsonFacets
 96EEB6032CF4572D-001/init-core-data-001/
   [junit4]   2> 154662 T636 oasc.JmxMonitoredMap.<init> JMX monitoring is 
enabled. Adding Solr mbeans to JMX Server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@3c6581f7
   [junit4]   2> 154662 T636 oasc.CachingDirectoryFactory.get return new 
directory for 
/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/build/solr-core/test/J0/temp/solr.search.facet.TestJsonFacets
 96EEB6032CF4572D-001/init-core-data-001
   [junit4]   2> 154663 T636 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/build/solr-core/test/J0/temp/solr.search.facet.TestJsonFacets
 96EEB6032CF4572D-001/init-core-data-001/index/
   [junit4]   2> 154663 T636 oasc.SolrCore.initIndex WARN [collection1] Solr 
index directory 
'/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/build/solr-core/test/J0/temp/solr.search.facet.TestJsonFacets
 96EEB6032CF4572D-001/init-core-data-001/index' doesn't exist. Creating new 
index...
   [junit4]   2> 154663 T636 oasc.CachingDirectoryFactory.get return new 
directory for 
/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/build/solr-core/test/J0/temp/solr.search.facet.TestJsonFacets
 96EEB6032CF4572D-001/init-core-data-001/index
   [junit4]   2> 154663 T636 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=36, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 154664 T636 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_1,generation=1}
   [junit4]   2> 154664 T636 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 154667 T636 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "nodistrib"
   [junit4]   2> 154667 T636 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 154667 T636 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 154668 T636 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 154668 T636 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 154668 T636 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 154668 T636 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 154668 T636 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 154668 T636 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 154670 T636 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 154671 T636 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 154673 T636 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 154673 T636 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 154676 T636 oasc.RequestHandlers.initHandlersFromConfig 
Registered paths: 
/admin/mbeans,standard,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
   [junit4]   2> 154676 T636 oasc.SolrCore.initStatsCache Using default 
statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 154677 T636 oasu.UpdateHandler.<init> Using UpdateLog 
implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 154677 T636 oasu.UpdateLog.init Initializing UpdateLog: 
dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
   [junit4]   2> 154677 T636 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 154678 T636 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 154678 T636 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=11, maxMergeAtOnceExplicit=26, maxMergedSegmentMB=67.8818359375, 
floorSegmentMB=0.9970703125, forceMergeDeletesPctAllowed=8.023386904628364, 
segmentsPerTier=39.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 154678 T636 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_1,generation=1}
   [junit4]   2> 154679 T636 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 154679 T636 oass.SolrIndexSearcher.<init> Opening 
Searcher@5bc0e0d0[collection1] main
   [junit4]   2> 154679 T636 oasr.ManagedResourceStorage.newStorageIO WARN 
Cannot write to config directory 
/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/core/src/test-files/solr/collection1/conf;
 switching to use InMemory storage instead.
   [junit4]   2> 154679 T636 oasr.RestManager.init Initializing RestManager 
with initArgs: {}
   [junit4]   2> 154679 T636 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using InMemoryStorage
   [junit4]   2> 154680 T636 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 154680 T636 oash.ReplicationHandler.inform Commits will be 
reserved for  10000
   [junit4]   2> 154680 T636 oasc.CoreContainer.registerCore registering core: 
collection1
   [junit4]   2> 154681 T637 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@5bc0e0d0[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 154681 T635 oas.SolrTestCaseJ4.initCore ####initCore end
   [junit4]   2> 154684 T635 oas.SolrTestCaseJ4.setUp ###Starting testComplex
   [junit4]   2> ASYNC  NEW_CORE C141 name=collection1 
org.apache.solr.core.SolrCore@438c9256
   [junit4]   2> 154690 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {deleteByQuery=*:* (-1498419564685295616)} 0 5
   [junit4]   2> 154694 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[0 
(1498419564693684224)]} 0 1
   [junit4]   2> 154695 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[1 
(1498419564694732800)]} 0 1
   [junit4]   2> 154695 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[2 
(1498419564695781376)]} 0 0
   [junit4]   2> 154696 T635 C141 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 154698 T635 C141 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_1,generation=1}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_2,generation=2}
   [junit4]   2> 154700 T635 C141 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 2
   [junit4]   2> 154703 T635 C141 oass.SolrIndexSearcher.<init> Opening 
Searcher@7dec63e0[collection1] main
   [junit4]   2> 154703 T635 C141 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 154704 T637 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@7dec63e0[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.1.0):c3)))}
   [junit4]   2> 154704 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 9
   [junit4]   2> 154706 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[3 
(1498419564706267136)]} 0 1
   [junit4]   2> 154706 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[4 
(1498419564707315712)]} 0 0
   [junit4]   2> 154707 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[4 
(1498419564708364288)]} 0 1
   [junit4]   2> 154707 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[5 
(1498419564708364289)]} 0 0
   [junit4]   2> 154708 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[6 
(1498419564708364290)]} 0 1
   [junit4]   2> 154708 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[7 
(1498419564709412864)]} 0 0
   [junit4]   2> 154709 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[8 
(1498419564710461440)]} 0 0
   [junit4]   2> 154709 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[9 
(1498419564710461441)]} 0 0
   [junit4]   2> 154709 T635 C141 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 154718 T635 C141 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_2,generation=2}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_3,generation=3}
   [junit4]   2> 154718 T635 C141 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 3
   [junit4]   2> 154718 T635 C141 oass.SolrIndexSearcher.<init> Opening 
Searcher@4222ca64[collection1] main
   [junit4]   2> 154719 T635 C141 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 154719 T637 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@4222ca64[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.1.0):c3)
 Uninverting(_1(5.1.0):c8/1:delGen=1)))}
   [junit4]   2> 154720 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 11
   [junit4]   2> 154721 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[10 
(1498419564723044352)]} 0 0
   [junit4]   2> 154722 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[10 
(1498419564724092928)]} 0 0
   [junit4]   2> 154722 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[11 
(1498419564724092929)]} 0 0
   [junit4]   2> 154723 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[12 
(1498419564725141504)]} 0 0
   [junit4]   2> 154723 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[13 
(1498419564725141505)]} 0 0
   [junit4]   2> 154724 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[14 
(1498419564726190080)]} 0 0
   [junit4]   2> 154724 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[15 
(1498419564726190081)]} 0 0
   [junit4]   2> 154725 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[16 
(1498419564727238656)]} 0 1
   [junit4]   2> 154725 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[17 
(1498419564727238657)]} 0 0
   [junit4]   2> 154725 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[18 
(1498419564727238658)]} 0 0
   [junit4]   2> 154726 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[19 
(1498419564728287232)]} 0 0
   [junit4]   2> 154726 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[20 
(1498419564728287233)]} 0 0
   [junit4]   2> 154726 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[21 
(1498419564728287234)]} 0 0
   [junit4]   2> 154727 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[22 
(1498419564729335808)]} 0 0
   [junit4]   2> 154727 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[23 
(1498419564729335809)]} 0 0
   [junit4]   2> 154727 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[24 
(1498419564729335810)]} 0 0
   [junit4]   2> 154728 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[25 
(1498419564729335811)]} 0 1
   [junit4]   2> 154728 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[26 
(1498419564730384384)]} 0 0
   [junit4]   2> 154728 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[27 
(1498419564730384385)]} 0 0
   [junit4]   2> 154729 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[28 
(1498419564730384386)]} 0 1
   [junit4]   2> 154729 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[29 
(1498419564731432960)]} 0 0
   [junit4]   2> 154729 T635 C141 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 154733 T635 C141 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_3,generation=3}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_4,generation=4}
   [junit4]   2> 154733 T635 C141 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 4
   [junit4]   2> 154734 T635 C141 oass.SolrIndexSearcher.<init> Opening 
Searcher@3b51c5ec[collection1] main
   [junit4]   2> 154734 T637 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@3b51c5ec[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.1.0):c3)
 Uninverting(_1(5.1.0):c8/1:delGen=1) Uninverting(_2(5.1.0):c21/1:delGen=1)))}
   [junit4]   2> 154735 T635 C141 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 154735 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 6
   [junit4]   2> 154737 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[30 
(1498419564738772992)]} 0 1
   [junit4]   2> 154738 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[31 
(1498419564739821568)]} 0 1
   [junit4]   2> 154738 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[32 
(1498419564740870144)]} 0 0
   [junit4]   2> 154738 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[33 
(1498419564740870145)]} 0 0
   [junit4]   2> 154739 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[34 
(1498419564741918720)]} 0 0
   [junit4]   2> 154739 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[35 
(1498419564741918721)]} 0 0
   [junit4]   2> 154739 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[36 
(1498419564741918722)]} 0 0
   [junit4]   2> 154740 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[37 
(1498419564742967296)]} 0 0
   [junit4]   2> 154740 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[38 
(1498419564742967297)]} 0 0
   [junit4]   2> 154740 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[39 
(1498419564742967298)]} 0 0
   [junit4]   2> 154741 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[40 
(1498419564744015872)]} 0 0
   [junit4]   2> 154741 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[41 
(1498419564744015873)]} 0 0
   [junit4]   2> 154742 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[42 
(1498419564745064448)]} 0 0
   [junit4]   2> 154742 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[43 
(1498419564745064449)]} 0 0
   [junit4]   2> 154742 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[44 
(1498419564745064450)]} 0 0
   [junit4]   2> 154743 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[45 
(1498419564746113024)]} 0 0
   [junit4]   2> 154743 T635 C141 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 154747 T635 C141 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_4,generation=4}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_5,generation=5}
   [junit4]   2> 154747 T635 C141 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 5
   [junit4]   2> 154748 T635 C141 oass.SolrIndexSearcher.<init> Opening 
Searcher@1f7eac67[collection1] main
   [junit4]   2> 154749 T637 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1f7eac67[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.1.0):c3)
 Uninverting(_1(5.1.0):c8/1:delGen=1) Uninverting(_2(5.1.0):c21/1:delGen=1) 
Uninverting(_3(5.1.0):c16)))}
   [junit4]   2> 154749 T635 C141 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 154749 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 6
   [junit4]   2> 154751 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[46 
(1498419564753453056)]} 0 1
   [junit4]   2> 154752 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[47 
(1498419564755550208)]} 0 1
   [junit4]   2> 154752 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[48 
(1498419564755550209)]} 0 0
   [junit4]   2> 154752 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[49 
(1498419564755550210)]} 0 0
   [junit4]   2> 154753 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[50 
(1498419564756598784)]} 0 0
   [junit4]   2> 154753 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[51 
(1498419564756598785)]} 0 0
   [junit4]   2> 154754 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[51 
(1498419564757647360)]} 0 1
   [junit4]   2> 154754 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[52 
(1498419564757647361)]} 0 0
   [junit4]   2> 154754 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[53 
(1498419564757647362)]} 0 0
   [junit4]   2> 154755 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[54 
(1498419564758695936)]} 0 0
   [junit4]   2> 154756 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[55 
(1498419564758695937)]} 0 0
   [junit4]   2> 154756 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[55 
(1498419564759744512)]} 0 0
   [junit4]   2> 154757 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[56 
(1498419564759744513)]} 0 1
   [junit4]   2> 154757 T635 C141 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 154761 T635 C141 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_5,generation=5}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_6,generation=6}
   [junit4]   2> 154761 T635 C141 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 6
   [junit4]   2> 154762 T635 C141 oass.SolrIndexSearcher.<init> Opening 
Searcher@35a75e7f[collection1] main
   [junit4]   2> 154762 T637 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@35a75e7f[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.1.0):c3)
 Uninverting(_1(5.1.0):c8/1:delGen=1) Uninverting(_2(5.1.0):c21/1:delGen=1) 
Uninverting(_3(5.1.0):c16) Uninverting(_4(5.1.0):c13/2:delGen=1)))}
   [junit4]   2> 154763 T635 C141 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 154763 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 6
   [junit4]   2> 154765 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[57 
(1498419564768133120)]} 0 1
   [junit4]   2> 154766 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[58 
(1498419564770230272)]} 0 0
   [junit4]   2> 154766 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[59 
(1498419564770230273)]} 0 0
   [junit4]   2> 154766 T635 C141 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 154770 T635 C141 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_6,generation=6}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_7,generation=7}
   [junit4]   2> 154771 T635 C141 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 7
   [junit4]   2> 154771 T635 C141 oass.SolrIndexSearcher.<init> Opening 
Searcher@18bc281d[collection1] main
   [junit4]   2> 154772 T637 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@18bc281d[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.1.0):c3)
 Uninverting(_1(5.1.0):c8/1:delGen=1) Uninverting(_2(5.1.0):c21/1:delGen=1) 
Uninverting(_3(5.1.0):c16) Uninverting(_4(5.1.0):c13/2:delGen=1) 
Uninverting(_5(5.1.0):c3)))}
   [junit4]   2> 154772 T635 C141 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 154773 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 7
   [junit4]   2> 154774 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[60 
(1498419564777570304)]} 0 1
   [junit4]   2> 154775 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[61 
(1498419564779667456)]} 0 0
   [junit4]   2> 154775 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[62 
(1498419564779667457)]} 0 0
   [junit4]   2> 154776 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[63 
(1498419564779667458)]} 0 1
   [junit4]   2> 154776 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[64 
(1498419564780716032)]} 0 0
   [junit4]   2> 154776 T635 C141 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 154780 T635 C141 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_7,generation=7}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_8,generation=8}
   [junit4]   2> 154780 T635 C141 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 8
   [junit4]   2> 154781 T635 C141 oass.SolrIndexSearcher.<init> Opening 
Searcher@54e2aa41[collection1] main
   [junit4]   2> 154782 T637 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@54e2aa41[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.1.0):c3)
 Uninverting(_1(5.1.0):c8/1:delGen=1) Uninverting(_2(5.1.0):c21/1:delGen=1) 
Uninverting(_3(5.1.0):c16) Uninverting(_4(5.1.0):c13/2:delGen=1) 
Uninverting(_5(5.1.0):c3) Uninverting(_6(5.1.0):c5)))}
   [junit4]   2> 154782 T635 C141 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 154783 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 7
   [junit4]   2> 154784 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[65 
(1498419564788056064)]} 0 1
   [junit4]   2> 154785 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[66 
(1498419564790153216)]} 0 0
   [junit4]   2> 154785 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[67 
(1498419564790153217)]} 0 0
   [junit4]   2> 154786 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[67 
(1498419564791201792)]} 0 0
   [junit4]   2> 154786 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[68 
(1498419564791201793)]} 0 0
   [junit4]   2> 154787 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[69 
(1498419564791201794)]} 0 1
   [junit4]   2> 154787 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[70 
(1498419564792250368)]} 0 0
   [junit4]   2> 154788 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[71 
(1498419564793298944)]} 0 0
   [junit4]   2> 154788 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[72 
(1498419564793298945)]} 0 0
   [junit4]   2> 154788 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[73 
(1498419564793298946)]} 0 0
   [junit4]   2> 154789 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[74 
(1498419564794347520)]} 0 0
   [junit4]   2> 154789 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[75 
(1498419564794347521)]} 0 0
   [junit4]   2> 154790 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[76 
(1498419564795396096)]} 0 0
   [junit4]   2> 154790 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[77 
(1498419564795396097)]} 0 0
   [junit4]   2> 154790 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[78 
(1498419564795396098)]} 0 0
   [junit4]   2> 154791 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[78 
(1498419564796444672)]} 0 0
   [junit4]   2> 154791 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[79 
(1498419564796444673)]} 0 0
   [junit4]   2> 154791 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[80 
(1498419564796444674)]} 0 0
   [junit4]   2> 154792 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[81 
(1498419564797493248)]} 0 0
   [junit4]   2> 154792 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[82 
(1498419564797493249)]} 0 0
   [junit4]   2> 154792 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[83 
(1498419564797493250)]} 0 0
   [junit4]   2> 154793 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[84 
(1498419564798541824)]} 0 0
   [junit4]   2> 154793 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[85 
(1498419564798541825)]} 0 0
   [junit4]   2> 154793 T635 C141 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 154797 T635 C141 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_8,generation=8}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_9,generation=9}
   [junit4]   2> 154797 T635 C141 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 9
   [junit4]   2> 154798 T635 C141 oass.SolrIndexSearcher.<init> Opening 
Searcher@253c9af4[collection1] main
   [junit4]   2> 154798 T635 C141 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 154798 T637 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@253c9af4[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.1.0):c3)
 Uninverting(_1(5.1.0):c8/1:delGen=1) Uninverting(_2(5.1.0):c21/1:delGen=1) 
Uninverting(_3(5.1.0):c16) Uninverting(_4(5.1.0):c13/2:delGen=1) 
Uninverting(_5(5.1.0):c3) Uninverting(_6(5.1.0):c5) 
Uninverting(_7(5.1.0):c23/2:delGen=1)))}
   [junit4]   2> 154799 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 6
   [junit4]   2> 154800 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[86 
(1498419564804833280)]} 0 1
   [junit4]   2> 154800 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[87 
(1498419564805881856)]} 0 0
   [junit4]   2> 154800 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[88 
(1498419564805881857)]} 0 0
   [junit4]   2> 154801 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[89 
(1498419564805881858)]} 0 1
   [junit4]   2> 154801 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[90 
(1498419564806930432)]} 0 0
   [junit4]   2> 154801 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[91 
(1498419564806930433)]} 0 0
   [junit4]   2> 154802 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[92 
(1498419564807979008)]} 0 0
   [junit4]   2> 154802 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[93 
(1498419564807979009)]} 0 0
   [junit4]   2> 154802 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[94 
(1498419564807979010)]} 0 0
   [junit4]   2> 154803 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[95 
(1498419564807979011)]} 0 1
   [junit4]   2> 154803 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[96 
(1498419564809027584)]} 0 0
   [junit4]   2> 154803 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[97 
(1498419564809027585)]} 0 0
   [junit4]   2> 154804 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[98 
(1498419564810076160)]} 0 0
   [junit4]   2> 154804 T635 C141 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 154807 T635 C141 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_9,generation=9}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_a,generation=10}
   [junit4]   2> 154807 T635 C141 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 10
   [junit4]   2> 154807 T635 C141 oass.SolrIndexSearcher.<init> Opening 
Searcher@6db3c660[collection1] main
   [junit4]   2> 154808 T635 C141 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 154808 T637 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@6db3c660[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.1.0):c3)
 Uninverting(_1(5.1.0):c8/1:delGen=1) Uninverting(_2(5.1.0):c21/1:delGen=1) 
Uninverting(_3(5.1.0):c16) Uninverting(_4(5.1.0):c13/2:delGen=1) 
Uninverting(_5(5.1.0):c3) Uninverting(_6(5.1.0):c5) 
Uninverting(_7(5.1.0):c23/2:delGen=1) Uninverting(_8(5.1.0):c13)))}
   [junit4]   2> 154808 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 4
   [junit4]   2> 154842 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={make_s=make_s&model_s=model_s&price_low=11000.0&price_high=100000.0&q=*%3A*&rows=0&fq=%2B%24%7Bmake_s%7D%3Ahonda+%2Bcost_f%3A%5B%24%7Bprice_low%7D+TO+%24%7Bprice_high%7D%5D&json.facet=%7Bmakes%3A%7Bterms%3A%7Bfield%3A%24%7Bmake_s%7D%2C+facet%3A%7Bmodels%3A%7Bterms%3A%7Bfield%3A%24%7Bmodel_s%7D%2C+limit%3A2%2C+mincount%3A0%7D%7D%7D%7D%7D%7D%7D&facet=true&facet.pivot=make_s%2Cmodel_s&facet.limit=2&wt=json&indent=true}
 hits=3 status=0 QTime=32 
   [junit4]   2> 154845 T635 oas.SolrTestCaseHS.matchJSON ERROR query failed 
JSON validation. error=mismatch: 'accord'!='a' @ 
facets/makes/buckets/[0]/models/buckets/[1]/val
   [junit4]   2>         expected =facets=={count:3, 
makes:{buckets:[{val:honda, count:3, models:{buckets:[{val:civic, 
count:2},{val:accord, count:0}]}}]}}
   [junit4]   2>         response = {
   [junit4]   2>          "responseHeader":{
   [junit4]   2>            "status":0,
   [junit4]   2>            "QTime":32},
   [junit4]   2>          "response":{"numFound":3,"start":0,"docs":[]
   [junit4]   2>          },
   [junit4]   2>          "facet_counts":{
   [junit4]   2>            "facet_queries":{},
   [junit4]   2>            "facet_fields":{},
   [junit4]   2>            "facet_dates":{},
   [junit4]   2>            "facet_ranges":{},
   [junit4]   2>            "facet_intervals":{},
   [junit4]   2>            "facet_heatmaps":{},
   [junit4]   2>            "facet_pivot":{
   [junit4]   2>              "make_s,model_s":[{
   [junit4]   2>                  "field":"make_s",
   [junit4]   2>                  "value":"honda",
   [junit4]   2>                  "count":3,
   [junit4]   2>                  "pivot":[{
   [junit4]   2>                      "field":"model_s",
   [junit4]   2>                      "value":"civic",
   [junit4]   2>                      "count":2}]}]}},
   [junit4]   2>          "facets":{
   [junit4]   2>            "count":3,
   [junit4]   2>            "makes":{
   [junit4]   2>              "buckets":[{
   [junit4]   2>                  "val":"honda",
   [junit4]   2>                  "count":3,
   [junit4]   2>                  "models":{
   [junit4]   2>                    "buckets":[{
   [junit4]   2>                        "val":"civic",
   [junit4]   2>                        "count":2},
   [junit4]   2>                      {
   [junit4]   2>                        "val":"a",
   [junit4]   2>                        "count":0}]}}]}}}
   [junit4]   2>        
   [junit4]   2> 154846 T635 oas.SolrTestCaseJ4.tearDown ###Ending testComplex
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestJsonFacets 
-Dtests.method=testComplex -Dtests.seed=96EEB6032CF4572D -Dtests.multiplier=3 
-Dtests.slow=true -Dtests.locale=pt_BR -Dtests.timezone=Africa/Asmara 
-Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   0.18s J0 | TestJsonFacets.testComplex <<<
   [junit4]    > Throwable #1: java.lang.RuntimeException: mismatch: 
'accord'!='a' @ facets/makes/buckets/[0]/models/buckets/[1]/val
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([96EEB6032CF4572D:7731B39F00BA1B4E]:0)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseHS.matchJSON(SolrTestCaseHS.java:160)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseHS.assertJQ(SolrTestCaseHS.java:142)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseHS$Client.testJQ(SolrTestCaseHS.java:288)
   [junit4]    >        at 
org.apache.solr.search.facet.TestJsonFacets.testComplex(TestJsonFacets.java:155)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 154864 T635 oas.SolrTestCaseJ4.setUp ###Starting testStats
   [junit4]   2> 154867 T635 C141 oass.SolrIndexSearcher.<init> Opening 
Searcher@24cafd93[collection1] realtime
   [junit4]   2> 154867 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {deleteByQuery=*:* (-1498419564874039296)} 0 2
   [junit4]   2> 154869 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[1 
(1498419564877185024)]} 0 1
   [junit4]   2> 154869 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[2 
(1498419564878233600)]} 0 0
   [junit4]   2> 154869 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[3 
(1498419564878233601)]} 0 0
   [junit4]   2> 154870 T635 C141 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 154871 T635 C141 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_a,generation=10}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_b,generation=11}
   [junit4]   2> 154872 T635 C141 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 11
   [junit4]   2> 154873 T635 C141 oass.SolrIndexSearcher.<init> Opening 
Searcher@1bc3588[collection1] main
   [junit4]   2> 154873 T635 C141 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 154873 T637 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1bc3588[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_9(5.1.0):c3)))}
   [junit4]   2> 154874 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 4
   [junit4]   2> 154876 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[4 
(1498419564884525056)]} 0 1
   [junit4]   2> 154877 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[5 
(1498419564886622208)]} 0 0
   [junit4]   2> 154877 T635 C141 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 154879 T635 C141 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_b,generation=11}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_c,generation=12}
   [junit4]   2> 154880 T635 C141 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 12
   [junit4]   2> 154880 T635 C141 oass.SolrIndexSearcher.<init> Opening 
Searcher@1e3ff788[collection1] main
   [junit4]   2> 154880 T635 C141 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 154880 T637 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1e3ff788[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_9(5.1.0):c3)
 Uninverting(_a(5.1.0):c2)))}
   [junit4]   2> 154881 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 4
   [junit4]   2> 154882 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[6 
(1498419564890816512)]} 0 1
   [junit4]   2> 154882 T635 C141 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 154884 T635 C141 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_c,generation=12}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_d,generation=13}
   [junit4]   2> 154885 T635 C141 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 13
   [junit4]   2> 154885 T635 C141 oass.SolrIndexSearcher.<init> Opening 
Searcher@2641a1a8[collection1] main
   [junit4]   2> 154885 T635 C141 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 154886 T637 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@2641a1a8[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_9(5.1.0):c3)
 Uninverting(_a(5.1.0):c2) Uninverting(_b(5.1.0):c1)))}
   [junit4]   2> 154886 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 4
   [junit4]   2> 154889 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&json.facet=%7BcatA%3A%7Bquery%3A%7Bq%3A%27%24%7Bcat_s%7D%3AA%27%7D%7D%2C++catA2%3A%7Bquery%3A%7Bquery%3A%27%24%7Bcat_s%7D%3AA%27%7D%7D%2C++catA3%3A%7Bquery%3A%27%24%7Bcat_s%7D%3AA%27%7D++++%7D&wt=json&indent=true}
 hits=6 status=0 QTime=3 
   [junit4]   2> 154891 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&json.facet=%7B+catB%3A%7Bquery%3A%7Bq%3A%27%24%7Bcat_s%7D%3AB%27%2C+facet%3A%7Bnj%3A%7Bquery%3A%27%24%7Bwhere_s%7D%3ANJ%27%7D%2C+ny%3A%7Bquery%3A%27%24%7Bwhere_s%7D%3ANY%27%7D%7D+%7D%7D%7D&wt=json&indent=true}
 hits=6 status=0 QTime=1 
   [junit4]   2> 154892 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=id%3A%282+3%29&json.facet=%7B+catB%3A%7Bquery%3A%7Bq%3A%27%24%7Bcat_s%7D%3AB%27%2C+facet%3A%7Bnj%3A%7Bquery%3A%27%24%7Bwhere_s%7D%3ANJ%27%7D%2C+ny%3A%7Bquery%3A%27%24%7Bwhere_s%7D%3ANY%27%7D%7D+%7D%7D%7D&wt=json&indent=true}
 hits=2 status=0 QTime=1 
   [junit4]   2> 154893 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&json.facet=%7B+catB%3A%7Bquery%3A%7Bq%3A%27%24%7Bcat_s%7D%3AB%27%2C+facet%3A%7Bnj%3A%7Bquery%3A%7Bq%3A%27%24%7Bwhere_s%7D%3ANJ%27%7D%7D%2C+ny%3A%7Bquery%3A%27%24%7Bwhere_s%7D%3ANY%27%7D%7D+%7D%7D%7D&wt=json&indent=true}
 hits=6 status=0 QTime=0 
   [junit4]   2> 154894 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&json.facet=%7Bc1%3A%7Bfield%3A%27%24%7Bcat_s%7D%27%7D%2C+c2%3A%7Bfield%3A%7Bfield%3A%27%24%7Bcat_s%7D%27%7D%7D%2C+c3%3A%7Bterms%3A%7Bfield%3A%27%24%7Bcat_s%7D%27%7D%7D++%7D&wt=json&indent=true}
 hits=6 status=0 QTime=1 
   [junit4]   2> 154894 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&json.facet=%7Bf1%3A%7Bterms%3A%7Bfield%3A%27%24%7Bcat_s%7D%27%2C+mincount%3A3%7D%7D%7D&wt=json&indent=true}
 hits=6 status=0 QTime=0 
   [junit4]   2> 154895 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=id%3A1&json.facet=%7Bf1%3A%7Bterms%3A%27%24%7Bcat_s%7D%27%7D%7D&wt=json&indent=true}
 hits=1 status=0 QTime=0 
   [junit4]   2> 154896 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=id%3A1&json.facet=%7BprocessEmpty%3Atrue%2C+f1%3A%7Bterms%3A%7Bfield%3A%27%24%7Bcat_s%7D%27%2C+mincount%3A0%7D%7D%7D&wt=json&indent=true}
 hits=1 status=0 QTime=1 
   [junit4]   2> 154899 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=id%3A1&json.facet=%7BprocessEmpty%3Atrue%2C+f1%3A%7Bterms%3A%7Bfield%3A%27%24%7Bcat_s%7D%27%2C+mincount%3A0%2C+allBuckets%3Atrue%2C+facet%3A%7Bn1%3A%27sum%28%24%7Bnum_d%7D%29%27%7D++%7D%7D%7D&wt=json&indent=true}
 hits=1 status=0 QTime=3 
   [junit4]   2> 154901 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&json.facet=%7Bf1%3A%7Bterms%3A%7Bfield%3A%27%24%7Bcat_s%7D%27%2C+sort%3A%27n1+desc%27%2C+facet%3A%7Bn1%3A%27sum%28%24%7Bnum_d%7D%29%27%7D++%7D%7D+%2C+f2%3A%7Bterms%3A%7Bfield%3A%27%24%7Bcat_s%7D%27%2C+sort%3A%27n1+asc%27%2C+facet%3A%7Bn1%3A%27sum%28%24%7Bnum_d%7D%29%27%7D++%7D%7D+%7D&wt=json&indent=true}
 hits=6 status=0 QTime=1 
   [junit4]   2> 154909 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&json.facet=%7Bf1%3A%7Bterms%3A%7Bfield%3A%27%24%7Bcat_s%7D%27%2C+sort%3A%27n1+desc%27%2C+facet%3A%7Bn1%3A%27percentile%28%24%7Bnum_d%7D%2C50%29%27%7D++%7D%7D+%2C+f2%3A%7Bterms%3A%7Bfield%3A%27%24%7Bcat_s%7D%27%2C+sort%3A%27n1+asc%27%2C+facet%3A%7Bn1%3A%27percentile%28%24%7Bnum_d%7D%2C50%29%27%7D++%7D%7D+%7D&wt=json&indent=true}
 hits=6 status=0 QTime=8 
   [junit4]   2> 154910 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&json.facet=%7Bf1%3A%7Bterms%3A%7Bfield%3A%27%24%7Bcat_s%7D%27%2C+sort%3A%27n1+desc%27%2C+facet%3A%7Bn1%3A%27percentile%28%24%7Bnum_d%7D%2C50%2C0%2C100%29%27%7D++%7D%7D+%2C+f2%3A%7Bterms%3A%7Bfield%3A%27%24%7Bcat_s%7D%27%2C+sort%3A%27n1+asc%27%2C+facet%3A%7Bn1%3A%27percentile%28%24%7Bnum_d%7D%2C50%2C0%2C100%29%27%7D++%7D%7D+%7D&wt=json&indent=true}
 hits=6 status=0 QTime=0 
   [junit4]   2> 154911 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&json.facet=%7Bf1%3A%7Bterms%3A%7Bfield%3A%27%24%7Bcat_s%7D%27%2C+sort%3A%27count+desc%27+%7D++%7D+++++++++++%2C+f2%3A%7Bterms%3A%7Bfield%3A%27%24%7Bcat_s%7D%27%2C+sort%3A%27count+asc%27++%7D++%7D+++++++++++%2C+f3%3A%7Bterms%3A%7Bfield%3A%27%24%7Bcat_s%7D%27%2C+sort%3A%27index+asc%27++%7D++%7D+++++++++++%2C+f4%3A%7Bterms%3A%7Bfield%3A%27%24%7Bcat_s%7D%27%2C+sort%3A%27index+desc%27+%7D++%7D%7D&wt=json&indent=true}
 hits=6 status=0 QTime=0 
   [junit4]   2> 154912 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=id%3A1+id%3A6&json.facet=%7Bf1%3A%7Bterms%3A%7Bfield%3A%27%24%7Bcat_s%7D%27%2C+sort%3A%27count+desc%27+%7D++%7D+++++++++++%2C+f2%3A%7Bterms%3A%7Bfield%3A%27%24%7Bcat_s%7D%27%2C+sort%3A%27count+asc%27++%7D++%7D%7D&wt=json&indent=true}
 hits=2 status=0 QTime=0 
   [junit4]   2> 154914 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&json.facet=%7Bcat%3A%7Bterms%3A%7Bfield%3A%27%24%7Bcat_s%7D%27%2C+facet%3A%7Bnj%3A%7Bquery%3A%27%24%7Bwhere_s%7D%3ANJ%27%7D%7D++++%7D+++%7D%7D+%7D&wt=json&indent=true}
 hits=6 status=0 QTime=1 
   [junit4]   2> 154916 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=id%3A%282+5+4%29&json.facet=%7Bcat%3A%7Bterms%3A%7Bfield%3A%27%24%7Bcat_s%7D%27%2C+facet%3A%7Bnj%3A%7Bquery%3A%27%24%7Bwhere_s%7D%3ANJ%27%7D%7D++++%7D+++%7D%7D+%7D&wt=json&indent=true}
 hits=3 status=0 QTime=2 
   [junit4]   2> 154917 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&json.facet=%7Bf1%3A%7Bterms%3A%7Bfield%3A%24%7Bsuper_s%7D%2C+prefix%3As%2C+mincount%3A0+%7D%7D%7D&wt=json&indent=true}
 hits=6 status=0 QTime=1 
   [junit4]   2> 154918 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&json.facet=%7Bf1%3A%7Bterms%3A%7Bfield%3A%24%7Bsuper_s%7D%2C+prefix%3Attt%2C+mincount%3A0+%7D%7D%7D&wt=json&indent=true}
 hits=6 status=0 QTime=0 
   [junit4]   2> 154918 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&json.facet=%7Bf1%3A%7Bterms%3A%7Bfield%3A%24%7Bsuper_s%7D%2C+prefix%3Aaaaaaa%2C+mincount%3A0+%7D%7D%7D&wt=json&indent=true}
 hits=6 status=0 QTime=0 
   [junit4]   2> 154919 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&json.facet=%7Bf1%3A%7Bterms%3A%7Bfield%3A%24%7Bsuper_s%7D%2C+prefix%3Azzzzzz%2C+mincount%3A0+%7D%7D%7D&wt=json&indent=true}
 hits=6 status=0 QTime=1 
   [junit4]   2> 154919 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&json.facet=%7Bf1%3A%7Bterms%3A%7Bfield%3A%24%7Bnoexist%7D%2C+missing%3Atrue%7D%7D%7D&wt=json&indent=true}
 hits=6 status=0 QTime=0 
   [junit4]   2> 154920 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&json.facet=%7Bf1%3A%7Bterms%3A%7Bfield%3A%24%7Bsparse_s%7D%2C+missing%3Atrue+%7D%7D%7D&wt=json&indent=true}
 hits=6 status=0 QTime=0 
   [junit4]   2> 154921 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&json.facet=%7Bf1%3A%7Bterms%3A%7Bfield%3A%24%7Bsparse_s%7D%2C+missing%3Atrue%2C+facet%3A%7Bx%3A%27sum%28%24%7Bnum_d%7D%29%27%7D+++%7D%7D%7D&wt=json&indent=true}
 hits=6 status=0 QTime=1 
   [junit4]   2> 154922 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&json.facet=%7Bf1%3A%7Bterms%3A%7Bfield%3A%24%7Bsparse_s%7D%2C+missing%3Atrue%2C+prefix%3Aon%2C+facet%3A%7Bx%3A%27sum%28%24%7Bnum_d%7D%29%27%7D+++%7D%7D%7D&wt=json&indent=true}
 hits=6 status=0 QTime=1 
   [junit4]   2> 154923 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&json.facet=%7Bf1%3A%7Bterms%3A%7Bfield%3A%24%7Bsparse_s%7D%2C+missing%3Atrue%2C+prefix%3Appp%2C+facet%3A%7Bx%3A%27sum%28%24%7Bnum_d%7D%29%27%7D+++%7D%7D%7D&wt=json&indent=true}
 hits=6 status=0 QTime=1 
   [junit4]   2> 154924 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&facet=true&json.facet=%7Bf1%3A%7Bterms%3A%7Bfield%3A%24%7Bcat_s%7D%2C+numBuckets%3Atrue%2C+limit%3A1%7D%7D%7D&wt=json&indent=true}
 hits=6 status=0 QTime=1 
   [junit4]   2> 154924 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&facet=true&json.facet=%7Bf1%3A%7Bterms%3A%7Bfield%3A%24%7Bcat_s%7D%2C+numBuckets%3Atrue%2C+prefix%3AB%7D%7D%7D&wt=json&indent=true}
 hits=6 status=0 QTime=0 
   [junit4]   2> 154925 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&facet=true&json.facet=%7Bf1%3A%7Bterms%3A%7Bfield%3A%24%7Bcat_s%7D%2C+numBuckets%3Atrue%2C+mincount%3A3%7D%7D%7D&wt=json&indent=true}
 hits=6 status=0 QTime=0 
   [junit4]   2> 154936 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&json.facet=%7Bf%3A%7Brange%3A%7Bfield%3A%24%7Bnum_d%7D%2C+start%3A-5%2C+end%3A10%2C+gap%3A5%7D%7D%7D&wt=json&indent=true}
 hits=6 status=0 QTime=10 
   [junit4]   2> 154938 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&json.facet=%7Bf%3A%7Brange%3A%7Bfield%3A%24%7Bnum_d%7D%2C+start%3A-5%2C+end%3A10%2C+gap%3A5%2C+include%3Aupper%7D%7D%7D&wt=json&indent=true}
 hits=6 status=0 QTime=1 
   [junit4]   2> 154939 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&json.facet=%7Bf%3A%7Brange%3A%7Bfield%3A%24%7Bnum_d%7D%2C+start%3A-5%2C+end%3A10%2C+gap%3A5%2C+++facet%3A%7B+x%3A%27sum%28%24%7Bnum_i%7D%29%27%2C+ny%3A%7Bquery%3A%27%24%7Bwhere_s%7D%3ANY%27%7D%7D+++%7D%7D%7D&wt=json&indent=true}
 hits=6 status=0 QTime=1 
   [junit4]   2> 154941 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&json.facet=%7Bf%3A%7Brange%3A%7Bfield%3A%24%7Bnum_d%7D%2C+start%3A-5%2C+end%3A10%2C+gap%3A5%2C+other%3Aall%2C+++facet%3A%7B+x%3A%27sum%28%24%7Bnum_i%7D%29%27%2C+ny%3A%7Bquery%3A%27%24%7Bwhere_s%7D%3ANY%27%7D%7D+++%7D%7D%7D&wt=json&indent=true}
 hits=6 status=0 QTime=1 
   [junit4]   2> 154944 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=id%3A%283+4+6%29&json.facet=%7Bf%3A%7Brange%3A%7Bfield%3A%24%7Bnum_d%7D%2C+start%3A-5%2C+end%3A10%2C+gap%3A5%2C+other%3Aall%2C+++facet%3A%7B+x%3A%27sum%28%24%7Bnum_i%7D%29%27%2C+ny%3A%7Bquery%3A%27%24%7Bwhere_s%7D%3ANY%27%7D%7D+++%7D%7D%7D&wt=json&indent=true}
 hits=3 status=0 QTime=2 
   [junit4]   2> 154957 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&json.facet=%7B+sum1%3A%27sum%28%24%7Bnum_d%7D%29%27%2C+sumsq1%3A%27sumsq%28%24%7Bnum_d%7D%29%27%2C+avg1%3A%27avg%28%24%7Bnum_d%7D%29%27%2C+min1%3A%27min%28%24%7Bnum_d%7D%29%27%2C+max1%3A%27max%28%24%7Bnum_d%7D%29%27%2C+numwhere%3A%27unique%28%24%7Bwhere_s%7D%29%27%2C+med%3A%27percentile%28%24%7Bnum_d%7D%2C50%29%27%2C+perc%3A%27percentile%28%24%7Bnum_d%7D%2C0%2C50.0%2C100%29%27+%7D&wt=json&indent=true}
 hits=6 status=0 QTime=13 
   [junit4]   2> 154958 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=id%3ADOESNOTEXIST&json.facet=%7B+sum1%3A%27sum%28%24%7Bnum_d%7D%29%27%2C+sumsq1%3A%27sumsq%28%24%7Bnum_d%7D%29%27%2C+avg1%3A%27avg%28%24%7Bnum_d%7D%29%27%2C+min1%3A%27min%28%24%7Bnum_d%7D%29%27%2C+max1%3A%27max%28%24%7Bnum_d%7D%29%27%2C+numwhere%3A%27unique%28%24%7Bwhere_s%7D%29%27%2C+med%3A%27percentile%28%24%7Bnum_d%7D%2C50%29%27%2C+perc%3A%27percentile%28%24%7Bnum_d%7D%2C0%2C50.0%2C100%29%27+%7D&wt=json&indent=true}
 hits=0 status=0 QTime=0 
   [junit4]   2> 154964 T635 C141 oassf.UnInvertedField.<init> UnInverted 
multi-valued field 
{field=multi_ss,memSize=4515,tindexSize=41,time=1,phase1=1,nTerms=2,bigTerms=2,termInstances=0,uses=0}
   [junit4]   2> 154965 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&json.facet=%7Bcat%3A%7Bterms%3A%7Bfield%3A%27%24%7Bmulti_ss%7D%27%2C+facet%3A%7Bnj%3A%7Bquery%3A%27%24%7Bwhere_s%7D%3ANJ%27%7D%7D++++%7D+++%7D%7D+%7D&wt=json&indent=true}
 hits=6 status=0 QTime=7 
   [junit4]   2> 154967 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&json.facet=%7Bx%3A%27unique%28%24%7Bmulti_ss%7D%29%27%2C+y%3A%7Bquery%3A%7Bq%3A%27id%3A2%27%2C+facet%3A%7Bx%3A%27unique%28%24%7Bmulti_ss%7D%29%27%7D+%7D%7D+++%7D&wt=json&indent=true}
 hits=6 status=0 QTime=2 
   [junit4]   2> 154968 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&json.facet=%7Bx%3A%7Bterms%3A%7Bfield%3A%27%24%7Bmulti_ss%7D%27%2CallBuckets%3Atrue%7D%7D%7D&wt=json&indent=true}
 hits=6 status=0 QTime=1 
   [junit4]   2> 154970 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&facet=true&facet.version=2&facet.field=%7B%21key%3Df1%7D%24%7Bcat_s%7D&facet.mincount=3&wt=json&indent=true}
 hits=6 status=0 QTime=2 
   [junit4]   2> 154970 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&facet=true&facet.version=2&facet.field=%7B%21key%3Df1%7D%24%7Bsuper_s%7D&facet.prefix=s&facet.mincount=0&wt=json&indent=true}
 hits=6 status=0 QTime=0 
   [junit4]   2> 154973 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&facet=true&facet.version=2&facet.range=%7B%21key%3Df%7D%24%7Bnum_d%7D&facet.range.start=-5&facet.range.end=10&facet.range.gap=5&f.f.facet.stat=x%3Asum%28%24%7Bnum_i%7D%29&subfacet.f.query=%7B%21key%3Dny%7D%24%7Bwhere_s%7D%3ANY&wt=json&indent=true}
 hits=6 status=0 QTime=2 
   [junit4]   2> 154974 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=*%3A*&facet=true&facet.version=2&facet.field=%7B%21key%3Df1%7D%24%7Bcat_s%7D&facet.field=%7B%21key%3Df2%7D%24%7Bcat_s%7D&f.f1.facet.sort=n1+desc&f.f1.facet.sort=n1+asc&facet.stat=n1%3Asum%28%24%7Bnum_d%7D%29&wt=json&indent=true}
 hits=6 status=0 QTime=1 
   [junit4]   2> 154976 T635 C141 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&sparse_s=sparse_s&multi_ss=multi_ss&q=id%3A%283+4+6%29&facet=true&facet.version=2&facet.range=%7B%21key%3Df%7D%24%7Bnum_d%7D&facet.range.start=-5&facet.range.end=10&facet.range.gap=5&f.f.facet.stat=x%3Asum%28%24%7Bnum_i%7D%29&subfacet.f.query=%7B%21key%3Dny%7D%24%7Bwhere_s%7D%3ANY&facet.range.other=all&wt=json&indent=true}
 hits=3 status=0 QTime=2 
   [junit4]   2> 154977 T635 C141 oass.SolrIndexSearcher.<init> Opening 
Searcher@5e92dda2[collection1] realtime
   [junit4]   2> 154978 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {deleteByQuery=*:* (-1498419564990431232)} 0 2
   [junit4]   2> 154978 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[1 
(1498419564992528384)]} 0 0
   [junit4]   2> 154979 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[2 
(1498419564993576960)]} 0 0
   [junit4]   2> 154979 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[3 
(1498419564993576961)]} 0 0
   [junit4]   2> 154979 T635 C141 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 154981 T635 C141 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_d,generation=13}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_e,generation=14}
   [junit4]   2> 154981 T635 C141 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 14
   [junit4]   2> 154982 T635 C141 oass.SolrIndexSearcher.<init> Opening 
Searcher@696c14a5[collection1] main
   [junit4]   2> 154982 T635 C141 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 154983 T637 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@696c14a5[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_c(5.1.0):c3)))}
   [junit4]   2> 154983 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 4
   [junit4]   2> 154985 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[4 
(1498419564998819840)]} 0 1
   [junit4]   2> 154985 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[5 
(1498419564999868416)]} 0 0
   [junit4]   2> 154985 T635 C141 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 154988 T635 C141 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_e,generation=14}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_f,generation=15}
   [junit4]   2> 154988 T635 C141 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 15
   [junit4]   2> 154988 T635 C141 oass.SolrIndexSearcher.<init> Opening 
Searcher@774348f4[collection1] main
   [junit4]   2> 154989 T635 C141 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 154989 T637 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@774348f4[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_c(5.1.0):c3)
 Uninverting(_d(5.1.0):c2)))}
   [junit4]   2> 154989 T635 C141 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 4
   [junit4]   2> ASYNC  NEW_CORE C142 name=collection1 
org.apache.solr.core.SolrCore@438c9256
   [junit4]   2> 155007 T635 C142 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={versions=true&wt=json&indent=true} {add=[6 
(1498419565021888512)]} 0 1
   [junit4]   2> 155007 T635 C142 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 155010 T635 C142 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_f,generation=15}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@2f5fa457 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f4a22d9),segFN=segments_g,generation=16}
   [junit4]   2> 155011 T635 C142 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 16
   [junit4]   2> 155011 T635 C142 oass.SolrIndexSearcher.<init> Opening 
Searcher@f4f27a[collection1] main
   [junit4]   2> 155012 T635 C142 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 155012 T637 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@f4f27a[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_c(5.1.0):c3)
 Uninverting(_d(5.1.0):c2) Uninverting(_e(5.1.0):c1)))}
   [junit4]   2> 155012 T635 C142 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 5
   [junit4]   2> 155014 T635 C142 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={facet=true&rows=0&noexist=noexist_ss&cat_s=cat_ss&where_s=where_ss&num_d=num_d&num_i=num_i&super_s=super_ss&val_b=val_b&sparse_s=sparse_ss&multi_ss=multi_ss&q=*%3A*&json.facet=%7BcatA%3A%7Bquery%3A%7Bq%3A%27%24%7Bcat_s%7D%3AA%27%7D%7D%2C++catA2%3A%7Bquery%3A%7Bquery%3A%27%24%7Bcat_s%7D%3AA%27%7D%7D%2C++catA3%3A%7Bquery%3A%27%24%7Bcat_s%7D%3AA%27%7D++++%7D&wt=json&indent=true}
 hits=6 status=0 QTime=1 
   [junit4]   2> 155015 T635 C142 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={facet=true&rows=0&noexist=noexist_ss&cat_s=cat_ss&where_s=where_ss&num_d=num_d&num_i=num_i&super_s=super_ss&val_b=val_b&sparse_s=sparse_ss&multi_ss=multi_ss&q=*%3A*&json.facet=%7B+catB%3A%7Bquery%3A%7Bq%3A%27%24%7Bcat_s%7D%3AB%27%2C+facet%3A%7Bnj%3A%7Bquery%3A%27%24%7Bwhere_s%7D%3ANJ%27%7D%2C+ny%3A%7Bquery%3A%27%24%7Bwhere_s%7D%3ANY%27%7D%7D+%7D%7D%7D&wt=json&indent=true}
 hits=6 status=0 QTime=1 
   [junit4]   2> 155016 T635 C142 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={facet=true&rows=0&noexist=noexist_ss&cat_s=cat_ss&where_s=where_ss&num_d=num_d&num_i=num_i&super_s=super_ss&val_b=val_b&sparse_s=sparse_ss&multi_ss=multi_ss&q=id%3A%282+3%29&json.facet=%7B+catB%3A%7Bquery%3A%7Bq%3A%27%24%7Bcat_s%7D%3AB%27%2C+facet%3A%7Bnj%3A%7Bquery%3A%27%24%7Bwhere_s%7D%3ANJ%27%7D%2C+ny%3A%7Bquery%3A%27%24%7Bwhere_s%7D%3ANY%27%7D%7D+%7D%7D%7D&wt=json&indent=true}
 hits=2 status=0 QTime=1 
   [junit4]   2> 155017 T635 C142 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={facet=true&rows=0&noexist=noexist_ss&cat_s=cat_ss&where_s=where_ss&num_d=num_d&num_i=num_i&super_s=super_ss&val_b=val_b&sparse_s=sparse_ss&multi_ss=multi_ss&q=*%3A*&json.facet=%7B+catB%3A%7Bquery%3A%7Bq%3A%27%24%7Bcat_s%7D%3AB%27%2C+facet%3A%7Bnj%3A%7Bquery%3A%7Bq%3A%27%24%7Bwhere_s%7D%3ANJ%27%7D%7D%2C+ny%3A%7Bquery%3A%27%24%7Bwhere_s%7D%3ANY%27%7D%7D+%7D%7D%7D&wt=json&indent=true}
 hits=6 status=0 QTime=1 
   [junit4]   2> 155018 T635 C142 oassf.UnInvertedField.<init> UnInverted 
multi-valued field 
{field=cat_ss,memSize=4446,tindexSize=41,time=1,phase1=1,nTerms=2,bigTerms=1,termInstances=2,uses=0}
   [junit4]   2> 155019 T635 C142 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={facet=true&rows=0&noexist=noexist_ss&cat_s=cat_ss&where_s=where_ss&num_d=num_d&num_i=num_i&super_s=super_ss&val_b=val_b&sparse_s=sparse_ss&multi_ss=multi_ss&q=*%3A*&json.facet=%7Bc1%3A%7Bfield%3A%27%24%7Bcat_s%7D%27%7D%2C+c2%3A%7Bfield%3A%7Bfield%3A%27%24%7Bcat_s%7D%27%7D%7D%2C+c3%3A%7Bterms%3A%7Bfield%3A%27%24%7Bcat_s%7D%27%7D%7D++%7D&wt=json&indent=true}
 hits=6 status=0 QTime=2 
   [junit4]   2> 155020 T635 C142 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={facet=true&rows=0&noexist=noexist_ss&cat_s=cat_ss&where_s=where_ss&num_d=num_d&num_i=num_i&super_s=super_ss&val_b=val_b&sparse_s=sparse_ss&multi_ss=multi_ss&q=*%3A*&json.facet=%7Bf1%3A%7Bterms%3A%7Bfield%3A%27%24%7Bcat_s%7D%27%2C+mincount%3A3%7D%7D%7D&wt=json&indent=true}
 hits=6 status=0 QTime=0 
   [junit4]   2> 155021 T635 C142 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={facet=true&rows=0&noexist=noexist_ss&cat_s=cat_ss&where_s=where_ss&num_d=num_d&num_i=num_i&super_s=super_ss&val_b=val_b&sparse_s=sparse_ss&multi_ss=multi_ss&q=id%3A1&json.facet=%7Bf1%3A%7Bterms%3A%27%24%7Bcat_s%7D%27%7D%7D&wt=json&indent=true}
 hits=1 status=0 QTime=0 
   [junit4]   2> 155022 T635 C142 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={facet=true&rows=0&noexist=noexist_ss&cat_s=cat_ss&where_s=where_ss&num_d=num_d&num_i=num_i&super_s=super_ss&val_b=val_b&sparse_s=sparse_ss&multi_ss=multi_ss&q=id%3A1&json.facet=%7BprocessEmpty%3Atrue%2C+f1%3A%7Bterms%3A%7Bfield%3A%27%24%7Bcat_s%7D%27%2C+mincount%3A0%7D%7D%7D&wt=json&indent=true}
 hits=1 status=0 QTime=0 
   [junit4]   2> 155023 T635 C142 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={facet=true&rows=0&noexist=noexist_ss&cat_s=cat_ss&where_s=where_ss&num_d=num_d&num_i=num_i&super_s=super_ss&val_b=val_b&sparse_s=sparse_ss&multi_ss=multi_ss&q=id%3A1&json.facet=%7BprocessEmpty%3Atrue%2C+f1%3A%7Bterms%3A%7Bfield%3A%27%24%7Bcat_s%7D%27%2C+mincount%3A0%2C+allBuckets%3Atrue%2C+facet%3A%7Bn1%3A%27sum%28%24%7Bnum_d%7D%29%27%7D++%7D%7D%7D&wt=json&indent=true}
 hits=1 status=0 QTime=1 
   [junit4]   2> 155024 T635 C142 oasc.SolrCore.execute [collection1] 
webapp=null path=null 
params={facet=true&rows=0&noexist=noexist_ss&cat_s=cat_ss&where_s=where_ss&num_d=num_d&num_i=num_i&super_s=super_ss&val_b=val_b&sparse_s=sparse_ss&multi_ss=multi_ss&q=*%3A*&json.facet=%7Bf1%3A%7Bterms%3A%7Bfield%3A%27%24%7Bcat_s%7D%27%2C+sort%3A

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

;done=false>>]
   [junit4]   2> 158209 T635 oasc.CachingDirectoryFactory.close Closing 
directory: 
/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/build/solr-core/test/J0/temp/solr.search.facet.TestJsonFacets
 96EEB6032CF4572D-001/s1-001/./collection1/data/index
   [junit4]   2> 158210 T635 oejsh.ContextHandler.doStop stopped 
o.e.j.s.ServletContextHandler{/solr,null}
   [junit4]   2> 158423 T635 oasc.CoreContainer.shutdown Shutting down 
CoreContainer instance=1496525204
   [junit4]   2> 158424 T635 oasc.SolrCore.close [collection1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@35c1208a
   [junit4]   2> 158424 T635 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=15,autocommits=0,soft 
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=10,cumulative_deletesById=0,cumulative_deletesByQuery=5,cumulative_errors=0,transaction_logs_total_size=1814,transaction_logs_total_number=10}
   [junit4]   2> 158424 T635 oasu.SolrCoreState.decrefSolrCoreState Closing 
SolrCoreState
   [junit4]   2> 158424 T635 oasu.DefaultSolrCoreState.closeIndexWriter 
SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 158425 T635 oasu.DefaultSolrCoreState.closeIndexWriter closing 
IndexWriter with IndexWriterCloser
   [junit4]   2> 158425 T635 oasc.SolrCore.closeSearcher [collection1] Closing 
main searcher on request.
   [junit4]   2> 158443 T635 oasc.CachingDirectoryFactory.close Closing 
MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 158443 T635 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/build/solr-core/test/J0/temp/solr.search.facet.TestJsonFacets
 96EEB6032CF4572D-001/s2-001/./collection1/data 
[CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/build/solr-core/test/J0/temp/solr.search.facet.TestJsonFacets
 96EEB6032CF4572D-001/s2-001/./collection1/data;done=false>>]
   [junit4]   2> 158443 T635 oasc.CachingDirectoryFactory.close Closing 
directory: 
/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/build/solr-core/test/J0/temp/solr.search.facet.TestJsonFacets
 96EEB6032CF4572D-001/s2-001/./collection1/data
   [junit4]   2> 158444 T635 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/build/solr-core/test/J0/temp/solr.search.facet.TestJsonFacets
 96EEB6032CF4572D-001/s2-001/./collection1/data/index 
[CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/build/solr-core/test/J0/temp/solr.search.facet.TestJsonFacets
 96EEB6032CF4572D-001/s2-001/./collection1/data/index;done=false>>]
   [junit4]   2> 158444 T635 oasc.CachingDirectoryFactory.close Closing 
directory: 
/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/build/solr-core/test/J0/temp/solr.search.facet.TestJsonFacets
 96EEB6032CF4572D-001/s2-001/./collection1/data/index
   [junit4]   2> 158445 T635 oejsh.ContextHandler.doStop stopped 
o.e.j.s.ServletContextHandler{/solr,null}
   [junit4]   2> 158613 T635 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> 158614 T635 oasc.CoreContainer.shutdown Shutting down 
CoreContainer instance=143808625
   [junit4]   2> 158614 T635 oasc.SolrCore.close [collection1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@438c9256
   [junit4]   2> 158614 T635 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=27,autocommits=0,soft 
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=141,cumulative_deletesById=0,cumulative_deletesByQuery=7,cumulative_errors=0,transaction_logs_total_size=2409,transaction_logs_total_number=10}
   [junit4]   2> 158614 T635 oasu.SolrCoreState.decrefSolrCoreState Closing 
SolrCoreState
   [junit4]   2> 158614 T635 oasu.DefaultSolrCoreState.closeIndexWriter 
SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 158615 T635 oasu.DefaultSolrCoreState.closeIndexWriter closing 
IndexWriter with IndexWriterCloser
   [junit4]   2> 158615 T635 oasc.SolrCore.closeSearcher [collection1] Closing 
main searcher on request.
   [junit4]   2> 158618 T635 oasc.CachingDirectoryFactory.close Closing 
MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 158618 T635 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/build/solr-core/test/J0/temp/solr.search.facet.TestJsonFacets
 96EEB6032CF4572D-001/init-core-data-001 
[CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/build/solr-core/test/J0/temp/solr.search.facet.TestJsonFacets
 96EEB6032CF4572D-001/init-core-data-001;done=false>>]
   [junit4]   2> 158618 T635 oasc.CachingDirectoryFactory.close Closing 
directory: 
/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/build/solr-core/test/J0/temp/solr.search.facet.TestJsonFacets
 96EEB6032CF4572D-001/init-core-data-001
   [junit4]   2> 158619 T635 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/build/solr-core/test/J0/temp/solr.search.facet.TestJsonFacets
 96EEB6032CF4572D-001/init-core-data-001/index 
[CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/build/solr-core/test/J0/temp/solr.search.facet.TestJsonFacets
 96EEB6032CF4572D-001/init-core-data-001/index;done=false>>]
   [junit4]   2> 158619 T635 oasc.CachingDirectoryFactory.close Closing 
directory: 
/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/build/solr-core/test/J0/temp/solr.search.facet.TestJsonFacets
 96EEB6032CF4572D-001/init-core-data-001/index
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/build/solr-core/test/J0/temp/solr.search.facet.TestJsonFacets
 96EEB6032CF4572D-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene50): 
{num_dd=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 super_s=PostingsFormat(name=Memory doPackFST= true), 
cat_sds=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 where_sds=PostingsFormat(name=Asserting), 
super_sds=PostingsFormat(name=Asserting), 
cat_ss=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 sparse_ss=PostingsFormat(name=Memory doPackFST= true), 
super_sd=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 where_s=PostingsFormat(name=Memory doPackFST= true), sparse_sd=FST50, 
id=PostingsFormat(name=Memory doPackFST= true), multi_ss=FST50, 
sparse_sds=PostingsFormat(name=Memory doPackFST= true), 
cat_sd=PostingsFormat(name=Asserting), super_ss=FST50, 
val_b=PostingsFormat(name=Asserting), multi_sds=FST50, cat_s=FST50, 
where_sd=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 make_s=PostingsFormat(name=Asserting), num_id=FST50, 
num_d=PostingsFormat(name=Memory doPackFST= true), 
num_i=PostingsFormat(name=Asserting), _version_=PostingsFormat(name=Asserting), 
cost_f=FST50, sparse_s=PostingsFormat(name=Asserting), 
where_ss=PostingsFormat(name=Asserting), 
model_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128)))},
 docValues:{super_sds=DocValuesFormat(name=Lucene50), 
num_dd=DocValuesFormat(name=Lucene50), sparse_sds=DocValuesFormat(name=Memory), 
super_sd=DocValuesFormat(name=Lucene50), cat_sd=DocValuesFormat(name=Lucene50), 
cat_sds=DocValuesFormat(name=Lucene50), 
multi_sds=DocValuesFormat(name=Asserting), 
where_sds=DocValuesFormat(name=Lucene50), 
where_sd=DocValuesFormat(name=Lucene50), 
sparse_sd=DocValuesFormat(name=Asserting), 
num_id=DocValuesFormat(name=Asserting)}, sim=DefaultSimilarity, locale=pt_BR, 
timezone=Africa/Asmara
   [junit4]   2> NOTE: Linux 3.13.0-49-generic amd64/Oracle Corporation 
1.8.0_40 (64-bit)/cpus=12,threads=1,free=172852512,total=424148992
   [junit4]   2> NOTE: All tests run in this JVM: [TestBulkSchemaAPI, 
HighlighterTest, TestConfig, TestAddFieldRealTimeGet, 
TestOverriddenPrefixQueryForCustomFieldType, SuggesterFSTTest, 
LeaderElectionIntegrationTest, TestIBSimilarityFactory, SimplePostToolTest, 
PreAnalyzedUpdateProcessorTest, DocExpirationUpdateProcessorFactoryTest, 
TestInitParams, TestSolrDynamicMBean, TestRandomFaceting, 
CurrencyFieldXmlFileTest, TestBadConfig, SolrIndexConfigTest, 
TestCollectionAPI, TestFaceting, PrimitiveFieldTypeTest, 
TestClassNameShortening, TestJsonFacets]
   [junit4] Completed on J0 in 4.22s, 4 tests, 1 error <<< FAILURES!

[...truncated 1244 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-5.1-Linux/build.xml:529: The following 
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.1-Linux/build.xml:477: The following 
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.1-Linux/build.xml:61: The following error 
occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.1-Linux/extra-targets.xml:39: The 
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/build.xml:191: The following 
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.1-Linux/solr/common-build.xml:509: The 
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.1-Linux/lucene/common-build.xml:1370: The 
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.1-Linux/lucene/common-build.xml:976: 
There were test failures: 480 suites, 1909 tests, 1 error, 48 ignored (21 
assumptions)

Total time: 42 minutes 57 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 64bit/jdk1.8.0_40 
-XX:-UseCompressedOops -XX:+UseParallelGC
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