You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2015/03/21 15:25:05 UTC

[JENKINS] Lucene-Solr-trunk-Linux (64bit/jdk1.8.0_60-ea-b06) - Build # 12037 - Still Failing!

Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/12037/
Java: 64bit/jdk1.8.0_60-ea-b06 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC

1 tests failed.
FAILED:  junit.framework.TestSuite.org.apache.solr.search.json.TestJsonRequest

Error Message:
Clean up static fields (in @AfterClass?), your test seems to hang on to approximately 12,071,296 bytes (threshold is 10,485,760). Field reference sizes (counted individually):   - 12,876,760 bytes, private static org.apache.solr.SolrTestCaseHS$SolrInstances org.apache.solr.search.json.TestJsonRequest.servers   - 296 bytes, public static org.junit.rules.TestRule org.apache.solr.SolrTestCaseJ4.solrClassRules   - 216 bytes, protected static java.lang.String org.apache.solr.SolrTestCaseJ4.testSolrHome   - 144 bytes, private static java.lang.String org.apache.solr.SolrTestCaseJ4.factoryProp   - 80 bytes, private static java.lang.String org.apache.solr.SolrTestCaseJ4.coreName

Stack Trace:
junit.framework.AssertionFailedError: Clean up static fields (in @AfterClass?), your test seems to hang on to approximately 12,071,296 bytes (threshold is 10,485,760). Field reference sizes (counted individually):
  - 12,876,760 bytes, private static org.apache.solr.SolrTestCaseHS$SolrInstances org.apache.solr.search.json.TestJsonRequest.servers
  - 296 bytes, public static org.junit.rules.TestRule org.apache.solr.SolrTestCaseJ4.solrClassRules
  - 216 bytes, protected static java.lang.String org.apache.solr.SolrTestCaseJ4.testSolrHome
  - 144 bytes, private static java.lang.String org.apache.solr.SolrTestCaseJ4.factoryProp
  - 80 bytes, private static java.lang.String org.apache.solr.SolrTestCaseJ4.coreName
	at __randomizedtesting.SeedInfo.seed([722868BB8C87E875]:0)
	at com.carrotsearch.randomizedtesting.rules.StaticFieldsInvariantRule$1.afterAlways(StaticFieldsInvariantRule.java:127)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43)
	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 10403 lines...]
   [junit4] Suite: org.apache.solr.search.json.TestJsonRequest
   [junit4]   2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/init-core-data-001
   [junit4]   2> 1328102 T9723 oas.SolrTestCaseJ4.initCore ####initCore
   [junit4]   2> 1328102 T9723 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 1328102 T9723 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 1328102 T9723 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 1328112 T9723 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
   [junit4]   2> 1328115 T9723 oasc.SolrConfig.<init> Using Lucene MatchVersion: 6.0.0
   [junit4]   2> 1328127 T9723 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-tlog.xml
   [junit4]   2> 1328128 T9723 oass.IndexSchema.readSchema Reading Solr Schema from /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/schema_latest.xml
   [junit4]   2> 1328131 T9723 oass.IndexSchema.readSchema [null] Schema name=example
   [junit4]   2> 1328176 T9723 oass.AbstractSpatialFieldType.init WARN units parameter is deprecated, please use distanceUnits instead for field types with class SpatialRecursivePrefixTreeFieldType
   [junit4]   2> 1328179 T9723 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 1328182 T9723 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 1328183 T9723 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 1328184 T9723 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1328184 T9723 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr
   [junit4]   2> 1328185 T9723 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/'
   [junit4]   2> 1328192 T9723 oasc.CoreContainer.<init> New CoreContainer 1162776101
   [junit4]   2> 1328192 T9723 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/]
   [junit4]   2> 1328192 T9723 oasc.CoreContainer.load loading shared library: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/lib
   [junit4]   2> 1328193 T9723 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: lib (resolved as: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/lib).
   [junit4]   2> 1328196 T9723 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 600000
   [junit4]   2> 1328196 T9723 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: null
   [junit4]   2> 1328196 T9723 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 60000
   [junit4]   2> 1328196 T9723 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 1328196 T9723 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000
   [junit4]   2> 1328197 T9723 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 1328197 T9723 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 1328197 T9723 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 1328197 T9723 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 1328197 T9723 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 1328197 T9723 oashc.HttpShardHandlerFactory.getParameter Setting useRetries to: false
   [junit4]   2> 1328197 T9723 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true
   [junit4]   2> 1328198 T9723 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1328198 T9723 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1328198 T9723 oasc.CoreContainer.load Node Name: testNode
   [junit4]   2> 1328198 T9723 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-trunk-Linux/solr/core/src/test-files/solr/collection1/, dataDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/init-core-data-001, shard=shard1}
   [junit4]   2> 1328199 T9724 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 1328199 T9724 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 1328199 T9724 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 1328208 T9724 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
   [junit4]   2> 1328211 T9724 oasc.SolrConfig.<init> Using Lucene MatchVersion: 6.0.0
   [junit4]   2> 1328226 T9724 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-tlog.xml
   [junit4]   2> 1328226 T9724 oass.IndexSchema.readSchema Reading Solr Schema from /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/schema_latest.xml
   [junit4]   2> 1328229 T9724 oass.IndexSchema.readSchema [collection1] Schema name=example
   [junit4]   2> 1328311 T9724 oass.AbstractSpatialFieldType.init WARN units parameter is deprecated, please use distanceUnits instead for field types with class SpatialRecursivePrefixTreeFieldType
   [junit4]   2> 1328314 T9724 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 1328317 T9724 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 1328319 T9724 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 1328320 T9724 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 1328320 T9724 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1328320 T9724 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/, dataDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/init-core-data-001/
   [junit4]   2> 1328320 T9724 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7e17f4e2
   [junit4]   2> 1328320 T9724 oasc.CachingDirectoryFactory.get return new directory for /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/init-core-data-001
   [junit4]   2> 1328320 T9724 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/init-core-data-001/index/
   [junit4]   2> 1328321 T9724 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/init-core-data-001/index' doesn't exist. Creating new index...
   [junit4]   2> 1328321 T9724 oasc.CachingDirectoryFactory.get return new directory for /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/init-core-data-001/index
   [junit4]   2> 1328321 T9724 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=12, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=80.5986328125, floorSegmentMB=0.595703125, forceMergeDeletesPctAllowed=25.82588459253664, segmentsPerTier=24.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7486258476698779
   [junit4]   2> 1328321 T9724 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@7c7982d8 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@11ae176),segFN=segments_1,generation=1}
   [junit4]   2> 1328322 T9724 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 1328324 T9724 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib"
   [junit4]   2> 1328324 T9724 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
   [junit4]   2> 1328324 T9724 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 1328324 T9724 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1328324 T9724 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1328324 T9724 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 1328324 T9724 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1328325 T9724 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1328325 T9724 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1328325 T9724 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1328326 T9724 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1328327 T9724 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1328327 T9724 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1328329 T9724 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> 1328329 T9724 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1328329 T9724 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1328329 T9724 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
   [junit4]   2> 1328330 T9724 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 1328330 T9724 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 1328330 T9724 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=15, maxMergeAtOnceExplicit=34, maxMergedSegmentMB=43.1953125, floorSegmentMB=2.037109375, forceMergeDeletesPctAllowed=1.182127493333277, segmentsPerTier=37.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1328330 T9724 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@7c7982d8 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@11ae176),segFN=segments_1,generation=1}
   [junit4]   2> 1328330 T9724 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 1328331 T9724 oass.SolrIndexSearcher.<init> Opening Searcher@5d760424[collection1] main
   [junit4]   2> 1328331 T9724 oasr.ManagedResourceStorage.newStorageIO WARN Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
   [junit4]   2> 1328331 T9724 oasr.RestManager.init Initializing RestManager with initArgs: {}
   [junit4]   2> 1328331 T9724 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
   [junit4]   2> 1328331 T9724 oasr.RestManager.init Initializing 0 registered ManagedResources
   [junit4]   2> 1328331 T9724 oash.ReplicationHandler.inform Commits will be reserved for  10000
   [junit4]   2> 1328332 T9724 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 1328332 T9725 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5d760424[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1328333 T9723 oas.SolrTestCaseJ4.initCore ####initCore end
   [junit4]   2> 1328335 T9723 oas.SolrTestCaseJ4.setUp ###Starting testDistribJsonRequest
   [junit4]   2> 1328342 T9723 oejs.Server.doStart jetty-9.2.9.v20150224
   [junit4]   2> 1328343 T9723 oejsh.ContextHandler.doStart Started o.e.j.s.ServletContextHandler@3197a179{/solr,null,AVAILABLE}
   [junit4]   2> 1328345 T9723 oejs.AbstractConnector.doStart Started ServerConnector@59f6a2bd{HTTP/1.1}{127.0.0.1:49577}
   [junit4]   2> 1328346 T9723 oejs.Server.doStart Started @1329297ms
   [junit4]   2> 1328346 T9723 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {schema=schema_latest.xml, solrconfig=solrconfig-tlog.xml, hostContext=/solr, hostPort=49577}
   [junit4]   2> 1328347 T9723 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@4e0e2f2a
   [junit4]   2> 1328347 T9723 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s0-001/'
   [junit4]   2> 1328375 T9723 oasc.SolrXmlConfig.fromFile Loading container configuration from /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s0-001/solr.xml
   [junit4]   2> 1328379 T9723 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s0-001/.
   [junit4]   2> 1328380 T9723 oasc.CoreContainer.<init> New CoreContainer 1478739593
   [junit4]   2> 1328380 T9723 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s0-001/]
   [junit4]   2> 1328380 T9723 oasc.CoreContainer.load loading shared library: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s0-001/lib
   [junit4]   2> 1328381 T9723 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: lib (resolved as: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s0-001/lib).
   [junit4]   2> 1328387 T9723 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
   [junit4]   2> 1328388 T9723 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: 
   [junit4]   2> 1328388 T9723 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
   [junit4]   2> 1328388 T9723 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 1328388 T9723 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000
   [junit4]   2> 1328389 T9723 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 1328389 T9723 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 1328389 T9723 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 1328389 T9723 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 1328390 T9723 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 1328390 T9723 oashc.HttpShardHandlerFactory.getParameter Setting useRetries to: false
   [junit4]   2> 1328390 T9723 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1328391 T9723 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1328391 T9723 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1328391 T9723 oasc.CoreContainer.load Node Name: 127.0.0.1
   [junit4]   2> 1328392 T9723 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s0-001/.
   [junit4]   2> 1328393 T9723 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {name=collection1, config=solrconfig-tlog.xml, instanceDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s0-001/./collection1, loadOnStartup=true, absoluteInstDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s0-001/./collection1/, schema=schema_latest.xml, transient=false, dataDir=data/}
   [junit4]   2> 1328393 T9723 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s0-001/./collection1/
   [junit4]   2> 1328393 T9723 oasc.CorePropertiesLocator.discover Found 1 core definitions
   [junit4]   2> 1328394 T9738 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s0-001/./collection1/'
   [junit4]   2> 1328409 T9738 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
   [junit4]   2> 1328413 T9738 oasc.SolrConfig.<init> Using Lucene MatchVersion: 6.0.0
   [junit4]   2> 1328423 T9738 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-tlog.xml
   [junit4]   2> 1328424 T9738 oass.IndexSchema.readSchema Reading Solr Schema from /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s0-001/./collection1/conf/schema_latest.xml
   [junit4]   2> 1328427 T9738 oass.IndexSchema.readSchema [collection1] Schema name=example
   [junit4]   2> 1328500 T9738 oass.AbstractSpatialFieldType.init WARN units parameter is deprecated, please use distanceUnits instead for field types with class SpatialRecursivePrefixTreeFieldType
   [junit4]   2> 1328503 T9738 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 1328508 T9738 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 1328509 T9738 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 1328511 T9738 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s0-001/./collection1/
   [junit4]   2> 1328511 T9738 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1328511 T9738 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s0-001/./collection1/, dataDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s0-001/./collection1/data/
   [junit4]   2> 1328511 T9738 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7e17f4e2
   [junit4]   2> 1328512 T9738 oasc.CachingDirectoryFactory.get return new directory for /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s0-001/./collection1/data
   [junit4]   2> 1328512 T9738 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s0-001/./collection1/data/index/
   [junit4]   2> 1328512 T9738 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s0-001/./collection1/data/index' doesn't exist. Creating new index...
   [junit4]   2> 1328513 T9738 oasc.CachingDirectoryFactory.get return new directory for /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s0-001/./collection1/data/index
   [junit4]   2> 1328513 T9738 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=12, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=80.5986328125, floorSegmentMB=0.595703125, forceMergeDeletesPctAllowed=25.82588459253664, segmentsPerTier=24.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7486258476698779
   [junit4]   2> 1328513 T9738 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@1dec91d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3222e23e),segFN=segments_1,generation=1}
   [junit4]   2> 1328514 T9738 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 1328518 T9738 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib"
   [junit4]   2> 1328518 T9738 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
   [junit4]   2> 1328518 T9738 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 1328518 T9738 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1328518 T9738 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1328519 T9738 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 1328519 T9738 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1328519 T9738 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1328519 T9738 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1328521 T9738 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1328522 T9738 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1328523 T9738 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1328524 T9738 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1328528 T9738 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> 1328529 T9738 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1328529 T9738 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1328529 T9738 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
   [junit4]   2> 1328530 T9738 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 1328530 T9738 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 1328531 T9738 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=15, maxMergeAtOnceExplicit=34, maxMergedSegmentMB=43.1953125, floorSegmentMB=2.037109375, forceMergeDeletesPctAllowed=1.182127493333277, segmentsPerTier=37.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1328531 T9738 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@1dec91d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3222e23e),segFN=segments_1,generation=1}
   [junit4]   2> 1328531 T9738 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 1328532 T9738 oass.SolrIndexSearcher.<init> Opening Searcher@2730efb8[collection1] main
   [junit4]   2> 1328532 T9738 oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s0-001/./collection1/conf
   [junit4]   2> 1328532 T9738 oasr.RestManager.init Initializing RestManager with initArgs: {storageDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s0-001/./collection1/conf}
   [junit4]   2> 1328532 T9738 oasr.ManagedResourceStorage.load Reading _rest_managed.json using file:dir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s0-001/./collection1/conf
   [junit4]   2> 1328533 T9738 oasr.RestManager.init Initializing 0 registered ManagedResources
   [junit4]   2> 1328533 T9738 oash.ReplicationHandler.inform Commits will be reserved for  10000
   [junit4]   2> 1328533 T9739 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2730efb8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1328534 T9738 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 1328538 T9723 oass.SolrDispatchFilter.init user.dir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2
   [junit4]   2> 1328539 T9723 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 1328539 T9723 oas.SolrTestCaseHS$SolrInstance.start ===> Started solr server port=49577 home=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s0-001
   [junit4]   2> 1328543 T9723 oejs.Server.doStart jetty-9.2.9.v20150224
   [junit4]   2> 1328544 T9723 oejsh.ContextHandler.doStart Started o.e.j.s.ServletContextHandler@5ee815ca{/solr,null,AVAILABLE}
   [junit4]   2> 1328545 T9723 oejs.AbstractConnector.doStart Started ServerConnector@2eea3eb{HTTP/1.1}{127.0.0.1:37548}
   [junit4]   2> 1328545 T9723 oejs.Server.doStart Started @1329496ms
   [junit4]   2> 1328545 T9723 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {schema=schema_latest.xml, solrconfig=solrconfig-tlog.xml, hostContext=/solr, hostPort=37548}
   [junit4]   2> 1328545 T9723 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@4e0e2f2a
   [junit4]   2> 1328545 T9723 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s1-001/'
   [junit4]   2> 1328553 T9723 oasc.SolrXmlConfig.fromFile Loading container configuration from /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s1-001/solr.xml
   [junit4]   2> 1328556 T9723 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s1-001/.
   [junit4]   2> 1328556 T9723 oasc.CoreContainer.<init> New CoreContainer 156132871
   [junit4]   2> 1328556 T9723 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s1-001/]
   [junit4]   2> 1328556 T9723 oasc.CoreContainer.load loading shared library: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s1-001/lib
   [junit4]   2> 1328557 T9723 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: lib (resolved as: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s1-001/lib).
   [junit4]   2> 1328560 T9723 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
   [junit4]   2> 1328561 T9723 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: 
   [junit4]   2> 1328561 T9723 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
   [junit4]   2> 1328561 T9723 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 1328561 T9723 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000
   [junit4]   2> 1328561 T9723 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 1328561 T9723 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 1328562 T9723 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 1328562 T9723 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 1328562 T9723 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 1328562 T9723 oashc.HttpShardHandlerFactory.getParameter Setting useRetries to: false
   [junit4]   2> 1328563 T9723 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1328563 T9723 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1328563 T9723 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1328563 T9723 oasc.CoreContainer.load Node Name: 127.0.0.1
   [junit4]   2> 1328564 T9723 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s1-001/.
   [junit4]   2> 1328564 T9723 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {name=collection1, config=solrconfig-tlog.xml, instanceDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s1-001/./collection1, loadOnStartup=true, absoluteInstDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s1-001/./collection1/, schema=schema_latest.xml, transient=false, dataDir=data/}
   [junit4]   2> 1328564 T9723 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s1-001/./collection1/
   [junit4]   2> 1328565 T9723 oasc.CorePropertiesLocator.discover Found 1 core definitions
   [junit4]   2> 1328565 T9752 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s1-001/./collection1/'
   [junit4]   2> 1328573 T9752 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
   [junit4]   2> 1328576 T9752 oasc.SolrConfig.<init> Using Lucene MatchVersion: 6.0.0
   [junit4]   2> 1328583 T9752 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-tlog.xml
   [junit4]   2> 1328583 T9752 oass.IndexSchema.readSchema Reading Solr Schema from /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s1-001/./collection1/conf/schema_latest.xml
   [junit4]   2> 1328585 T9752 oass.IndexSchema.readSchema [collection1] Schema name=example
   [junit4]   2> 1328635 T9752 oass.AbstractSpatialFieldType.init WARN units parameter is deprecated, please use distanceUnits instead for field types with class SpatialRecursivePrefixTreeFieldType
   [junit4]   2> 1328637 T9752 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 1328640 T9752 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 1328641 T9752 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 1328642 T9752 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s1-001/./collection1/
   [junit4]   2> 1328642 T9752 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1328642 T9752 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s1-001/./collection1/, dataDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s1-001/./collection1/data/
   [junit4]   2> 1328642 T9752 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7e17f4e2
   [junit4]   2> 1328643 T9752 oasc.CachingDirectoryFactory.get return new directory for /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s1-001/./collection1/data
   [junit4]   2> 1328643 T9752 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s1-001/./collection1/data/index/
   [junit4]   2> 1328643 T9752 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s1-001/./collection1/data/index' doesn't exist. Creating new index...
   [junit4]   2> 1328643 T9752 oasc.CachingDirectoryFactory.get return new directory for /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s1-001/./collection1/data/index
   [junit4]   2> 1328643 T9752 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=12, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=80.5986328125, floorSegmentMB=0.595703125, forceMergeDeletesPctAllowed=25.82588459253664, segmentsPerTier=24.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7486258476698779
   [junit4]   2> 1328644 T9752 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@7b532df3 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@46a6eb9b),segFN=segments_1,generation=1}
   [junit4]   2> 1328644 T9752 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 1328646 T9752 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib"
   [junit4]   2> 1328647 T9752 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
   [junit4]   2> 1328647 T9752 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 1328647 T9752 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1328647 T9752 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1328647 T9752 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 1328647 T9752 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1328647 T9752 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1328647 T9752 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1328648 T9752 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1328649 T9752 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1328649 T9752 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1328650 T9752 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1328652 T9752 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> 1328653 T9752 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1328653 T9752 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1328653 T9752 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
   [junit4]   2> 1328653 T9752 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 1328654 T9752 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 1328654 T9752 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=15, maxMergeAtOnceExplicit=34, maxMergedSegmentMB=43.1953125, floorSegmentMB=2.037109375, forceMergeDeletesPctAllowed=1.182127493333277, segmentsPerTier=37.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1328654 T9752 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@7b532df3 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@46a6eb9b),segFN=segments_1,generation=1}
   [junit4]   2> 1328654 T9752 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 1328654 T9752 oass.SolrIndexSearcher.<init> Opening Searcher@62916924[collection1] main
   [junit4]   2> 1328655 T9752 oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s1-001/./collection1/conf
   [junit4]   2> 1328655 T9752 oasr.RestManager.init Initializing RestManager with initArgs: {storageDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s1-001/./collection1/conf}
   [junit4]   2> 1328655 T9752 oasr.ManagedResourceStorage.load Reading _rest_managed.json using file:dir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s1-001/./collection1/conf
   [junit4]   2> 1328655 T9752 oasr.RestManager.init Initializing 0 registered ManagedResources
   [junit4]   2> 1328655 T9752 oash.ReplicationHandler.inform Commits will be reserved for  10000
   [junit4]   2> 1328656 T9753 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@62916924[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1328656 T9752 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 1328656 T9723 oass.SolrDispatchFilter.init user.dir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2
   [junit4]   2> 1328656 T9723 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 1328656 T9723 oas.SolrTestCaseHS$SolrInstance.start ===> Started solr server port=37548 home=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s1-001
   [junit4]   2> 1328661 T9723 oejs.Server.doStart jetty-9.2.9.v20150224
   [junit4]   2> 1328662 T9723 oejsh.ContextHandler.doStart Started o.e.j.s.ServletContextHandler@622e6ece{/solr,null,AVAILABLE}
   [junit4]   2> 1328662 T9723 oejs.AbstractConnector.doStart Started ServerConnector@4e61b65{HTTP/1.1}{127.0.0.1:41988}
   [junit4]   2> 1328663 T9723 oejs.Server.doStart Started @1329614ms
   [junit4]   2> 1328663 T9723 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {schema=schema_latest.xml, solrconfig=solrconfig-tlog.xml, hostContext=/solr, hostPort=41988}
   [junit4]   2> 1328663 T9723 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@4e0e2f2a
   [junit4]   2> 1328663 T9723 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s2-001/'
   [junit4]   2> 1328672 T9723 oasc.SolrXmlConfig.fromFile Loading container configuration from /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s2-001/solr.xml
   [junit4]   2> 1328675 T9723 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s2-001/.
   [junit4]   2> 1328676 T9723 oasc.CoreContainer.<init> New CoreContainer 354890413
   [junit4]   2> 1328676 T9723 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s2-001/]
   [junit4]   2> 1328676 T9723 oasc.CoreContainer.load loading shared library: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s2-001/lib
   [junit4]   2> 1328676 T9723 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: lib (resolved as: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s2-001/lib).
   [junit4]   2> 1328680 T9723 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
   [junit4]   2> 1328680 T9723 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: 
   [junit4]   2> 1328680 T9723 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
   [junit4]   2> 1328681 T9723 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 1328681 T9723 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000
   [junit4]   2> 1328681 T9723 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 1328681 T9723 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 1328681 T9723 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 1328681 T9723 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 1328682 T9723 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 1328682 T9723 oashc.HttpShardHandlerFactory.getParameter Setting useRetries to: false
   [junit4]   2> 1328683 T9723 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1328683 T9723 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1328683 T9723 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1328683 T9723 oasc.CoreContainer.load Node Name: 127.0.0.1
   [junit4]   2> 1328684 T9723 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s2-001/.
   [junit4]   2> 1328684 T9723 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {name=collection1, config=solrconfig-tlog.xml, instanceDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s2-001/./collection1, loadOnStartup=true, absoluteInstDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s2-001/./collection1/, schema=schema_latest.xml, transient=false, dataDir=data/}
   [junit4]   2> 1328684 T9723 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s2-001/./collection1/
   [junit4]   2> 1328684 T9723 oasc.CorePropertiesLocator.discover Found 1 core definitions
   [junit4]   2> 1328685 T9766 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s2-001/./collection1/'
   [junit4]   2> 1328693 T9766 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
   [junit4]   2> 1328696 T9766 oasc.SolrConfig.<init> Using Lucene MatchVersion: 6.0.0
   [junit4]   2> 1328703 T9766 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-tlog.xml
   [junit4]   2> 1328703 T9766 oass.IndexSchema.readSchema Reading Solr Schema from /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s2-001/./collection1/conf/schema_latest.xml
   [junit4]   2> 1328705 T9766 oass.IndexSchema.readSchema [collection1] Schema name=example
   [junit4]   2> 1328760 T9766 oass.AbstractSpatialFieldType.init WARN units parameter is deprecated, please use distanceUnits instead for field types with class SpatialRecursivePrefixTreeFieldType
   [junit4]   2> 1328762 T9766 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 1328765 T9766 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 1328767 T9766 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 1328768 T9766 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s2-001/./collection1/
   [junit4]   2> 1328768 T9766 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1328768 T9766 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s2-001/./collection1/, dataDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s2-001/./collection1/data/
   [junit4]   2> 1328768 T9766 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7e17f4e2
   [junit4]   2> 1328768 T9766 oasc.CachingDirectoryFactory.get return new directory for /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s2-001/./collection1/data
   [junit4]   2> 1328768 T9766 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s2-001/./collection1/data/index/
   [junit4]   2> 1328769 T9766 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s2-001/./collection1/data/index' doesn't exist. Creating new index...
   [junit4]   2> 1328769 T9766 oasc.CachingDirectoryFactory.get return new directory for /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s2-001/./collection1/data/index
   [junit4]   2> 1328769 T9766 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=12, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=80.5986328125, floorSegmentMB=0.595703125, forceMergeDeletesPctAllowed=25.82588459253664, segmentsPerTier=24.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7486258476698779
   [junit4]   2> 1328769 T9766 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@39cbfe6d lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@60961c5f),segFN=segments_1,generation=1}
   [junit4]   2> 1328769 T9766 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 1328772 T9766 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib"
   [junit4]   2> 1328772 T9766 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
   [junit4]   2> 1328772 T9766 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 1328772 T9766 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1328772 T9766 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1328773 T9766 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 1328773 T9766 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1328773 T9766 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1328773 T9766 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1328774 T9766 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1328775 T9766 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1328775 T9766 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1328776 T9766 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1328778 T9766 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> 1328779 T9766 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1328779 T9766 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1328779 T9766 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
   [junit4]   2> 1328779 T9766 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 1328779 T9766 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 1328780 T9766 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=15, maxMergeAtOnceExplicit=34, maxMergedSegmentMB=43.1953125, floorSegmentMB=2.037109375, forceMergeDeletesPctAllowed=1.182127493333277, segmentsPerTier=37.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1328780 T9766 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@39cbfe6d lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@60961c5f),segFN=segments_1,generation=1}
   [junit4]   2> 1328780 T9766 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 1328780 T9766 oass.SolrIndexSearcher.<init> Opening Searcher@627b16c8[collection1] main
   [junit4]   2> 1328781 T9766 oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s2-001/./collection1/conf
   [junit4]   2> 1328781 T9766 oasr.RestManager.init Initializing RestManager with initArgs: {storageDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s2-001/./collection1/conf}
   [junit4]   2> 1328781 T9766 oasr.ManagedResourceStorage.load Reading _rest_managed.json using file:dir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s2-001/./collection1/conf
   [junit4]   2> 1328781 T9766 oasr.RestManager.init Initializing 0 registered ManagedResources
   [junit4]   2> 1328781 T9766 oash.ReplicationHandler.inform Commits will be reserved for  10000
   [junit4]   2> 1328781 T9767 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@627b16c8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1328782 T9766 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 1328782 T9723 oass.SolrDispatchFilter.init user.dir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2
   [junit4]   2> 1328782 T9723 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 1328783 T9723 oas.SolrTestCaseHS$SolrInstance.start ===> Started solr server port=41988 home=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/s2-001
   [junit4]   2> ASYNC  NEW_CORE C2518 name=collection1 org.apache.solr.core.SolrCore@660f9f0b
   [junit4]   2> 1328787 T9733 C2518 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1496263304110145536)} 0 1
   [junit4]   2> ASYNC  NEW_CORE C2519 name=collection1 org.apache.solr.core.SolrCore@19d10741
   [junit4]   2> 1328789 T9747 C2519 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1496263304113291264)} 0 0
   [junit4]   2> ASYNC  NEW_CORE C2520 name=collection1 org.apache.solr.core.SolrCore@6ecc964e
   [junit4]   2> 1328792 T9761 C2520 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1496263304115388416)} 0 1
   [junit4]   2> 1328794 T9748 C2519 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1 (1496263304118534144)]} 0 0
   [junit4]   2> 1328796 T9734 C2518 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[2 (1496263304120631296)]} 0 0
   [junit4]   2> 1328798 T9762 C2520 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[3 (1496263304122728448)]} 0 0
   [junit4]   2> 1328800 T9735 C2518 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1328800 T9735 C2518 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@1dec91d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3222e23e),segFN=segments_1,generation=1}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@1dec91d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3222e23e),segFN=segments_2,generation=2}
   [junit4]   2> 1328801 T9735 C2518 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
   [junit4]   2> 1328802 T9735 C2518 oass.SolrIndexSearcher.<init> Opening Searcher@5e832fb0[collection1] main
   [junit4]   2> 1328802 T9735 C2518 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1328803 T9739 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5e832fb0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c1)))}
   [junit4]   2> 1328803 T9735 C2518 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 3
   [junit4]   2> 1328805 T9749 C2519 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1328805 T9749 C2519 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@7b532df3 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@46a6eb9b),segFN=segments_1,generation=1}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@7b532df3 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@46a6eb9b),segFN=segments_2,generation=2}
   [junit4]   2> 1328806 T9749 C2519 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
   [junit4]   2> 1328806 T9749 C2519 oass.SolrIndexSearcher.<init> Opening Searcher@4b419227[collection1] main
   [junit4]   2> 1328807 T9749 C2519 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1328807 T9753 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4b419227[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c1)))}
   [junit4]   2> 1328807 T9749 C2519 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 2
   [junit4]   2> 1328809 T9763 C2520 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1328809 T9763 C2520 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@39cbfe6d lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@60961c5f),segFN=segments_1,generation=1}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@39cbfe6d lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@60961c5f),segFN=segments_2,generation=2}
   [junit4]   2> 1328810 T9763 C2520 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
   [junit4]   2> 1328811 T9763 C2520 oass.SolrIndexSearcher.<init> Opening Searcher@49907fc9[collection1] main
   [junit4]   2> 1328811 T9763 C2520 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1328811 T9767 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@49907fc9[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c1)))}
   [junit4]   2> 1328811 T9763 C2520 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 2
   [junit4]   2> 1328815 T9733 C2518 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[4 (1496263304138457088)]} 0 2
   [junit4]   2> 1328818 T9761 C2520 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[5 (1496263304142651392)]} 0 2
   [junit4]   2> 1328819 T9734 C2518 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1328821 T9734 C2518 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@1dec91d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3222e23e),segFN=segments_2,generation=2}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@1dec91d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3222e23e),segFN=segments_3,generation=3}
   [junit4]   2> 1328821 T9734 C2518 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
   [junit4]   2> 1328821 T9734 C2518 oass.SolrIndexSearcher.<init> Opening Searcher@29f243d2[collection1] main
   [junit4]   2> 1328822 T9734 C2518 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1328822 T9739 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@29f243d2[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c1) Uninverting(_1(6.0.0):c1)))}
   [junit4]   2> 1328822 T9734 C2518 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 3
   [junit4]   2> 1328824 T9747 C2519 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1328824 T9747 C2519 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 1328824 T9747 C2519 oasc.SolrCore.openNewSearcher SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
   [junit4]   2> 1328824 T9747 C2519 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1328824 T9747 C2519 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 0
   [junit4]   2> 1328826 T9762 C2520 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1328827 T9762 C2520 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@39cbfe6d lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@60961c5f),segFN=segments_2,generation=2}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@39cbfe6d lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@60961c5f),segFN=segments_3,generation=3}
   [junit4]   2> 1328828 T9762 C2520 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
   [junit4]   2> 1328828 T9762 C2520 oass.SolrIndexSearcher.<init> Opening Searcher@35606169[collection1] main
   [junit4]   2> 1328828 T9762 C2520 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1328828 T9767 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@35606169[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c1) Uninverting(_1(6.0.0):c1)))}
   [junit4]   2> 1328829 T9762 C2520 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 3
   [junit4]   2> 1328831 T9748 C2519 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[6 (1496263304156282880)]} 0 1
   [junit4]   2> 1328833 T9735 C2518 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1328833 T9735 C2518 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 1328833 T9735 C2518 oasc.SolrCore.openNewSearcher SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
   [junit4]   2> 1328833 T9735 C2518 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1328834 T9735 C2518 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 1
   [junit4]   2> 1328835 T9749 C2519 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1328836 T9749 C2519 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@7b532df3 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@46a6eb9b),segFN=segments_2,generation=2}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@7b532df3 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@46a6eb9b),segFN=segments_3,generation=3}
   [junit4]   2> 1328837 T9749 C2519 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
   [junit4]   2> 1328837 T9749 C2519 oass.SolrIndexSearcher.<init> Opening Searcher@7c85d695[collection1] main
   [junit4]   2> 1328837 T9749 C2519 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1328837 T9753 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7c85d695[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c1) Uninverting(_1(6.0.0):c1)))}
   [junit4]   2> 1328838 T9749 C2519 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 3
   [junit4]   2> 1328840 T9763 C2520 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1328840 T9763 C2520 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 1328840 T9763 C2520 oasc.SolrCore.openNewSearcher SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
   [junit4]   2> 1328840 T9763 C2520 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1328840 T9763 C2520 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 1
   [junit4]   2> 1328844 T9733 C2518 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49577/solr/collection1&rows=10&version=2&q=cat_s:A&NOW=1426947883767&json={query:'cat_s:A'}&isShard=true&wt=javabin} hits=1 status=0 QTime=0 
   [junit4]   2> 1328844 T9762 C2520 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:41988/solr/collection1&rows=10&version=2&q=cat_s:A&NOW=1426947883767&json={query:'cat_s:A'}&isShard=true&wt=javabin} hits=0 status=0 QTime=0 
   [junit4]   2> 1328844 T9747 C2519 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:37548/solr/collection1&rows=10&version=2&q=cat_s:A&NOW=1426947883767&json={query:'cat_s:A'}&isShard=true&wt=javabin} hits=1 status=0 QTime=0 
   [junit4]   2> 1328847 T9734 C2518 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=cat_s:A&distrib=false&shards.purpose=64&NOW=1426947883767&json={query:'cat_s:A'}&ids=4&isShard=true&shard.url=127.0.0.1:49577/solr/collection1&wt=javabin&version=2} status=0 QTime=0 
   [junit4]   2> 1328847 T9748 C2519 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=cat_s:A&distrib=false&shards.purpose=64&NOW=1426947883767&json={query:'cat_s:A'}&ids=1&isShard=true&shard.url=127.0.0.1:37548/solr/collection1&wt=javabin&version=2} status=0 QTime=0 
   [junit4]   2> 1328847 T9761 C2520 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={shards=127.0.0.1:49577/solr/collection1,127.0.0.1:37548/solr/collection1,127.0.0.1:41988/solr/collection1&indent=true&json={query:'cat_s:A'}&wt=json&version=2.2} hits=2 status=0 QTime=5 
   [junit4]   2> 1328852 T9762 C2520 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&fq=where_s:NY&shard.url=127.0.0.1:41988/solr/collection1&rows=10&version=2&q=cat_s:A&NOW=1426947883775&json={query:'cat_s:A'}&json={filter:'where_s:NY'}&isShard=true&wt=javabin} hits=0 status=0 QTime=1 
   [junit4]   2> 1328852 T9749 C2519 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&fq=where_s:NY&shard.url=127.0.0.1:37548/solr/collection1&rows=10&version=2&q=cat_s:A&NOW=1426947883775&json={query:'cat_s:A'}&json={filter:'where_s:NY'}&isShard=true&wt=javabin} hits=1 status=0 QTime=1 
   [junit4]   2> 1328852 T9735 C2518 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&fq=where_s:NY&shard.url=127.0.0.1:49577/solr/collection1&rows=10&version=2&q=cat_s:A&NOW=1426947883775&json={query:'cat_s:A'}&json={filter:'where_s:NY'}&isShard=true&wt=javabin} hits=0 status=0 QTime=1 
   [junit4]   2> 1328854 T9747 C2519 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=cat_s:A&distrib=false&shards.purpose=64&NOW=1426947883775&json={query:'cat_s:A'}&json={filter:'where_s:NY'}&ids=1&isShard=true&fq=where_s:NY&shard.url=127.0.0.1:37548/solr/collection1&wt=javabin&version=2} status=0 QTime=0 
   [junit4]   2> 1328854 T9763 C2520 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={shards=127.0.0.1:49577/solr/collection1,127.0.0.1:37548/solr/collection1,127.0.0.1:41988/solr/collection1&indent=true&json={query:'cat_s:A'}&json={filter:'where_s:NY'}&wt=json&version=2.2} hits=1 status=0 QTime=5 
   [junit4]   2> 1328858 T9762 C2520 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&fq=where_s:NY&fq=cat_s:A&shard.url=127.0.0.1:41988/solr/collection1&rows=10&version=2&q=*:*&NOW=1426947883781&json={query:'*:*'}&json={filter:'where_s:NY'}&json={filter:'cat_s:A'}&isShard=true&wt=javabin} hits=0 status=0 QTime=0 
   [junit4]   2> 1328858 T9733 C2518 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&fq=where_s:NY&fq=cat_s:A&shard.url=127.0.0.1:49577/solr/collection1&rows=10&version=2&q=*:*&NOW=1426947883781&json={query:'*:*'}&json={filter:'where_s:NY'}&json={filter:'cat_s:A'}&isShard=true&wt=javabin} hits=0 status=0 QTime=0 
   [junit4]   2> 1328858 T9748 C2519 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&fq=where_s:NY&fq=cat_s:A&shard.url=127.0.0.1:37548/solr/collection1&rows=10&version=2&q=*:*&NOW=1426947883781&json={query:'*:*'}&json={filter:'where_s:NY'}&json={filter:'cat_s:A'}&isShard=true&wt=javabin} hits=1 status=0 QTime=0 
   [junit4]   2> 1328860 T9749 C2519 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1426947883781&json={query:'*:*'}&json={filter:'where_s:NY'}&json={filter:'cat_s:A'}&ids=1&isShard=true&fq=where_s:NY&fq=cat_s:A&shard.url=127.0.0.1:37548/solr/collection1&wt=javabin&version=2} status=0 QTime=0 
   [junit4]   2> 1328860 T9761 C2520 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={shards=127.0.0.1:49577/solr/collection1,127.0.0.1:37548/solr/collection1,127.0.0.1:41988/solr/collection1&indent=true&json={query:'*:*'}&json={filter:'where_s:NY'}&json={filter:'cat_s:A'}&wt=json&version=2.2} hits=1 status=0 QTime=4 
   [junit4]   2> 1328864 T9734 C2518 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&fq=where_s:NY&fq=cat_s:A&shard.url=127.0.0.1:49577/solr/collection1&rows=10&version=2&q=*:*&NOW=1426947883787&json={query:'*:*'}&json={filter:'where_s:NY'}&json={filter:['cat_s:A']}&isShard=true&wt=javabin} hits=0 status=0 QTime=1 
   [junit4]   2> 1328864 T9747 C2519 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&fq=where_s:NY&fq=cat_s:A&shard.url=127.0.0.1:37548/solr/collection1&rows=10&version=2&q=*:*&NOW=1426947883787&json={query:'*:*'}&json={filter:'where_s:NY'}&json={filter:['cat_s:A']}&isShard=true&wt=javabin} hits=1 status=0 QTime=1 
   [junit4]   2> 1328864 T9762 C2520 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&fq=where_s:NY&fq=cat_s:A&shard.url=127.0.0.1:41988/solr/collection1&rows=10&version=2&q=*:*&NOW=1426947883787&json={query:'*:*'}&json={filter:'where_s:NY'}&json={filter:['cat_s:A']}&isShard=true&wt=javabin} hits=0 status=0 QTime=1 
   [junit4]   2> 1328866 T9748 C2519 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1426947883787&json={query:'*:*'}&json={filter:'where_s:NY'}&json={filter:['cat_s:A']}&ids=1&isShard=true&fq=where_s:NY&fq=cat_s:A&shard.url=127.0.0.1:37548/solr/collection1&wt=javabin&version=2} status=0 QTime=0 
   [junit4]   2> 1328866 T9763 C2520 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={shards=127.0.0.1:49577/solr/collection1,127.0.0.1:37548/solr/collection1,127.0.0.1:41988/solr/collection1&indent=true&json={query:'*:*'}&json={filter:'where_s:NY'}&json={filter:['cat_s:A']}&wt=json&version=2.2} hits=1 status=0 QTime=4 
   [junit4]   2> 1328870 T9735 C2518 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&fq=where_s:NY&fq=cat_s:A&shard.url=127.0.0.1:49577/solr/collection1&rows=10&version=2&q=*:*&NOW=1426947883793&json={query:'*:*'}&json={filter:['where_s:NY']}&json={filter:'cat_s:A'}&isShard=true&wt=javabin} hits=0 status=0 QTime=1 
   [junit4]   2> 1328876 T9747 C2519 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&fq=where_s:NY&fq=cat_s:A&shard.url=127.0.0.1:37548/solr/collection1&rows=10&version=2&q=*:*&NOW=1426947883793&json={query:'*:*'}&json={filter:['where_s:NY']}&json={filter:'cat_s:A'}&isShard=true&wt=javabin} hits=1 status=0 QTime=1 
   [junit4]   2> 1328877 T9761 C2520 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&fq=where_s:NY&fq=cat_s:A&shard.url=127.0.0.1:41988/solr/collection1&rows=10&version=2&q=*:*&NOW=1426947883793&json={query:'*:*'}&json={filter:['where_s:NY']}&json={filter:'cat_s:A'}&isShard=true&wt=javabin} hits=0 status=0 QTime=0 
   [junit4]   2> 1328879 T9748 C2519 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1426947883793&json={query:'*:*'}&json={filter:['where_s:NY']}&json={filter:'cat_s:A'}&ids=1&isShard=true&fq=where_s:NY&fq=cat_s:A&shard.url=127.0.0.1:37548/solr/collection1&wt=javabin&version=2} status=0 QTime=0 
   [junit4]   2> 1328880 T9749 C2519 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={shards=127.0.0.1:49577/solr/collection1,127.0.0.1:37548/solr/collection1,127.0.0.1:41988/solr/collection1&indent=true&json={query:'*:*'}&json={filter:['where_s:NY']}&json={filter:'cat_s:A'}&wt=json&version=2.2} hits=1 status=0 QTime=12 
   [junit4]   2> 1328884 T9763 C2520 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&fq=where_s:NY&fq=cat_s:A&shard.url=127.0.0.1:41988/solr/collection1&rows=10&version=2&q=*:*&NOW=1426947883807&json={query:'*:*'}&json={filter:['where_s:NY']}&json={filter:['cat_s:A']}&isShard=true&wt=javabin} hits=0 status=0 QTime=1 
   [junit4]   2> 1328884 T9747 C2519 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&fq=where_s:NY&fq=cat_s:A&shard.url=127.0.0.1:37548/solr/collection1&rows=10&version=2&q=*:*&NOW=1426947883807&json={query:'*:*'}&json={filter:['where_s:NY']}&json={filter:['cat_s:A']}&isShard=true&wt=javabin} hits=1 status=0 QTime=1 
   [junit4]   2> 1328884 T9733 C2518 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&fq=where_s:NY&fq=cat_s:A&shard.url=127.0.0.1:49577/solr/collection1&rows=10&version=2&q=*:*&NOW=1426947883807&json={query:'*:*'}&json={filter:['where_s:NY']}&json={filter:['cat_s:A']}&isShard=true&wt=javabin} hits=0 status=0 QTime=1 
   [junit4]   2> 1328887 T9748 C2519 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1426947883807&json={query:'*:*'}&json={filter:['where_s:NY']}&json={filter:['cat_s:A']}&ids=1&isShard=true&fq=where_s:NY&fq=cat_s:A&shard.url=127.0.0.1:37548/solr/collection1&wt=javabin&version=2} status=0 QTime=1 
   [junit4]   2> 1328887 T9762 C2520 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={shards=127.0.0.1:49577/solr/collection1,127.0.0.1:37548/solr/collection1,127.0.0.1:41988/solr/collection1&indent=true&json={query:'*:*'}&json={filter:['where_s:NY']}&json={filter:['cat_s:A']}&wt=json&version=2.2} hits=1 status=0 QTime=5 
   [junit4]   2> 1328892 T9734 C2518 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&json.query='*:*'&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&fq=where_s:NY&fq=cat_s:A&shard.url=127.0.0.1:49577/solr/collection1&rows=10&version=2&q=*:*&NOW=1426947883814&isShard=true&json.filter='where_s:NY'&json.filter='cat_s:A'&wt=javabin} hits=0 status=0 QTime=0 
   [junit4]   2> 1328892 T9749 C2519 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&json.query='*:*'&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&fq=where_s:NY&fq=cat_s:A&shard.url=127.0.0.1:37548/solr/collection1&rows=10&version=2&q=*:*&NOW=1426947883814&isShard=true&json.filter='where_s:NY'&json.filter='cat_s:A'&wt=javabin} hits=1 status=0 QTime=0 
   [junit4]   2> 1328892 T9763 C2520 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&json.query='*:*'&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&fq=where_s:NY&fq=cat_s:A&shard.url=127.0.0.1:41988/solr/collection1&rows=10&version=2&q=*:*&NOW=1426947883814&isShard=true&json.filter='where_s:NY'&json.filter='cat_s:A'&wt=javabin} hits=0 status=0 QTime=0 
   [junit4]   2> 1328894 T9747 C2519 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=*:*&distrib=false&json.query='*:*'&shards.purpose=64&NOW=1426947883814&ids=1&isShard=true&json.filter='where_s:NY'&json.filter='cat_s:A'&fq=where_s:NY&fq=cat_s:A&shard.url=127.0.0.1:37548/solr/collection1&wt=javabin&version=2} status=0 QTime=0 
   [junit4]   2> 1328895 T9761 C2520 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={shards=127.0.0.1:49577/solr/collection1,127.0.0.1:37548/solr/collection1,127.0.0.1:41988/solr/collection1&indent=true&json.query='*:*'&json.filter='where_s:NY'&json.filter='cat_s:A'&wt=json&version=2.2} hits=1 status=0 QTime=6 
   [junit4]   2> 1328899 T9748 C2519 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&json.query='foo_s:NONE'&json.query='*:*'&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&fq=where_s:NY&fq=cat_s:A&shard.url=127.0.0.1:37548/solr/collection1&rows=10&version=2&q=*:*&NOW=1426947883822&isShard=true&json.filter='where_s:NY'&json.filter='cat_s:A'&wt=javabin} hits=1 status=0 QTime=1 
   [junit4]   2> 1328902 T9733 C2518 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&json.query='foo_s:NONE'&json.query='*:*'&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&fq=where_s:NY&fq=cat_s:A&shard.url=127.0.0.1:49577/solr/collection1&rows=10&version=2&q=*:*&NOW=1426947883822&isShard=true&json.filter='where_s:NY'&json.filter='cat_s:A'&wt=javabin} hits=0 status=0 QTime=1 
   [junit4]   2> 1328902 T9762 C2520 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&json.query='foo_s:NONE'&json.query='*:*'&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&fq=where_s:NY&fq=cat_s:A&shard.url=127.0.0.1:41988/solr/collection1&rows=10&version=2&q=*:*&NOW=1426947883822&isShard=true&json.filter='where_s:NY'&json.filter='cat_s:A'&wt=javabin} hits=0 status=0 QTime=0 
   [junit4]   2> 1328904 T9749 C2519 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=*:*&distrib=false&json.query='foo_s:NONE'&json.query='*:*'&shards.purpose=64&NOW=1426947883822&ids=1&isShard=true&json.filter='where_s:NY'&json.filter='cat_s:A'&fq=where_s:NY&fq=cat_s:A&shard.url=127.0.0.1:37548/solr/collection1&wt=javabin&version=2} status=0 QTime=0 
   [junit4]   2> 1328905 T9735 C2518 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={shards=127.0.0.1:49577/solr/collection1,127.0.0.1:37548/solr/collection1,127.0.0.1:41988/solr/collection1&indent=true&json.query='foo_s:NONE'&json.query='*:*'&json.filter='where_s:NY'&json.filter='cat_s:A'&wt=json&version=2.2} hits=1 status=0 QTime=8 
   [junit4]   2> 1328911 T9734 C2518 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&fl=id&fl=score&shards.purpose=68&start=0&fsv=true&fq=cat_s:A&fq=where_s:NY&shard.url=127.0.0.1:49577/solr/collection1&rows=5&version=2&q=*:*&NOW=1426947883832&json={params:{q:'*:*',+fq:['cat_s:A','where_s:NY'],+start:0,+rows:5,+fl:id}}&isShard=true&wt=javabin} hits=0 status=0 QTime=1 
   [junit4]   2> 1328911 T9747 C2519 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&fl=id&fl=score&shards.purpose=68&start=0&fsv=true&fq=cat_s:A&fq=where_s:NY&shard.url=127.0.0.1:37548/solr/collection1&rows=5&version=2&q=*:*&NOW=1426947883832&json={params:{q:'*:*',+fq:['cat_s:A','where_s:NY'],+start:0,+rows:5,+fl:id}}&isShard=true&wt=javabin} hits=1 status=0 QTime=1 
   [junit4]   2> 1328911 T9761 C2520 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&fl=id&fl=score&shards.purpose=68&start=0&fsv=true&fq=cat_s:A&fq=where_s:NY&shard.url=127.0.0.1:41988/solr/collection1&rows=5&version=2&q=*:*&NOW=1426947883832&json={params:{q:'*:*',+fq:['cat_s:A','where_s:NY'],+start:0,+rows:5,+fl:id}}&isShard=true&wt=javabin} hits=0 status=0 QTime=1 
   [junit4]   2> 1328912 T9763 C2520 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={shards=127.0.0.1:49577/solr/collection1,127.0.0.1:37548/solr/collection1,127.0.0.1:41988/solr/collection1&indent=true&json={params:{q:'*:*',+fq:['cat_s:A','where_s:NY'],+start:0,+rows:5,+fl:id}}&wt=json&version=2.2} hits=1 status=0 QTime=5 
   [junit4]   2> 1328916 T9761 C2520 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&fl=id&shards.purpose=68&start=0&fsv=true&fq=cat_s:A&fq=where_s:(NY+OR+NJ)&sort=wher

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

   2> 1329172 T9723 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1162776101
   [junit4]   2> 1329173 T9723 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@44e0240b
   [junit4]   2> 1329173 T9723 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=3,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=6,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0,transaction_logs_total_size=519,transaction_logs_total_number=3}
   [junit4]   2> 1329173 T9723 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
   [junit4]   2> 1329173 T9723 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 1329174 T9723 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
   [junit4]   2> 1329174 T9723 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 1329177 T9723 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 1329178 T9723 oasc.CachingDirectoryFactory.closeCacheValue looking to close /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/init-core-data-001 [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/init-core-data-001;done=false>>]
   [junit4]   2> 1329178 T9723 oasc.CachingDirectoryFactory.close Closing directory: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/init-core-data-001
   [junit4]   2> 1329178 T9723 oasc.CachingDirectoryFactory.closeCacheValue looking to close /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/init-core-data-001/index [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/init-core-data-001/index;done=false>>]
   [junit4]   2> 1329178 T9723 oasc.CachingDirectoryFactory.close Closing directory: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J2/temp/solr.search.json.TestJsonRequest 722868BB8C87E875-001/init-core-data-001/index
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene50), sim=RandomSimilarityProvider(queryNorm=true,coord=crazy): {}, locale=en_CA, timezone=Africa/Bamako
   [junit4]   2> NOTE: Linux 3.13.0-46-generic amd64/Oracle Corporation 1.8.0_60-ea (64-bit)/cpus=12,threads=1,free=212303080,total=510066688
   [junit4]   2> NOTE: All tests run in this JVM: [DirectSolrSpellCheckerTest, SuggesterTest, SolrCoreCheckLockOnStartupTest, VMParamsZkACLAndCredentialsProvidersTest, BadCopyFieldTest, ExternalCollectionsTest, DeleteInactiveReplicaTest, AnalyticsQueryTest, AsyncMigrateRouteKeyTest, TestFieldTypeResource, DistributedQueryElevationComponentTest, CursorMarkTest, PolyFieldTest, TestDistribDocBasedVersion, TestSearcherReuse, RankQueryTest, SoftAutoCommitTest, SortByFunctionTest, HardAutoCommitTest, DistanceUnitsTest, BadIndexSchemaTest, TestStressReorder, TestStressRecovery, TestPartialUpdateDeduplication, OverseerCollectionProcessorTest, TestInitQParser, TermVectorComponentDistributedTest, HdfsWriteToMultipleCollectionsTest, DistribCursorPagingTest, TestFieldTypeCollectionResource, TestReload, ZkStateWriterTest, StatsComponentTest, TestExtendedDismaxParser, AddBlockUpdateTest, CircularListTest, UnloadDistributedZkTest, SimpleFacetsTest, HdfsDirectoryTest, TestSystemIdResolver, TestGroupingSearch, QueryEqualityTest, CoreAdminRequestStatusTest, DistributedQueryComponentOptimizationTest, TestJsonFacets, SolrInfoMBeanTest, TestMaxScoreQueryParser, TestSurroundQueryParser, TestCSVResponseWriter, TestSort, LeaderElectionTest, ReplicationFactorTest, CloudMLTQParserTest, AssignTest, OverriddenZkACLAndCredentialsProvidersTest, LoggingHandlerTest, AnalyticsMergeStrategyTest, TestClusterStateMutator, TestRecovery, DOMUtilTest, TestNamedUpdateProcessors, CoreAdminCreateDiscoverTest, SynonymTokenizerTest, TestBinaryResponseWriter, DocValuesTest, SOLR749Test, OpenExchangeRatesOrgProviderTest, TestPerFieldSimilarity, TestReqParamsAPI, TestTrie, DirectUpdateHandlerOptimizeTest, TestShardHandlerFactory, QueryParsingTest, DistribJoinFromCollectionTest, BasicDistributedZkTest, CollectionsAPIDistributedZkTest, TestZkChroot, TestRandomDVFaceting, AutoCommitTest, TestFaceting, DistributedSpellCheckComponentTest, TestJoin, SolrCoreTest, SpellCheckComponentTest, DirectUpdateHandlerTest, TestBadConfig, TestIndexSearcher, CurrencyFieldOpenExchangeTest, CurrencyFieldXmlFileTest, SolrIndexSplitterTest, SpellCheckCollatorTest, SuggesterWFSTTest, NoCacheHeaderTest, SchemaVersionSpecificBehaviorTest, TestPseudoReturnFields, FieldMutatingUpdateProcessorTest, StatelessScriptUpdateProcessorFactoryTest, LukeRequestHandlerTest, TestReversedWildcardFilterFactory, PrimitiveFieldTypeTest, FileBasedSpellCheckerTest, XmlUpdateRequestHandlerTest, TermVectorComponentTest, MoreLikeThisHandlerTest, TestSolrQueryParser, RegexBoostProcessorTest, SolrPluginUtilsTest, TestCollationField, UpdateRequestProcessorFactoryTest, TestAnalyzedSuggestions, JsonLoaderTest, TestPHPSerializedResponseWriter, CSVRequestHandlerTest, TestLFUCache, HighlighterConfigTest, AlternateDirectoryTest, ResponseLogComponentTest, TestSolrDeletionPolicy2, SampleTest, NumericFieldsTest, MinimalSchemaTest, OutputWriterTest, NotRequiredUniqueKeyTest, TestCodecSupport, TestSweetSpotSimilarityFactory, TestIBSimilarityFactory, TestDefaultSimilarityFactory, TestJmxMonitoredMap, ResourceLoaderTest, ScriptEngineTest, DateMathParserTest, PrimUtilsTest, RAMDirectoryFactoryTest, TestSolrJ, TestLRUCache, DistributedMLTComponentTest, DistributedIntervalFacetingTest, CloudExitableDirectoryReaderTest, CustomCollectionTest, LeaderFailoverAfterPartitionTest, MigrateRouteKeyTest, OverseerRolesTest, OverseerStatusTest, SharedFSAutoReplicaFailoverTest, SharedFSAutoReplicaFailoverUtilsTest, SimpleCollectionCreateDeleteTest, SolrXmlInZkTest, TestCryptoKeys, TestReplicaProperties, TestShortCircuitedRequests, TestImplicitCoreProperties, TestInitParams, TestReloadAndDeleteDocs, TestSolrConfigHandler, TestSolrDynamicMBean, TestSolrXml, TestReplicationHandlerBackup, CoreMergeIndexesAdminHandlerTest, DistributedExpandComponentTest, DistributedFacetPivotLargeTest, DistributedFacetPivotLongTailTest, FacetPivotSmallTest, SuggestComponentTest, TestManagedSchemaFieldResource, TestSolrQueryParserResource, TestManagedSynonymFilterFactory, EnumFieldTest, TestBulkSchemaConcurrent, TestManagedSchema, TestSchemaManager, MergeStrategyTest, TestComplexPhraseQParserPlugin, TestCustomSort, TestFieldSortValues, TestNoOpRegenerator, TestOverriddenPrefixQueryForCustomFieldType, TestSimpleQParserPlugin, TestSolr4Spatial2, TestStandardQParsers, TestStressUserVersions, BJQParserTest, TestJsonRequest]
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestJsonRequest -Dtests.seed=722868BB8C87E875 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=en_CA -Dtests.timezone=Africa/Bamako -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.00s J2 | TestJsonRequest (suite) <<<
   [junit4]    > Throwable #1: junit.framework.AssertionFailedError: Clean up static fields (in @AfterClass?), your test seems to hang on to approximately 12,071,296 bytes (threshold is 10,485,760). Field reference sizes (counted individually):
   [junit4]    >   - 12,876,760 bytes, private static org.apache.solr.SolrTestCaseHS$SolrInstances org.apache.solr.search.json.TestJsonRequest.servers
   [junit4]    >   - 296 bytes, public static org.junit.rules.TestRule org.apache.solr.SolrTestCaseJ4.solrClassRules
   [junit4]    >   - 216 bytes, protected static java.lang.String org.apache.solr.SolrTestCaseJ4.testSolrHome
   [junit4]    >   - 144 bytes, private static java.lang.String org.apache.solr.SolrTestCaseJ4.factoryProp
   [junit4]    >   - 80 bytes, private static java.lang.String org.apache.solr.SolrTestCaseJ4.coreName
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([722868BB8C87E875]:0)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4] Completed on J2 in 1.54s, 2 tests, 1 failure <<< FAILURES!

[...truncated 77 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:519: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:467: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:61: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/extra-targets.xml:39: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build.xml:191: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/common-build.xml:510: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:1351: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:958: There were test failures: 476 suites, 1893 tests, 1 suite-level error, 48 ignored (21 assumptions)

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