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/07/13 17:40:27 UTC
[JENKINS] Lucene-Solr-5.x-Windows (64bit/jdk1.7.0_80) - Build #
4904 - Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Windows/4904/
Java: 64bit/jdk1.7.0_80 -XX:-UseCompressedOops -XX:+UseG1GC
1 tests failed.
FAILED: org.apache.solr.search.TestSmileRequest.testDistribJsonRequest
Error Message:
PermGen space
Stack Trace:
java.lang.OutOfMemoryError: PermGen space
at __randomizedtesting.SeedInfo.seed([971177CA5798F95F:834B01C702F57F97]:0)
at java.lang.ClassLoader.defineClass1(Native Method)
at java.lang.ClassLoader.defineClass(ClassLoader.java:800)
at java.security.SecureClassLoader.defineClass(SecureClassLoader.java:142)
at java.net.URLClassLoader.defineClass(URLClassLoader.java:449)
at java.net.URLClassLoader.access$100(URLClassLoader.java:71)
at java.net.URLClassLoader$1.run(URLClassLoader.java:361)
at java.net.URLClassLoader$1.run(URLClassLoader.java:355)
at java.security.AccessController.doPrivileged(Native Method)
at java.net.URLClassLoader.findClass(URLClassLoader.java:354)
at java.lang.ClassLoader.loadClass(ClassLoader.java:425)
at sun.misc.Launcher$AppClassLoader.loadClass(Launcher.java:308)
at java.lang.ClassLoader.loadClass(ClassLoader.java:358)
at java.lang.ClassLoader.defineClass1(Native Method)
at java.lang.ClassLoader.defineClass(ClassLoader.java:800)
at java.security.SecureClassLoader.defineClass(SecureClassLoader.java:142)
at java.net.URLClassLoader.defineClass(URLClassLoader.java:449)
at java.net.URLClassLoader.access$100(URLClassLoader.java:71)
at java.net.URLClassLoader$1.run(URLClassLoader.java:361)
at java.net.URLClassLoader$1.run(URLClassLoader.java:355)
at java.security.AccessController.doPrivileged(Native Method)
at java.net.URLClassLoader.findClass(URLClassLoader.java:354)
at java.lang.ClassLoader.loadClass(ClassLoader.java:425)
at sun.misc.Launcher$AppClassLoader.loadClass(Launcher.java:308)
at java.lang.ClassLoader.loadClass(ClassLoader.java:358)
at com.fasterxml.jackson.databind.cfg.DeserializerFactoryConfig.<clinit>(DeserializerFactoryConfig.java:28)
at com.fasterxml.jackson.databind.deser.BeanDeserializerFactory.<clinit>(BeanDeserializerFactory.java:55)
at com.fasterxml.jackson.databind.ObjectMapper.<init>(ObjectMapper.java:480)
at com.fasterxml.jackson.databind.ObjectMapper.<init>(ObjectMapper.java:402)
at org.apache.solr.request.SmileWriterTest.decodeSmile(SmileWriterTest.java:213)
at org.apache.solr.search.TestSmileRequest$SmileResponseParser.processResponse(TestSmileRequest.java:103)
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:535)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:234)
Build Log:
[...truncated 11462 lines...]
[junit4] Suite: org.apache.solr.search.TestSmileRequest
[junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\init-core-data-001
[junit4] 2> 3099031 INFO (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 3099031 INFO (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\'
[junit4] 2> 3099086 INFO (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-5.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 3099130 INFO (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-5.x-Windows/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 3099513 INFO (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 3099562 INFO (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.3.0
[junit4] 2> 3099733 INFO (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig-tlog.xml
[junit4] 2> 3099733 INFO (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ ] o.a.s.s.IndexSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\schema_latest.xml
[junit4] 2> 3099740 INFO (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=example
[junit4] 2> 3100317 WARN (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ ] o.a.s.s.SpatialRecursivePrefixTreeFieldType units parameter is deprecated, please use distanceUnits instead for field types with class SpatialRecursivePrefixTreeFieldType
[junit4] 2> 3100322 INFO (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 3100467 INFO (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 3100470 INFO (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 3100474 INFO (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 3100474 INFO (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr
[junit4] 2> 3100474 INFO (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\'
[junit4] 2> 3100507 INFO (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ ] o.a.s.c.CoreContainer New CoreContainer 143398083
[junit4] 2> 3100507 INFO (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\]
[junit4] 2> 3100508 INFO (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ ] o.a.s.c.CoreContainer loading shared library: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\lib
[junit4] 2> 3100508 WARN (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\lib).
[junit4] 2> 3100520 INFO (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
[junit4] 2> 3100663 INFO (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true
[junit4] 2> 3100715 INFO (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3100715 INFO (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3100715 INFO (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 3100746 INFO (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ ] o.a.s.c.SolrCore Created CoreDescriptor: {config=solrconfig-tlog.xml, absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\, schema=schema_latest.xml, transient=false, loadOnStartup=true, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\init-core-data-001, shard=shard1, collection=collection1, instanceDir=collection1, name=collection1}
[junit4] 2> 3100782 INFO (coreLoadExecutor-7030-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\'
[junit4] 2> 3100782 INFO (coreLoadExecutor-7030-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-5.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 3100784 INFO (coreLoadExecutor-7030-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-5.x-Windows/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 3100848 INFO (coreLoadExecutor-7030-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 3100867 INFO (coreLoadExecutor-7030-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.3.0
[junit4] 2> 3100931 INFO (coreLoadExecutor-7030-thread-1) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig-tlog.xml
[junit4] 2> 3100934 INFO (coreLoadExecutor-7030-thread-1) [ ] o.a.s.s.IndexSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\schema_latest.xml
[junit4] 2> 3100942 INFO (coreLoadExecutor-7030-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=example
[junit4] 2> 3101351 WARN (coreLoadExecutor-7030-thread-1) [ ] o.a.s.s.SpatialRecursivePrefixTreeFieldType units parameter is deprecated, please use distanceUnits instead for field types with class SpatialRecursivePrefixTreeFieldType
[junit4] 2> 3101358 INFO (coreLoadExecutor-7030-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 3101366 INFO (coreLoadExecutor-7030-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 3101371 INFO (coreLoadExecutor-7030-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 3101375 INFO (coreLoadExecutor-7030-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\
[junit4] 2> 3101375 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 3101376 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\], dataDir=[null]
[junit4] 2> 3101376 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@375a8d07
[junit4] 2> 3101377 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\init-core-data-001\
[junit4] 2> 3101377 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\init-core-data-001\index/
[junit4] 2> 3101377 WARN (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\init-core-data-001\index' doesn't exist. Creating new index...
[junit4] 2> 3101377 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\init-core-data-001\index
[junit4] 2> 3101378 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=40, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6803698641565004]
[junit4] 2> 3101378 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@71dd7ca6 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@422b0b1),segFN=segments_1,generation=1}
[junit4] 2> 3101378 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 3101383 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\init-core-data-001\
[junit4] 2> 3101402 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "nodistrib"
[junit4] 2> 3101402 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe"
[junit4] 2> 3101402 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 3101403 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 3101403 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 3101403 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 3101403 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3101403 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3101403 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 3101439 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 3101441 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 3101442 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 3101444 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 3101478 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /update/json/docs,/get,/admin/logging,/replication,/admin/mbeans,/admin/ping,/admin/properties,/admin/file,/admin/system,/admin/luke,/update/json,/admin/segments,/admin/plugins,/admin/threads,standard,/update/csv,/schema,/config,/update
[junit4] 2> 3101480 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 3101482 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 3101482 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 3101483 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
[junit4] 2> 3101483 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
[junit4] 2> 3101485 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=16, maxMergeAtOnceExplicit=17, maxMergedSegmentMB=34.9912109375, floorSegmentMB=0.7392578125, forceMergeDeletesPctAllowed=15.06774538352498, segmentsPerTier=42.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.3038412330103942
[junit4] 2> 3101485 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@71dd7ca6 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@422b0b1),segFN=segments_1,generation=1}
[junit4] 2> 3101485 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 3101485 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@4a3936f9[collection1] main
[junit4] 2> 3101487 WARN (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf; switching to use InMemory storage instead.
[junit4] 2> 3101487 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
[junit4] 2> 3101487 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 3101487 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 3101487 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 3101487 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets
[junit4] 2> 3101488 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version buckets from index
[junit4] 2> 3101488 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket highest value from index
[junit4] 2> 3101488 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1506595849225895936
[junit4] 2> 3101490 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.u.UpdateLog Took 3 ms to seed version buckets with highest version 1506595849225895936
[junit4] 2> 3101490 INFO (coreLoadExecutor-7030-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 3101492 INFO (searcherExecutor-7031-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4a3936f9[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 3101538 INFO (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 3101559 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testDistribJsonRequest
[junit4] 2> 3101757 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.e.j.s.Server jetty-9.2.11.v20150529
[junit4] 2> 3101763 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4eba27a4{/solr,null,AVAILABLE}
[junit4] 2> 3101766 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.e.j.s.ServerConnector Started ServerConnector@1f80a85d{HTTP/1.1}{127.0.0.1:51110}
[junit4] 2> 3101766 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.e.j.s.Server Started @3107684ms
[junit4] 2> 3101766 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solrconfig=solrconfig-tlog.xml, schema=schema_latest.xml, hostPort=51110, hostContext=/solr}
[junit4] 2> 3101767 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@56f9659d
[junit4] 2> 3101767 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s0-001\'
[junit4] 2> 3102253 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s0-001\solr.xml
[junit4] 2> 3102550 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s0-001\.
[junit4] 2> 3102551 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.CoreContainer New CoreContainer 1482109344
[junit4] 2> 3102551 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s0-001\]
[junit4] 2> 3102551 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.CoreContainer loading shared library: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s0-001\lib
[junit4] 2> 3102551 WARN (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s0-001\lib).
[junit4] 2> 3102562 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
[junit4] 2> 3102564 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 3102565 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3102565 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3102565 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 3102567 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.CoresLocator Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s0-001\.
[junit4] 2> 3102569 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, loadOnStartup=true, schema=schema_latest.xml, absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s0-001\.\collection1\, config=solrconfig-tlog.xml, transient=false, instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s0-001\.\collection1, dataDir=data\}
[junit4] 2> 3102569 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.CoresLocator Found core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s0-001\.\collection1\
[junit4] 2> 3102570 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.CoresLocator Found 1 core definitions
[junit4] 2> 3102581 INFO (coreLoadExecutor-7041-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s0-001\.\collection1\'
[junit4] 2> 3102583 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.s.SolrDispatchFilter user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1
[junit4] 2> 3102583 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 3102658 INFO (coreLoadExecutor-7041-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 3102688 INFO (coreLoadExecutor-7041-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.3.0
[junit4] 2> 3102731 INFO (coreLoadExecutor-7041-thread-1) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig-tlog.xml
[junit4] 2> 3102731 INFO (coreLoadExecutor-7041-thread-1) [ ] o.a.s.s.IndexSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s0-001\.\collection1\conf\schema_latest.xml
[junit4] 2> 3102739 INFO (coreLoadExecutor-7041-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=example
[junit4] 2> 3103009 WARN (coreLoadExecutor-7041-thread-1) [ ] o.a.s.s.SpatialRecursivePrefixTreeFieldType units parameter is deprecated, please use distanceUnits instead for field types with class SpatialRecursivePrefixTreeFieldType
[junit4] 2> 3103015 INFO (coreLoadExecutor-7041-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 3103025 INFO (coreLoadExecutor-7041-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 3103030 INFO (coreLoadExecutor-7041-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 3103035 INFO (coreLoadExecutor-7041-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s0-001\.\collection1\
[junit4] 2> 3103035 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 3103035 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s0-001\.\collection1\], dataDir=[null]
[junit4] 2> 3103035 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@375a8d07
[junit4] 2> 3103036 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s0-001\.\collection1\data\
[junit4] 2> 3103036 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s0-001\.\collection1\data\index/
[junit4] 2> 3103036 WARN (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s0-001\.\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 3103036 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s0-001\.\collection1\data\index
[junit4] 2> 3103036 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=40, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6803698641565004]
[junit4] 2> 3103037 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@9593860 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@40842b6b),segFN=segments_1,generation=1}
[junit4] 2> 3103037 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 3103046 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "nodistrib"
[junit4] 2> 3103048 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe"
[junit4] 2> 3103048 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 3103048 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 3103048 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 3103048 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 3103050 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3103050 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3103050 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 3103051 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s0-001\.\collection1\data\
[junit4] 2> 3103051 WARN (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.DirectoryFactory C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s0-001\.\collection1\data\ does not point to a valid data directory; skipping clean-up of old index directories.
[junit4] 2> 3103098 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 3103100 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 3103101 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 3103104 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 3103168 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /update/json/docs,/get,/admin/logging,/replication,/admin/mbeans,/admin/ping,/admin/properties,/admin/file,/admin/system,/admin/luke,/update/json,/admin/segments,/admin/plugins,/admin/threads,standard,/update/csv,/schema,/config,/update
[junit4] 2> 3103170 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 3103173 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 3103173 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 3103267 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
[junit4] 2> 3103267 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
[junit4] 2> 3103268 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=16, maxMergeAtOnceExplicit=17, maxMergedSegmentMB=34.9912109375, floorSegmentMB=0.7392578125, forceMergeDeletesPctAllowed=15.06774538352498, segmentsPerTier=42.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.3038412330103942
[junit4] 2> 3103268 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@9593860 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@40842b6b),segFN=segments_1,generation=1}
[junit4] 2> 3103268 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 3103268 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@58d0778c[collection1] main
[junit4] 2> 3103270 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s0-001\.\collection1\conf
[junit4] 2> 3103270 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s0-001\.\collection1\conf}
[junit4] 2> 3103270 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s0-001\.\collection1\conf
[junit4] 2> 3103271 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 3103271 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 3103271 INFO (searcherExecutor-7042-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@58d0778c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 3103272 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets
[junit4] 2> 3103272 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version buckets from index
[junit4] 2> 3103272 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket highest value from index
[junit4] 2> 3103272 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1506595851096555520
[junit4] 2> 3103274 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.u.UpdateLog Took 2 ms to seed version buckets with highest version 1506595851096555520
[junit4] 2> 3103274 INFO (coreLoadExecutor-7041-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 3103375 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.SolrTestCaseJ4 ===> Started solr server port=51110 home=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s0-001
[junit4] 2> 3103727 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.e.j.s.Server jetty-9.2.11.v20150529
[junit4] 2> 3103759 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1e48b0aa{/solr,null,AVAILABLE}
[junit4] 2> 3103761 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.e.j.s.ServerConnector Started ServerConnector@3646786e{HTTP/1.1}{127.0.0.1:51113}
[junit4] 2> 3103761 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.e.j.s.Server Started @3109679ms
[junit4] 2> 3103761 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, schema=schema_latest.xml, hostPort=51113, solrconfig=solrconfig-tlog.xml}
[junit4] 2> 3103762 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@56f9659d
[junit4] 2> 3103762 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s1-001\'
[junit4] 2> 3103857 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s1-001\solr.xml
[junit4] 2> 3104090 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s1-001\.
[junit4] 2> 3104090 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.CoreContainer New CoreContainer 13408904
[junit4] 2> 3104090 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s1-001\]
[junit4] 2> 3104090 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.CoreContainer loading shared library: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s1-001\lib
[junit4] 2> 3104090 WARN (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s1-001\lib).
[junit4] 2> 3104103 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
[junit4] 2> 3104159 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 3104164 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3104164 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3104164 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 3104174 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.CoresLocator Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s1-001\.
[junit4] 2> 3104213 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.SolrCore Created CoreDescriptor: {loadOnStartup=true, transient=false, config=solrconfig-tlog.xml, schema=schema_latest.xml, dataDir=data\, instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s1-001\.\collection1, name=collection1, absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s1-001\.\collection1\}
[junit4] 2> 3104213 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.CoresLocator Found core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s1-001\.\collection1\
[junit4] 2> 3104218 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.CoresLocator Found 1 core definitions
[junit4] 2> 3104219 INFO (coreLoadExecutor-7052-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s1-001\.\collection1\'
[junit4] 2> 3104219 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.s.SolrDispatchFilter user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1
[junit4] 2> 3104219 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 3104335 INFO (coreLoadExecutor-7052-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 3104417 INFO (coreLoadExecutor-7052-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.3.0
[junit4] 2> 3104466 INFO (coreLoadExecutor-7052-thread-1) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig-tlog.xml
[junit4] 2> 3104466 INFO (coreLoadExecutor-7052-thread-1) [ ] o.a.s.s.IndexSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s1-001\.\collection1\conf\schema_latest.xml
[junit4] 2> 3104475 INFO (coreLoadExecutor-7052-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=example
[junit4] 2> 3104711 WARN (coreLoadExecutor-7052-thread-1) [ ] o.a.s.s.SpatialRecursivePrefixTreeFieldType units parameter is deprecated, please use distanceUnits instead for field types with class SpatialRecursivePrefixTreeFieldType
[junit4] 2> 3104723 INFO (coreLoadExecutor-7052-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 3104734 INFO (coreLoadExecutor-7052-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 3104738 INFO (coreLoadExecutor-7052-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 3104743 INFO (coreLoadExecutor-7052-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s1-001\.\collection1\
[junit4] 2> 3104743 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 3104749 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s1-001\.\collection1\], dataDir=[null]
[junit4] 2> 3104750 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@375a8d07
[junit4] 2> 3104750 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s1-001\.\collection1\data\
[junit4] 2> 3104750 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s1-001\.\collection1\data\index/
[junit4] 2> 3104769 WARN (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s1-001\.\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 3104769 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s1-001\.\collection1\data\index
[junit4] 2> 3104770 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=40, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6803698641565004]
[junit4] 2> 3104783 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@36aebb19 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@97d825b),segFN=segments_1,generation=1}
[junit4] 2> 3104785 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 3104799 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s1-001\.\collection1\data\
[junit4] 2> 3104799 WARN (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.DirectoryFactory C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s1-001\.\collection1\data\ does not point to a valid data directory; skipping clean-up of old index directories.
[junit4] 2> 3104830 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "nodistrib"
[junit4] 2> 3104831 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe"
[junit4] 2> 3104833 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 3104833 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 3104833 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 3104833 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 3104833 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3104834 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3104834 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 3104884 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 3104888 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 3104890 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 3104892 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 3104936 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /update/json/docs,/get,/admin/logging,/replication,/admin/mbeans,/admin/ping,/admin/properties,/admin/file,/admin/system,/admin/luke,/update/json,/admin/segments,/admin/plugins,/admin/threads,standard,/update/csv,/schema,/config,/update
[junit4] 2> 3104944 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 3104947 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 3104947 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 3104949 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
[junit4] 2> 3104949 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
[junit4] 2> 3104951 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=16, maxMergeAtOnceExplicit=17, maxMergedSegmentMB=34.9912109375, floorSegmentMB=0.7392578125, forceMergeDeletesPctAllowed=15.06774538352498, segmentsPerTier=42.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.3038412330103942
[junit4] 2> 3104951 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@36aebb19 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@97d825b),segFN=segments_1,generation=1}
[junit4] 2> 3104951 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 3104951 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@e771dae[collection1] main
[junit4] 2> 3104952 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s1-001\.\collection1\conf
[junit4] 2> 3104952 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s1-001\.\collection1\conf}
[junit4] 2> 3104952 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s1-001\.\collection1\conf
[junit4] 2> 3104953 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 3104953 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 3104953 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets
[junit4] 2> 3104953 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version buckets from index
[junit4] 2> 3104953 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket highest value from index
[junit4] 2> 3104954 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1506595852860260352
[junit4] 2> 3104955 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.u.UpdateLog Took 2 ms to seed version buckets with highest version 1506595852860260352
[junit4] 2> 3104955 INFO (coreLoadExecutor-7052-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 3104987 INFO (searcherExecutor-7053-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@e771dae[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 3105478 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.SolrTestCaseJ4 ===> Started solr server port=51113 home=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s1-001
[junit4] 2> 3105726 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.e.j.s.Server jetty-9.2.11.v20150529
[junit4] 2> 3105776 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2d369209{/solr,null,AVAILABLE}
[junit4] 2> 3105779 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.e.j.s.ServerConnector Started ServerConnector@59ada40f{HTTP/1.1}{127.0.0.1:51123}
[junit4] 2> 3105779 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.e.j.s.Server Started @3111697ms
[junit4] 2> 3105779 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostPort=51123, schema=schema_latest.xml, hostContext=/solr, solrconfig=solrconfig-tlog.xml}
[junit4] 2> 3105779 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@56f9659d
[junit4] 2> 3105860 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s2-001\'
[junit4] 2> 3106106 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s2-001\solr.xml
[junit4] 2> 3106236 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s2-001\.
[junit4] 2> 3106236 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.CoreContainer New CoreContainer 451063824
[junit4] 2> 3106236 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s2-001\]
[junit4] 2> 3106236 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.CoreContainer loading shared library: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s2-001\lib
[junit4] 2> 3106237 WARN (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s2-001\lib).
[junit4] 2> 3106250 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
[junit4] 2> 3106313 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 3106314 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3106314 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3106314 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 3106368 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.CoresLocator Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s2-001\.
[junit4] 2> 3106379 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.SolrCore Created CoreDescriptor: {dataDir=data\, absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s2-001\.\collection1\, name=collection1, loadOnStartup=true, schema=schema_latest.xml, config=solrconfig-tlog.xml, instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s2-001\.\collection1, transient=false}
[junit4] 2> 3106379 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.CoresLocator Found core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s2-001\.\collection1\
[junit4] 2> 3106383 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.c.CoresLocator Found 1 core definitions
[junit4] 2> 3106390 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.s.SolrDispatchFilter user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1
[junit4] 2> 3106390 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 3106390 INFO (coreLoadExecutor-7063-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s2-001\.\collection1\'
[junit4] 2> 3106441 INFO (coreLoadExecutor-7063-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 3106464 INFO (coreLoadExecutor-7063-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.3.0
[junit4] 2> 3106516 INFO (coreLoadExecutor-7063-thread-1) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig-tlog.xml
[junit4] 2> 3106517 INFO (coreLoadExecutor-7063-thread-1) [ ] o.a.s.s.IndexSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s2-001\.\collection1\conf\schema_latest.xml
[junit4] 2> 3106527 INFO (coreLoadExecutor-7063-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=example
[junit4] 2> 3106709 WARN (coreLoadExecutor-7063-thread-1) [ ] o.a.s.s.SpatialRecursivePrefixTreeFieldType units parameter is deprecated, please use distanceUnits instead for field types with class SpatialRecursivePrefixTreeFieldType
[junit4] 2> 3106725 INFO (coreLoadExecutor-7063-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 3106855 INFO (coreLoadExecutor-7063-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 3106862 INFO (coreLoadExecutor-7063-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 3107001 INFO (coreLoadExecutor-7063-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s2-001\.\collection1\
[junit4] 2> 3107001 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 3107001 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s2-001\.\collection1\], dataDir=[null]
[junit4] 2> 3107001 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@375a8d07
[junit4] 2> 3107002 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s2-001\.\collection1\data\
[junit4] 2> 3107002 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s2-001\.\collection1\data\index/
[junit4] 2> 3107002 WARN (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s2-001\.\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 3107004 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s2-001\.\collection1\data\index
[junit4] 2> 3107004 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=40, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6803698641565004]
[junit4] 2> 3107005 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@580d90ce lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@629df18b),segFN=segments_1,generation=1}
[junit4] 2> 3107005 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 3107017 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "nodistrib"
[junit4] 2> 3107019 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe"
[junit4] 2> 3107019 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 3107019 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 3107020 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 3107020 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 3107020 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3107020 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3107020 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 3107029 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 3107032 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 3107035 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 3107036 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 3107043 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s2-001\.\collection1\data\
[junit4] 2> 3107048 WARN (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.DirectoryFactory C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s2-001\.\collection1\data\ does not point to a valid data directory; skipping clean-up of old index directories.
[junit4] 2> 3107048 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /update/json/docs,/get,/admin/logging,/replication,/admin/mbeans,/admin/ping,/admin/properties,/admin/file,/admin/system,/admin/luke,/update/json,/admin/segments,/admin/plugins,/admin/threads,standard,/update/csv,/schema,/config,/update
[junit4] 2> 3107052 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 3107056 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 3107056 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 3107183 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
[junit4] 2> 3107183 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
[junit4] 2> 3107185 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=16, maxMergeAtOnceExplicit=17, maxMergedSegmentMB=34.9912109375, floorSegmentMB=0.7392578125, forceMergeDeletesPctAllowed=15.06774538352498, segmentsPerTier=42.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.3038412330103942
[junit4] 2> 3107185 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@580d90ce lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@629df18b),segFN=segments_1,generation=1}
[junit4] 2> 3107185 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 3107185 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@74425c73[collection1] main
[junit4] 2> 3107185 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s2-001\.\collection1\conf
[junit4] 2> 3107186 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s2-001\.\collection1\conf}
[junit4] 2> 3107186 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s2-001\.\collection1\conf
[junit4] 2> 3107188 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 3107188 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 3107188 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets
[junit4] 2> 3107188 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version buckets from index
[junit4] 2> 3107188 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket highest value from index
[junit4] 2> 3107189 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1506595855203827712
[junit4] 2> 3107190 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.u.UpdateLog Took 2 ms to seed version buckets with highest version 1506595855203827712
[junit4] 2> 3107190 INFO (coreLoadExecutor-7063-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 3107192 INFO (searcherExecutor-7064-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@74425c73[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 3107917 INFO (TEST-TestSmileRequest.testDistribJsonRequest-seed#[971177CA5798F95F]) [ ] o.a.s.SolrTestCaseJ4 ===> Started solr server port=51123 home=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\s2-001
[junit4] 2> 3108311 INFO (qtp416942255-16151) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1506595856327901184)} 0 36
[junit4] 2> 3108362 INFO (qtp288829775-16170) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1506595856430661632)} 0 2
[junit4] 2> 3108547 INFO (qtp775786989-16188) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1506595856554393600)} 0 51
[junit4] 2> 3108553 INFO (qtp288829775-16171) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[1 (1506595856631988224)]} 0 0
[junit4] 2> 3108566 INFO (qtp775786989-16190) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[2 (1506595856646668288)]} 0 0
[junit4] 2> 3108586 INFO (qtp416942255-16153) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[3 (1506595856668688384)]} 0 0
[junit4] 2> 3108589 INFO (qtp416942255-16156) [ x:collection1] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 3108592 INFO (qtp416942255-16156) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@9593860 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@40842b6b),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@9593860 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@40842b6b),segFN=segments_2,generation=2}
[junit4] 2> 3108611 INFO (qtp416942255-16156) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 2
[junit4] 2> 3108622 INFO (qtp416942255-16156) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@e142025[collection1] main
[junit4] 2> 3108623 INFO (qtp416942255-16156) [ x:collection1] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 3108639 INFO (searcherExecutor-7042-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@e142025[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1)))}
[junit4] 2> 3108650 INFO (qtp416942255-16156) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={version=2&commit=true&softCommit=false&waitSearcher=true&wt=javabin} {commit=} 0 43
[junit4] 2> 3108657 INFO (qtp288829775-16173) [ x:collection1] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 3108658 INFO (qtp288829775-16173) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@36aebb19 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@97d825b),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@36aebb19 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@97d825b),segFN=segments_2,generation=2}
[junit4] 2> 3108658 INFO (qtp288829775-16173) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 2
[junit4] 2> 3108662 INFO (qtp288829775-16173) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@5a41c7ca[collection1] main
[junit4] 2> 3108662 INFO (qtp288829775-16173) [ x:collection1] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 3108669 INFO (searcherExecutor-7053-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5a41c7ca[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1)))}
[junit4] 2> 3108670 INFO (qtp288829775-16173) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={version=2&commit=true&softCommit=false&waitSearcher=true&wt=javabin} {commit=} 0 9
[junit4] 2> 3108715 INFO (qtp775786989-16191) [ x:collection1] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 3108719 INFO (qtp775786989-16191) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@580d90ce lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@629df18b),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@580d90ce lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@629df18b),segFN=segments_2,generation=2}
[junit4] 2> 3108719 INFO (qtp775786989-16191) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 2
[junit4] 2> 3108743 INFO (qtp775786989-16191) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@58056fa2[collection1] main
[junit4] 2> 3108743 INFO (qtp775786989-16191) [ x:collection1] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 3108745 INFO (searcherExecutor-7064-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@58056fa2[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1)))}
[junit4] 2> 3108755 INFO (qtp775786989-16191) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={version=2&commit=true&softCommit=false&waitSearcher=true&wt=javabin} {commit=} 0 29
[junit4] 2> 3108831 INFO (qtp288829775-16174) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[4 (1506595856867917824)]} 0 40
[junit4] 2> 3108914 INFO (qtp775786989-16186) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[5 (1506595856965435392)]} 0 31
[junit4] 2> 3108923 INFO (qtp416942255-16154) [ x:collection1] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 3108923 INFO (qtp416942255-16154) [ x:collection1] o.a.s.u.UpdateHandler No uncommitted changes. Skipping IW.commit.
[junit4] 2> 3108923 INFO (qtp416942255-16154) [ x:collection1] o.a.s.c.SolrCore SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
[junit4] 2> 3108924 INFO (qtp416942255-16154) [ x:collection1] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 3108924 INFO (qtp416942255-16154) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={version=2&commit=true&softCommit=false&waitSearcher=true&wt=javabin} {commit=} 0 0
[junit4] 2> 3108945 INFO (qtp288829775-16169) [ x:collection1] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 3108997 INFO (qtp288829775-16169) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@36aebb19 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@97d825b),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@36aebb19 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@97d825b),segFN=segments_3,generation=3}
[junit4] 2> 3108999 INFO (qtp288829775-16169) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 3
[junit4] 2> 3109000 INFO (qtp288829775-16169) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@762325a0[collection1] main
[junit4] 2> 3109000 INFO (qtp288829775-16169) [ x:collection1] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 3109000 INFO (searcherExecutor-7053-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@762325a0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1) Uninverting(_1(5.3.0):C1)))}
[junit4] 2> 3109001 INFO (qtp288829775-16169) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={version=2&commit=true&softCommit=false&waitSearcher=true&wt=javabin} {commit=} 0 40
[junit4] 2> 3109037 INFO (qtp775786989-16189) [ x:collection1] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 3109041 INFO (qtp775786989-16189) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@580d90ce lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@629df18b),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@580d90ce lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@629df18b),segFN=segments_3,generation=3}
[junit4] 2> 3109041 INFO (qtp775786989-16189) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 3
[junit4] 2> 3109042 INFO (qtp775786989-16189) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@18b09777[collection1] main
[junit4] 2> 3109043 INFO (searcherExecutor-7064-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@18b09777[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1) Uninverting(_1(5.3.0):C1)))}
[junit4] 2> 3109045 INFO (qtp775786989-16189) [ x:collection1] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 3109045 INFO (qtp775786989-16189) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={version=2&commit=true&softCommit=false&waitSearcher=true&wt=javabin} {commit=} 0 5
[junit4]
[...truncated too long message...]
[junit4] 2> 3115396 INFO (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 3115396 INFO (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\init-core-data-001\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\init-core-data-001\index;done=false>>]
[junit4] 2> 3115396 INFO (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\init-core-data-001\index
[junit4] 2> 3115396 INFO (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\init-core-data-001\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\init-core-data-001\;done=false>>]
[junit4] 2> 3115397 INFO (SUITE-TestSmileRequest-seed#[971177CA5798F95F]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001\init-core-data-001\
[junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.TestSmileRequest_971177CA5798F95F-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene53): {_version_=PostingsFormat(name=LuceneVarGapFixedInterval), where_s=PostingsFormat(name=Direct), id=PostingsFormat(name=Direct), cat_s=PostingsFormat(name=LuceneVarGapFixedInterval)}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=true,coord=no): {}, locale=tr_TR, timezone=Pacific/Gambier
[junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.7.0_80 (64-bit)/cpus=3,threads=1,free=436396384,total=523239424
[junit4] 2> NOTE: All tests run in this JVM: [TestClassNameShortening, TestRestManager, TestCryptoKeys, TestTrie, TestShortCircuitedRequests, TestFieldSortValues, TestFieldTypeResource, ExternalFileFieldSortTest, TestCodecSupport, ChangedSchemaMergeTest, TestRealTimeGet, TestDFRSimilarityFactory, TermVectorComponentTest, TestFreeTextSuggestions, TestRestoreCore, CurrencyFieldXmlFileTest, SharedFSAutoReplicaFailoverTest, StatsComponentTest, EchoParamsTest, ZkNodePropsTest, SpellCheckComponentTest, DistributedQueueTest, SearchHandlerTest, TestAuthorizationFramework, EnumFieldTest, TestRemoteStreaming, HdfsLockFactoryTest, ReplicationFactorTest, TestNamedUpdateProcessors, TestSolrDeletionPolicy2, BadCopyFieldTest, CloudMLTQParserTest, TestImplicitCoreProperties, BasicDistributedZk2Test, TestRTGBase, TestRandomFaceting, HighlighterTest, TestRandomRequestDistribution, CollectionStateFormat2Test, TermsComponentTest, TestQuerySenderListener, TestFoldingMultitermQuery, TestDistributedGrouping, TestDocBasedVersionConstraints, RAMDirectoryFactoryTest, QueryResultKeyTest, TestLRUStatsCache, FieldMutatingUpdateProcessorTest, TestCoreDiscovery, AtomicUpdatesTest, AsyncCallRequestStatusResponseTest, TestFieldCollectionResource, TestNoOpRegenerator, PolyFieldTest, SolrCloudExampleTest, MoreLikeThisHandlerTest, TestChildDocTransformer, ReturnFieldsTest, TestJoin, TestRangeQuery, TestBlendedInfixSuggestions, FastVectorHighlighterTest, TestReversedWildcardFilterFactory, AutoCommitTest, BasicFunctionalityTest, TestOverriddenPrefixQueryForCustomFieldType, ShardSplitTest, TestExactStatsCache, JsonLoaderTest, DistributedExpandComponentTest, TestSolr4Spatial2, DeleteLastCustomShardedReplicaTest, OverriddenZkACLAndCredentialsProvidersTest, FileUtilsTest, DocExpirationUpdateProcessorFactoryTest, LeaderFailoverAfterPartitionTest, DistributedMLTComponentTest, TestComplexPhraseQParserPlugin, TestLMDirichletSimilarityFactory, SimpleMLTQParserTest, TestFastOutputStream, LeaderInitiatedRecoveryOnCommitTest, CollectionsAPIDistributedZkTest, ZkStateWriterTest, SpellPossibilityIteratorTest, TriLevelCompositeIdRoutingTest, CopyFieldTest, TestSystemIdResolver, TestSolrCoreProperties, DistribDocExpirationUpdateProcessorTest, CSVRequestHandlerTest, BasicZkTest, HighlighterMaxOffsetTest, InfoHandlerTest, TestEmbeddedSolrServerConstructors, NotRequiredUniqueKeyTest, StatelessScriptUpdateProcessorFactoryTest, TestExpandComponent, DistributedDebugComponentTest, HighlighterConfigTest, OverseerCollectionProcessorTest, XsltUpdateRequestHandlerTest, CleanupOldIndexTest, DistributedSuggestComponentTest, TestReload, TestRemoveLastDynamicCopyField, TestSchemaNameResource, DeleteInactiveReplicaTest, SolrXmlInZkTest, AnalyticsQueryTest, DebugComponentTest, AddBlockUpdateTest, MBeansHandlerTest, DistributedVersionInfoTest, TestDefaultStatsCache, TestDistribDocBasedVersion, DocumentBuilderTest, DisMaxRequestHandlerTest, TestManagedSchema, TestFieldTypeCollectionResource, ConvertedLegacyTest, SignatureUpdateProcessorFactoryTest, FullSolrCloudDistribCmdsTest, ZkSolrClientTest, TestZkChroot, ShardRoutingCustomTest, TestDistributedSearch, CurrencyFieldOpenExchangeTest, SolrIndexSplitterTest, SuggesterTSTTest, SuggesterTest, SuggesterWFSTTest, NoCacheHeaderTest, SchemaVersionSpecificBehaviorTest, TestWordDelimiterFilterFactory, DirectUpdateHandlerOptimizeTest, DocValuesMultiTest, CacheHeaderTest, TestSurroundQueryParser, TestQueryUtils, StandardRequestHandlerTest, DirectSolrSpellCheckerTest, PrimitiveFieldTypeTest, RequestHandlersTest, TestValueSourceCache, TestSolrQueryParser, LoggingHandlerTest, SolrPluginUtilsTest, TestCollationField, TestCSVResponseWriter, TestAnalyzedSuggestions, BinaryUpdateRequestHandlerTest, PingRequestHandlerTest, TestLFUCache, OutputWriterTest, DirectSolrConnectionTest, TestLuceneMatchVersion, SynonymTokenizerTest, TestSweetSpotSimilarityFactory, TestFastWriter, TestJmxMonitoredMap, ResourceLoaderTest, PluginInfoTest, DateMathParserTest, PreAnalyzedFieldTest, TestSuggestSpellingConverter, DateFieldTest, SpellingQueryConverterTest, TestSolrJ, TestUtils, SliceStateTest, SystemInfoHandlerTest, CircularListTest, CursorPagingTest, SolrTestCaseJ4Test, TestCursorMarkWithoutUniqueKey, TestDistributedMissingSort, TestTolerantSearch, TestJettySolrRunner, AssignTest, AsyncMigrateRouteKeyTest, CollectionReloadTest, ConcurrentDeleteAndCreateCollectionTest, CustomCollectionTest, DeleteShardTest, MigrateRouteKeyTest, OutOfBoxZkACLAndCredentialsProvidersTest, OverseerRolesTest, RemoteQueryErrorTest, TestCloudInspectUtil, TestCloudPivotFacet, TestMiniSolrCloudClusterSSL, TestReplicaProperties, TestSolrCloudWithKerberosAlt, ExitableDirectoryReaderTest, HdfsDirectoryFactoryTest, TestConfigOverlay, TestDynamicLoading, TestInitParams, TestReloadAndDeleteDocs, TestShardHandlerFactory, TestSolrDynamicMBean, TestSolrXml, TestBlobHandler, TestSolrConfigHandlerConcurrent, CoreMergeIndexesAdminHandlerTest, DistributedFacetPivotLargeTest, DistributedFacetPivotLongTailTest, DistributedFacetPivotSmallAdvancedTest, DistributedQueryComponentCustomSortTest, DistributedQueryComponentOptimizationTest, TestDistributedStatsComponentCardinality, TestCloudManagedSchema, TestCloudSchemaless, TestSchemaManager, AnalyticsMergeStrategyTest, CursorMarkTest, MergeStrategyTest, RankQueryTest, TestAddFieldRealTimeGet, TestCollapseQParserPlugin, TestMissingGroups, TestRecoveryHdfs, TestSearcherReuse, TestSmileRequest]
[junit4] Completed [484/508] on J1 in 16.55s, 1 test, 1 error <<< FAILURES!
[...truncated 69 lines...]
[junit4] JVM J1: stdout was not empty, see: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\temp\junit4-J1-20150713_144419_055.sysout
[junit4] >>> JVM J1: stdout (verbatim) ----
[junit4] java.lang.OutOfMemoryError: PermGen space
[junit4] Dumping heap to C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\heapdumps\java_pid3172.hprof ...
[junit4] Heap dump file created [101987904 bytes in 0.566 secs]
[junit4] <<< JVM J1: EOF ----
[...truncated 14 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:536: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:484: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:61: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\extra-targets.xml:39: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build.xml:230: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\common-build.xml:512: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:1444: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:999: There were test failures: 508 suites, 2012 tests, 1 error, 68 ignored (34 assumptions)
Total time: 76 minutes 50 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any