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/04/09 13:58:43 UTC
[JENKINS] Lucene-Solr-trunk-Windows (64bit/jdk1.8.0_40) - Build #
4653 - Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/4653/
Java: 64bit/jdk1.8.0_40 -XX:-UseCompressedOops -XX:+UseSerialGC
1 tests failed.
FAILED: org.apache.solr.update.HardAutoCommitTest.testCommitWithin
Error Message:
Exception during query
Stack Trace:
java.lang.RuntimeException: Exception during query
at __randomizedtesting.SeedInfo.seed([DC8D96FF24681D08:665FF987A746F31D]:0)
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:794)
at org.apache.solr.update.HardAutoCommitTest.testCommitWithin(HardAutoCommitTest.java:100)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:497)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at java.lang.Thread.run(Thread.java:745)
Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=//result[@numFound=1]
xml response was: <?xml version="1.0" encoding="UTF-8"?>
<response>
<lst name="responseHeader"><int name="status">0</int><int name="QTime">0</int></lst><result name="response" numFound="0" start="0"></result>
</response>
request was:q=id:529&qt=standard&start=0&rows=20&version=2.2
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:787)
... 40 more
Build Log:
[...truncated 9699 lines...]
[junit4] Suite: org.apache.solr.update.HardAutoCommitTest
[junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.update.HardAutoCommitTest DC8D96FF24681D08-001\init-core-data-001
[junit4] 2> 1432270 T9431 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (false) and clientAuth (false)
[junit4] 2> 1432270 T9431 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> 1432270 T9431 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\'
[junit4] 2> 1432271 T9431 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 1432271 T9431 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 1432290 T9431 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
[junit4] 2> 1432295 T9431 oasc.SolrConfig.<init> Using Lucene MatchVersion: 6.0.0
[junit4] 2> 1432322 T9431 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1432322 T9431 oass.IndexSchema.readSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\schema.xml
[junit4] 2> 1432326 T9431 oass.IndexSchema.readSchema [null] Schema name=test
[junit4] 2> 1432430 T9431 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1432439 T9431 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 1432440 T9431 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1432445 T9431 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 1432448 T9431 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 1432450 T9431 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1432451 T9431 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 1432451 T9431 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 1432452 T9431 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1432452 T9431 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 1432452 T9431 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 1432453 T9431 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1432453 T9431 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr
[junit4] 2> 1432453 T9431 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\'
[junit4] 2> 1432470 T9431 oasc.CoreContainer.<init> New CoreContainer 1977079815
[junit4] 2> 1432471 T9431 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\]
[junit4] 2> 1432471 T9431 oasc.CoreContainer.load loading shared library: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\lib
[junit4] 2> 1432471 T9431 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: lib (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\lib).
[junit4] 2> 1432481 T9431 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 600000
[junit4] 2> 1432481 T9431 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: null
[junit4] 2> 1432481 T9431 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 60000
[junit4] 2> 1432481 T9431 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 1432482 T9431 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000
[junit4] 2> 1432482 T9431 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 1432482 T9431 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 1432482 T9431 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 1432483 T9431 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 1432483 T9431 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 1432483 T9431 oashc.HttpShardHandlerFactory.getParameter Setting useRetries to: false
[junit4] 2> 1432484 T9431 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true
[junit4] 2> 1432485 T9431 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1432486 T9431 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1432486 T9431 oasc.CoreContainer.load Node Name: testNode
[junit4] 2> 1432488 T9431 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, instanceDir=collection1, collection=collection1, absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.update.HardAutoCommitTest DC8D96FF24681D08-001\init-core-data-001, shard=shard1}
[junit4] 2> 1432491 T9432 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\'
[junit4] 2> 1432492 T9432 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 1432493 T9432 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 1432519 T9432 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
[junit4] 2> 1432530 T9432 oasc.SolrConfig.<init> Using Lucene MatchVersion: 6.0.0
[junit4] 2> 1432566 T9432 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1432567 T9432 oass.IndexSchema.readSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\schema.xml
[junit4] 2> 1432573 T9432 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 1432682 T9432 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1432687 T9432 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 1432689 T9432 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1432695 T9432 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 1432697 T9432 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 1432700 T9432 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1432700 T9432 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 1432700 T9432 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 1432700 T9432 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1432700 T9432 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 1432700 T9432 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 1432700 T9432 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\
[junit4] 2> 1432701 T9432 c:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1432701 T9432 c:collection1 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.update.HardAutoCommitTest DC8D96FF24681D08-001\init-core-data-001\
[junit4] 2> 1432701 T9432 c:collection1 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1129cff3
[junit4] 2> 1432702 T9432 c:collection1 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.update.HardAutoCommitTest DC8D96FF24681D08-001\init-core-data-001\
[junit4] 2> 1432702 T9432 c:collection1 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.update.HardAutoCommitTest DC8D96FF24681D08-001\init-core-data-001\index/
[junit4] 2> 1432702 T9432 c:collection1 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.update.HardAutoCommitTest DC8D96FF24681D08-001\init-core-data-001\index' doesn't exist. Creating new index...
[junit4] 2> 1432704 T9432 c:collection1 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.update.HardAutoCommitTest DC8D96FF24681D08-001\init-core-data-001\index
[junit4] 2> 1432705 T9432 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=48, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5623541878382635]
[junit4] 2> 1432713 T9432 c:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.update.HardAutoCommitTest DC8D96FF24681D08-001\index-NIOFSDirectory-001 lockFactory=org.apache.lucene.store.NativeFSLockFactory@2c81b03b),segFN=segments_1,generation=1}
[junit4] 2> 1432714 T9432 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1432721 T9432 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 1432721 T9432 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 1432721 T9432 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 1432721 T9432 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 1432722 T9432 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 1432723 T9432 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 1432723 T9432 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
[junit4] 2> 1432723 T9432 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 1432723 T9432 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 1432724 T9432 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1432724 T9432 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1432724 T9432 c:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1432730 T9432 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1432731 T9432 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1432732 T9432 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1432734 T9432 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1432738 T9432 c:collection1 oasc.PluginBag.createPlugin requestHandler : 'lazy' created with startup=lazy
[junit4] 2> 1432740 T9432 c:collection1 oasc.RequestHandlers.initHandlersFromConfig Registered paths: /admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admin/luke,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/properties,/update/json,mltrh,/admin/threads,/search-facet-def,/update/csv,/search-facet-invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/replication,dismax,defaults,/config,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/terms,spellCheckCompRH_Direct,/debug/dump
[junit4] 2> 1432741 T9432 c:collection1 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 1432741 T9432 c:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 1432742 T9432 c:collection1 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1432743 T9432 c:collection1 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
[junit4] 2> 1432743 T9432 c:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 1432743 T9432 c:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 1432744 T9432 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=18, maxMergeAtOnceExplicit=25, maxMergedSegmentMB=65.53515625, floorSegmentMB=0.4921875, forceMergeDeletesPctAllowed=16.04131594363161, segmentsPerTier=34.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 1432745 T9432 c:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.update.HardAutoCommitTest DC8D96FF24681D08-001\index-NIOFSDirectory-001 lockFactory=org.apache.lucene.store.NativeFSLockFactory@2c81b03b),segFN=segments_1,generation=1}
[junit4] 2> 1432745 T9432 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1432745 T9432 c:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@66eed3be[collection1] main
[junit4] 2> 1432745 T9432 c:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 1432745 T9432 c:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 1432746 T9432 c:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 1432746 T9432 c:collection1 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4] 2> 1432752 T9432 c:collection1 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1432786 T9432 c:collection1 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 1432787 T9432 c:collection1 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 1432788 T9433 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default
[junit4] 2> 1432788 T9433 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: direct
[junit4] 2> 1432788 T9433 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak
[junit4] 2> 1432788 T9433 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: multipleFields
[junit4] 2> 1432789 T9433 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1432789 T9433 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: external
[junit4] 2> 1432790 T9433 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: freq
[junit4] 2> 1432790 T9431 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 1432791 T9433 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: fqcn
[junit4] 2> 1432791 T9433 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: perDict
[junit4] 2> 1432792 T9433 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@66eed3be[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1432792 T9431 oas.SolrTestCaseJ4.setUp ###Starting testCommitWithin
[junit4] 2> ASYNC NEW_CORE C4328 name=collection1 org.apache.solr.core.SolrCore@77f4e6e4
[junit4] 2> 1432795 T9431 C4328 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:* (-1497974593316454400)} 0 3
[junit4] 2> 1432797 T9431 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\'
[junit4] 2> 1432799 T9431 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 1432799 T9431 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 1432849 T9431 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
[junit4] 2> 1432857 T9431 oasc.SolrConfig.<init> Using Lucene MatchVersion: 6.0.0
[junit4] 2> 1432871 T9431 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1432872 T9431 oass.IndexSchema.readSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\schema.xml
[junit4] 2> 1432875 T9431 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 1433012 T9431 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1433018 T9431 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 1433020 T9431 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1433030 T9431 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 1433033 T9431 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 1433035 T9431 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1433036 T9431 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 1433037 T9431 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 1433038 T9431 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1433038 T9431 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 1433039 T9431 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 1433039 T9431 oasc.CoreContainer.reload Reloading SolrCore 'collection1' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\
[junit4] 2> 1433040 T9431 c:collection1 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.update.HardAutoCommitTest DC8D96FF24681D08-001\init-core-data-001\
[junit4] 2> 1433041 T9431 c:collection1 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1129cff3
[junit4] 2> 1433041 T9431 c:collection1 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.update.HardAutoCommitTest DC8D96FF24681D08-001\init-core-data-001\index/
[junit4] 2> 1433049 T9431 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 1433049 T9431 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 1433050 T9431 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 1433050 T9431 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 1433050 T9431 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 1433050 T9431 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 1433051 T9431 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
[junit4] 2> 1433051 T9431 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 1433051 T9431 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 1433052 T9431 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1433052 T9431 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1433053 T9431 c:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1433055 T9431 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1433056 T9431 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1433058 T9431 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1433060 T9431 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1433076 T9431 c:collection1 oasc.PluginBag.createPlugin requestHandler : 'lazy' created with startup=lazy
[junit4] 2> 1433079 T9431 c:collection1 oasc.RequestHandlers.initHandlersFromConfig Registered paths: /admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admin/luke,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/properties,/update/json,mltrh,/admin/threads,/search-facet-def,/update/csv,/search-facet-invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/replication,dismax,defaults,/config,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/terms,spellCheckCompRH_Direct,/debug/dump
[junit4] 2> 1433080 T9431 c:collection1 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 1433081 T9431 c:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 1433083 T9431 c:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 1433083 T9431 c:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 1433084 T9431 c:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@67910cfe[collection1] main
[junit4] 2> 1433085 T9431 c:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 1433085 T9431 c:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 1433085 T9431 c:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 1433086 T9431 c:collection1 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4] 2> 1433087 T9431 c:collection1 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1433094 T9431 c:collection1 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 1433096 T9431 c:collection1 oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter...
[junit4] 2> 1433097 T9431 c:collection1 oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused... core=collection1
[junit4] 2> 1433097 T9431 c:collection1 oasu.DefaultSolrCoreState.newIndexWriter Closing old IndexWriter... core=collection1
[junit4] 2> 1433101 T9435 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default
[junit4] 2> 1433102 T9435 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: direct
[junit4] 2> 1433102 T9435 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak
[junit4] 2> 1433102 T9435 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: multipleFields
[junit4] 2> 1433103 T9435 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1433104 T9435 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: external
[junit4] 2> 1433104 T9435 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: freq
[junit4] 2> 1433105 T9435 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: fqcn
[junit4] 2> 1433105 T9435 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: perDict
[junit4] 2> 1433106 T9435 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@67910cfe[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1433108 T9431 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=27, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 1433110 T9431 c:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.update.HardAutoCommitTest DC8D96FF24681D08-001\index-NIOFSDirectory-001 lockFactory=org.apache.lucene.store.NativeFSLockFactory@2c81b03b),segFN=segments_1,generation=1}
[junit4] 2> 1433111 T9431 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1433111 T9431 c:collection1 oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used.
[junit4] 2> 1433111 T9431 c:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@4f21276e[collection1] main
[junit4] 2> 1433112 T9431 c:collection1 oasc.CoreContainer.registerCore replacing core: collection1
[junit4] 2> 1433112 T9431 c:collection1 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@77f4e6e4
[junit4] 2> 1433112 T9431 c:collection1 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=1,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
[junit4] 2> 1433113 T9431 c:collection1 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 1433136 T9435 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4f21276e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1433142 T9431 c:collection1 oasup.LogUpdateProcessor.finish [collection1] {add=[529 (1497974593671921664)]} 0 14
[junit4] 2> ASYNC NEW_CORE C4329 name=collection1 org.apache.solr.core.SolrCore@297612de
[junit4] 2> 1433142 T9431 c:collection1 C4329 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 1433144 T9431 c:collection1 oasup.LogUpdateProcessor.finish [collection1] {add=[530 (1497974593684504576)]} 0 16
[junit4] 2> 1433145 T9431 c:collection1 C4329 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 1433146 T9431 c:collection1 oasup.LogUpdateProcessor.finish [collection1] {delete=[529 (-1497974593686601728)]} 0 18
[junit4] 2> 1433146 T9431 c:collection1 C4329 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 1433147 T9431 c:collection1 oas.SolrTestCaseJ4.assertQ ERROR REQUEST FAILED: xpath=//result[@numFound=1]
[junit4] 2> xml response was: <?xml version="1.0" encoding="UTF-8"?>
[junit4] 2> <response>
[junit4] 2> <lst name="responseHeader"><int name="status">0</int><int name="QTime">0</int></lst><result name="response" numFound="0" start="0"></result>
[junit4] 2> </response>
[junit4] 2>
[junit4] 2> request was:q=id:529&qt=standard&start=0&rows=20&version=2.2
[junit4] 2> 1433147 T9431 c:collection1 oasc.SolrException.log ERROR REQUEST FAILED: q=id:529&qt=standard&start=0&rows=20&version=2.2:java.lang.RuntimeException: REQUEST FAILED: xpath=//result[@numFound=1]
[junit4] 2> xml response was: <?xml version="1.0" encoding="UTF-8"?>
[junit4] 2> <response>
[junit4] 2> <lst name="responseHeader"><int name="status">0</int><int name="QTime">0</int></lst><result name="response" numFound="0" start="0"></result>
[junit4] 2> </response>
[junit4] 2>
[junit4] 2> request was:q=id:529&qt=standard&start=0&rows=20&version=2.2
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:787)
[junit4] 2> at org.apache.solr.update.HardAutoCommitTest.testCommitWithin(HardAutoCommitTest.java:100)
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:497)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[junit4] 2> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
[junit4] 2> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> 1433148 T9431 c:collection1 oas.SolrTestCaseJ4.tearDown ###Ending testCommitWithin
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=HardAutoCommitTest -Dtests.method=testCommitWithin -Dtests.seed=DC8D96FF24681D08 -Dtests.slow=true -Dtests.locale= -Dtests.timezone=Atlantic/Faroe -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.36s J1 | HardAutoCommitTest.testCommitWithin <<<
[junit4] > Throwable #1: java.lang.RuntimeException: Exception during query
[junit4] > at __randomizedtesting.SeedInfo.seed([DC8D96FF24681D08:665FF987A746F31D]:0)
[junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:794)
[junit4] > at org.apache.solr.update.HardAutoCommitTest.testCommitWithin(HardAutoCommitTest.java:100)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=//result[@numFound=1]
[junit4] > xml response was: <?xml version="1.0" encoding="UTF-8"?>
[junit4] > <response>
[junit4] > <lst name="responseHeader"><int name="status">0</int><int name="QTime">0</int></lst><result name="response" numFound="0" start="0"></result>
[junit4] > </response>
[junit4] > request was:q=id:529&qt=standard&start=0&rows=20&version=2.2
[junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:787)
[junit4] > ... 40 more
[junit4] 2> 1433154 T9431 c:collection1 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 1433154 T9431 c:collection1 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1977079815
[junit4] 2> 1433155 T9431 c:collection1 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@297612de
[junit4] 2> 1433155 T9431 c:collection1 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=2,adds=2,deletesById=1,deletesByQuery=0,errors=0,cumulative_adds=2,cumulative_deletesById=1,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
[junit4] 2> 1433155 T9431 c:collection1 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 1433155 T9431 c:collection1 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 1433155 T9431 c:collection1 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 1433155 T9431 c:collection1 C4329 oasu.DirectUpdateHandler2.closeWriter Committing on IndexWriter close.
[junit4] 2> 1433208 T9431 c:collection1 C4329 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.update.HardAutoCommitTest DC8D96FF24681D08-001\index-NIOFSDirectory-001 lockFactory=org.apache.lucene.store.NativeFSLockFactory@2c81b03b),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.update.HardAutoCommitTest DC8D96FF24681D08-001\index-NIOFSDirectory-001 lockFactory=org.apache.lucene.store.NativeFSLockFactory@2c81b03b),segFN=segments_2,generation=2}
[junit4] 2> 1433208 T9431 c:collection1 C4329 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 1433211 T9431 c:collection1 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 1433228 T9431 c:collection1 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 1433228 T9431 c:collection1 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.update.HardAutoCommitTest DC8D96FF24681D08-001\init-core-data-001\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.update.HardAutoCommitTest DC8D96FF24681D08-001\init-core-data-001\;done=false>>]
[junit4] 2> 1433228 T9431 c:collection1 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.update.HardAutoCommitTest DC8D96FF24681D08-001\init-core-data-001\
[junit4] 2> 1433229 T9431 c:collection1 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.update.HardAutoCommitTest DC8D96FF24681D08-001\init-core-data-001\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.update.HardAutoCommitTest DC8D96FF24681D08-001\init-core-data-001\index;done=false>>]
[junit4] 2> 1433229 T9431 c:collection1 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.update.HardAutoCommitTest DC8D96FF24681D08-001\init-core-data-001\index
[junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.update.HardAutoCommitTest DC8D96FF24681D08-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene50): {_version_=PostingsFormat(name=MockRandom), field_t=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), multiDefault=PostingsFormat(name=Direct), subject=PostingsFormat(name=Direct), intDefault=PostingsFormat(name=MockRandom), id=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), text=BlockTreeOrds(blocksize=128), range_facet_l=PostingsFormat(name=Direct), timestamp=PostingsFormat(name=Direct)}, docValues:{timestamp=DocValuesFormat(name=Direct)}, sim=DefaultSimilarity, locale=, timezone=Atlantic/Faroe
[junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.8.0_40 (64-bit)/cpus=3,threads=1,free=110456032,total=359493632
[junit4] 2> NOTE: All tests run in this JVM: [SSLMigrationTest, CursorPagingTest, DocExpirationUpdateProcessorFactoryTest, TestReversedWildcardFilterFactory, TestCoreDiscovery, ExitableDirectoryReaderTest, TestFastOutputStream, ReplicationFactorTest, OutOfBoxZkACLAndCredentialsProvidersTest, FullSolrCloudDistribCmdsTest, TestDynamicLoading, TestLuceneMatchVersion, TestAnalyzeInfixSuggestions, ShardSplitTest, TestCloudManagedSchema, AnalyticsQueryTest, CurrencyFieldOpenExchangeTest, FastVectorHighlighterTest, PluginInfoTest, ReturnFieldsTest, CopyFieldTest, TermsComponentTest, DocumentBuilderTest, TestCodecSupport, TestRangeQuery, TestManagedSchemaFieldTypeResource, ResourceLoaderTest, DirectUpdateHandlerOptimizeTest, TestRawResponseWriter, TestSolrJ, TestNamedUpdateProcessors, DistributedFacetPivotSmallTest, FileBasedSpellCheckerTest, SpellCheckCollatorTest, TestTrie, TestInfoStreamLogging, SolrIndexConfigTest, TestDefaultSimilarityFactory, TestTolerantSearch, TestHdfsUpdateLog, TestRecovery, ResponseHeaderTest, TestCryptoKeys, TestMergePolicyConfig, TestDocBasedVersionConstraints, QueryParsingTest, BasicDistributedZk2Test, ZkSolrClientTest, HdfsSyncSliceTest, InfoHandlerTest, OpenExchangeRatesOrgProviderTest, TestEmbeddedSolrServerConstructors, SpatialFilterTest, TestRestManager, TermVectorComponentDistributedTest, HdfsBasicDistributedZkTest, TestConfigReload, TestExactStatsCache, TestSolrQueryParserDefaultOperatorResource, HighlighterTest, AsyncMigrateRouteKeyTest, CloudMLTQParserTest, CSVRequestHandlerTest, TestRandomFaceting, TestSchemaSimilarityResource, TestPivotHelperCode, MoreLikeThisHandlerTest, ConnectionManagerTest, LoggingHandlerTest, AnalyticsMergeStrategyTest, TestQuerySenderNoQuery, QueryEqualityTest, TestBadConfig, ExternalCollectionsTest, WordBreakSolrSpellCheckerTest, TestCloudManagedSchemaConcurrent, TestFuzzyAnalyzedSuggestions, LeaderElectionIntegrationTest, HighlighterConfigTest, BasicZkTest, SpellPossibilityIteratorTest, CollectionsAPIDistributedZkTest, TestDFRSimilarityFactory, TestSolrQueryParser, TestStressUserVersions, JsonLoaderTest, TestSolrDeletionPolicy1, TestReplicationHandlerBackup, TestCopyFieldCollectionResource, TestPHPSerializedResponseWriter, CachingDirectoryFactoryTest, TestManagedResource, DistributedMLTComponentTest, SchemaVersionSpecificBehaviorTest, TestFoldingMultitermQuery, TestAddFieldRealTimeGet, RollingRestartTest, FieldMutatingUpdateProcessorTest, LeaderInitiatedRecoveryOnCommitTest, XsltUpdateRequestHandlerTest, OverseerStatusTest, SolrRequestParserTest, HdfsLockFactoryTest, TriLevelCompositeIdRoutingTest, DistributedQueryComponentOptimizationTest, TestDefaultSearchFieldResource, TestFieldTypeResource, TestNonDefinedSimilarityFactory, SearchHandlerTest, TestSuggestSpellingConverter, TestValueSourceCache, PrimitiveFieldTypeTest, BasicFunctionalityTest, TestJoin, TestSchemaVersionResource, TestZkChroot, TestHashQParserPlugin, SolrTestCaseJ4Test, ShardRoutingCustomTest, TestDistributedGrouping, TestRealTimeGet, TestReload, HardAutoCommitTest]
[junit4] Completed [257/482] on J1 in 0.98s, 1 test, 1 error <<< FAILURES!
[...truncated 692 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:519: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:467: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:61: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\extra-targets.xml:39: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:191: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:510: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1351: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:958: There were test failures: 482 suites, 1910 tests, 1 error, 58 ignored (30 assumptions)
Total time: 56 minutes 50 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 64bit/jdk1.8.0_40 -XX:-UseCompressedOops -XX:+UseSerialGC
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
[JENKINS] Lucene-Solr-trunk-Windows (32bit/jdk1.8.0_40) - Build #
4655 - Still Failing!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/4655/
Java: 32bit/jdk1.8.0_40 -server -XX:+UseParallelGC
1 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.core.TestSolrConfigHandler
Error Message:
Could not remove the following files (in the order of attempts): C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-010\collection1\conf\configoverlay.json: java.nio.file.FileSystemException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-010\collection1\conf\configoverlay.json: The process cannot access the file because it is being used by another process. C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-010\collection1\conf: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-010\collection1\conf C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-010\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-010\collection1 C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-010: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-010 C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-010: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-010 C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001
Stack Trace:
java.io.IOException: Could not remove the following files (in the order of attempts):
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-010\collection1\conf\configoverlay.json: java.nio.file.FileSystemException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-010\collection1\conf\configoverlay.json: The process cannot access the file because it is being used by another process.
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-010\collection1\conf: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-010\collection1\conf
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-010\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-010\collection1
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-010: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-010
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-010: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-010
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001
at __randomizedtesting.SeedInfo.seed([5E82983A0FE5F972]:0)
at org.apache.lucene.util.IOUtils.rm(IOUtils.java:286)
at org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:200)
at com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterAlways(TestRuleAdapter.java:31)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 10177 lines...]
[junit4] Suite: org.apache.solr.core.TestSolrConfigHandler
[junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\init-core-data-001
[junit4] 2> 1921779 T10600 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (true) and clientAuth (false)
[junit4] 2> 1921782 T10600 oas.SolrTestCaseJ4.setUp ###Starting testProperty
[junit4] 2> 1922069 T10600 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> 1922069 T10600 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 1922070 T10600 oas.SolrTestCaseJ4.writeCoreProperties Writing core.properties file to C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-003\cores\core
[junit4] 2> 1922072 T10600 oejs.Server.doStart jetty-9.2.9.v20150224
[junit4] 2> 1922075 T10600 oejsh.ContextHandler.doStart Started o.e.j.s.ServletContextHandler@a23f0b{/solr,null,AVAILABLE}
[junit4] 2> 1922082 T10600 oejs.AbstractConnector.doStart Started ServerConnector@1ff9efb{SSL-http/1.1}{127.0.0.1:56153}
[junit4] 2> 1922082 T10600 oejs.Server.doStart Started @1924963ms
[junit4] 2> 1922082 T10600 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {hostContext=/solr, hostPort=56153, configSetBaseDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001, coreRootDirectory=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-003\cores}
[junit4] 2> 1922085 T10600 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@e2f2a
[junit4] 2> 1922085 T10600 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\'
[junit4] 2> 1922105 T10600 oasc.SolrXmlConfig.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\solr.xml
[junit4] 2> 1922111 T10600 oasc.CorePropertiesLocator.<init> Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-003\cores
[junit4] 2> 1922111 T10600 oasc.CoreContainer.<init> New CoreContainer 19233401
[junit4] 2> 1922112 T10600 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\]
[junit4] 2> 1922112 T10600 oasc.CoreContainer.load loading shared library: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\lib
[junit4] 2> 1922112 T10600 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: lib (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\lib).
[junit4] 2> 1922118 T10600 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 1922118 T10600 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: https
[junit4] 2> 1922118 T10600 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 1922119 T10600 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 1922119 T10600 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000
[junit4] 2> 1922120 T10600 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 1922120 T10600 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 1922120 T10600 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 1922120 T10600 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 1922120 T10600 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 1922121 T10600 oashc.HttpShardHandlerFactory.getParameter Setting useRetries to: false
[junit4] 2> 1922125 T10600 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1922127 T10600 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1922128 T10600 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1922128 T10600 oasc.CoreContainer.load Node Name: 127.0.0.1
[junit4] 2> 1922129 T10600 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-003\cores
[junit4] 2> 1922130 T10600 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {name=collection1, config=solrconfig-managed-schema.xml, transient=false, schema=schema-rest.xml, loadOnStartup=true, instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-003\cores\core, absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-003\cores\core\, configSet=collection1, dataDir=data\}
[junit4] 2> 1922130 T10600 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-003\cores\core\
[junit4] 2> 1922130 T10600 oasc.CorePropertiesLocator.discover Found 1 core definitions
[junit4] 2> 1922131 T10612 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\'
[junit4] 2> 1922132 T10612 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.core.TestSolrConfigHandler%205E82983A0FE5F972-001/tempDir-001/collection1/lib/classes/' to classloader
[junit4] 2> 1922133 T10612 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.core.TestSolrConfigHandler%205E82983A0FE5F972-001/tempDir-001/collection1/lib/README' to classloader
[junit4] 2> 1922153 T10612 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
[junit4] 2> 1922155 T10612 oasc.SolrConfig.<init> Using Lucene MatchVersion: 6.0.0
[junit4] 2> 1922158 T10612 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-managed-schema.xml
[junit4] 2> 1922162 T10612 oass.ManagedIndexSchemaFactory.readSchemaLocally The schema is configured as managed, but managed schema resource managed-schema not found - loading non-managed schema schema-rest.xml instead
[junit4] 2> 1922162 T10612 oass.IndexSchema.readSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf\schema-rest.xml
[junit4] 2> 1922166 T10612 oass.IndexSchema.readSchema [collection1] Schema name=test-rest
[junit4] 2> 1922221 T10612 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 1922221 T10612 oass.IndexSchema.readSchema query parser default operator is OR
[junit4] 2> 1922221 T10612 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1922222 T10612 oass.IndexSchema.loadCopyFields WARN Field title is not multivalued and destination for multiple copyFields (3)
[junit4] 2> 1922224 T10612 oasr.RestManager$Registry.registerManagedResource Registered ManagedResource impl org.apache.solr.rest.schema.analysis.ManagedWordSetResource for path /schema/analysis/stopwords/german
[junit4] 2> 1922224 T10612 oasr.RestManager$Registry.registerManagedResource Registered ManagedResource impl org.apache.solr.rest.schema.analysis.ManagedSynonymFilterFactory$SynonymManager for path /schema/analysis/synonyms/german
[junit4] 2> 1922232 T10612 oasr.RestManager$Registry.registerManagedResource Registered ManagedResource impl org.apache.solr.rest.schema.analysis.ManagedWordSetResource for path /schema/analysis/stopwords/english
[junit4] 2> 1922232 T10612 oasr.RestManager$Registry.registerManagedResource Registered ManagedResource impl org.apache.solr.rest.schema.analysis.ManagedSynonymFilterFactory$SynonymManager for path /schema/analysis/synonyms/english
[junit4] 2> 1922239 T10612 oasr.RestManager$Registry.registerManagedResource Added observer of type org.apache.solr.rest.schema.analysis.ManagedStopFilterFactory to existing ManagedResource /schema/analysis/stopwords/english
[junit4] 2> 1922239 T10612 oasr.RestManager$Registry.registerManagedResource Added observer of type org.apache.solr.rest.schema.analysis.ManagedSynonymFilterFactory to existing ManagedResource /schema/analysis/synonyms/english
[junit4] 2> 1922239 T10612 oasr.RestManager$Registry.registerManagedResource Added observer of type org.apache.solr.rest.schema.analysis.ManagedStopFilterFactory to existing ManagedResource /schema/analysis/stopwords/german
[junit4] 2> 1922239 T10612 oasr.RestManager$Registry.registerManagedResource Added observer of type org.apache.solr.rest.schema.analysis.ManagedSynonymFilterFactory to existing ManagedResource /schema/analysis/synonyms/german
[junit4] 2> 1922244 T10612 oass.ManagedIndexSchema.persistManagedSchema Upgraded to managed schema at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf\managed-schema
[junit4] 2> 1922248 T10612 oass.ManagedIndexSchemaFactory.upgradeToManagedSchema After upgrading to managed schema, renamed the non-managed schema C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf\schema-rest.xml to C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf\schema-rest.xml.bak
[junit4] 2> 1922248 T10612 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from configset C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1
[junit4] 2> 1922248 T10612 c:collection1 oasc.SolrCore.initDirectoryFactory solr.NRTCachingDirectoryFactory
[junit4] 2> 1922248 T10612 c:collection1 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-003\cores\core\data\
[junit4] 2> 1922248 T10612 c:collection1 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 1922249 T10612 c:collection1 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-003\cores\core\data
[junit4] 2> 1922250 T10612 c:collection1 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-003\cores\core\data\index/
[junit4] 2> 1922251 T10612 c:collection1 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-003\cores\core\data\index' doesn't exist. Creating new index...
[junit4] 2> 1922251 T10612 c:collection1 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-003\cores\core\data\index
[junit4] 2> 1922252 T10612 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=34, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=72.310546875, floorSegmentMB=0.8935546875, forceMergeDeletesPctAllowed=12.215781134846516, segmentsPerTier=27.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5718349491585829
[junit4] 2> 1922255 T10612 c:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=NRTCachingDirectory(SimpleFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-003\cores\core\data\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1e72146; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
[junit4] 2> 1922255 T10612 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1922258 T10612 c:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1922258 T10612 c:collection1 oasc.RequestHandlers.applyInitParams WARN INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,args = {defaults={a=A,b=B}}}
[junit4] 2> 1922261 T10612 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1922262 T10612 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1922263 T10612 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1922265 T10612 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1922266 T10612 c:collection1 oasc.RequestHandlers.initHandlersFromConfig Registered paths: /admin/mbeans,standard,/dump,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
[junit4] 2> 1922266 T10612 c:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 1922268 T10612 c:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 1922268 T10612 c:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 1922269 T10612 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=16, maxMergeAtOnceExplicit=17, maxMergedSegmentMB=51.3076171875, floorSegmentMB=0.34765625, forceMergeDeletesPctAllowed=9.41018951041065, segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 1922269 T10612 c:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=NRTCachingDirectory(SimpleFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-003\cores\core\data\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1e72146; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
[junit4] 2> 1922269 T10612 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1922270 T10612 c:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@85ca2c[collection1] main
[junit4] 2> 1922270 T10612 c:collection1 oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage initialized to use dir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf
[junit4] 2> 1922270 T10612 c:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf}
[junit4] 2> 1922271 T10612 c:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf
[junit4] 2> 1922271 T10612 c:collection1 oasr.RestManager.init Initializing 4 registered ManagedResources
[junit4] 2> 1922271 T10612 c:collection1 oasr.ManagedResourceStorage.load Reading _schema_analysis_stopwords_english.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf
[junit4] 2> 1922272 T10612 c:collection1 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /schema/analysis/stopwords/english
[junit4] 2> 1922272 T10612 c:collection1 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _schema_analysis_stopwords_english.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf
[junit4] 2> 1922273 T10612 c:collection1 oasrsa.ManagedWordSetResource.onManagedDataLoadedFromStorage Loaded 0 words for /schema/analysis/stopwords/english
[junit4] 2> 1922273 T10612 c:collection1 oasr.ManagedResource.notifyObserversDuringInit Notified 2 observers of /schema/analysis/stopwords/english
[junit4] 2> 1922273 T10612 c:collection1 oasr.ManagedResourceStorage.load Reading _schema_analysis_stopwords_german.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf
[junit4] 2> 1922273 T10612 c:collection1 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /schema/analysis/stopwords/german
[junit4] 2> 1922274 T10612 c:collection1 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _schema_analysis_stopwords_german.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf
[junit4] 2> 1922274 T10612 c:collection1 oasrsa.ManagedWordSetResource.onManagedDataLoadedFromStorage Loaded 0 words for /schema/analysis/stopwords/german
[junit4] 2> 1922274 T10612 c:collection1 oasr.ManagedResource.notifyObserversDuringInit Notified 2 observers of /schema/analysis/stopwords/german
[junit4] 2> 1922274 T10612 c:collection1 oasr.ManagedResourceStorage.load Reading _schema_analysis_synonyms_english.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf
[junit4] 2> 1922275 T10612 c:collection1 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /schema/analysis/synonyms/english
[junit4] 2> 1922275 T10612 c:collection1 oasrsa.ManagedSynonymFilterFactory$SynonymManager.onManagedDataLoadedFromStorage Loaded 0 synonym mappings for /schema/analysis/synonyms/english
[junit4] 2> 1922275 T10612 c:collection1 oasr.ManagedResource.notifyObserversDuringInit Notified 2 observers of /schema/analysis/synonyms/english
[junit4] 2> 1922275 T10612 c:collection1 oasr.ManagedResourceStorage.load Reading _schema_analysis_synonyms_german.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf
[junit4] 2> 1922276 T10612 c:collection1 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /schema/analysis/synonyms/german
[junit4] 2> 1922276 T10612 c:collection1 oasrsa.ManagedSynonymFilterFactory$SynonymManager.onManagedDataLoadedFromStorage Loaded 0 synonym mappings for /schema/analysis/synonyms/german
[junit4] 2> 1922276 T10612 c:collection1 oasr.ManagedResource.notifyObserversDuringInit Notified 2 observers of /schema/analysis/synonyms/german
[junit4] 2> 1922277 T10612 c:collection1 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 1922277 T10613 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@85ca2c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1922277 T10612 c:collection1 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 1922277 T10600 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4] 2> 1922278 T10600 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 1922278 T10600 oas.SolrJettyTestBase.createJetty Jetty Assigned Port#56153
[junit4] 2> ASYNC NEW_CORE C1105 name=collection1 org.apache.solr.core.SolrCore@12e01b2
[junit4] 2> 1922330 T10606 c:collection1 C1105 oasc.SolrCore.execute [collection1] webapp=/solr path=/config params={wt=json} status=0 QTime=1
[junit4] 2> 1922339 T10607 c:collection1 C1105 oasc.SolrResourceLoader.persistConfLocally Written confile configoverlay.json
[junit4] 2> 1922343 T10607 c:collection1 C1105 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\'
[junit4] 2> 1922345 T10607 c:collection1 C1105 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.core.TestSolrConfigHandler%205E82983A0FE5F972-001/tempDir-001/collection1/lib/classes/' to classloader
[junit4] 2> 1922345 T10607 c:collection1 C1105 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.core.TestSolrConfigHandler%205E82983A0FE5F972-001/tempDir-001/collection1/lib/README' to classloader
[junit4] 2> 1922379 T10607 c:collection1 C1105 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
[junit4] 2> 1922380 T10607 c:collection1 C1105 oasc.SolrConfig.<init> Using Lucene MatchVersion: 6.0.0
[junit4] 2> 1922384 T10607 c:collection1 C1105 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-managed-schema.xml
[junit4] 2> 1922388 T10607 c:collection1 C1105 oass.IndexSchema.readSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf\managed-schema
[junit4] 2> 1922390 T10607 c:collection1 C1105 oass.IndexSchema.readSchema [collection1] Schema name=test-rest
[junit4] 2> ASYNC NEW_CORE C1106 name=collection1 org.apache.solr.core.SolrCore@12e01b2
[junit4] 2> 1922444 T10607 c:collection1 C1106 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 1922444 T10607 c:collection1 C1106 oass.IndexSchema.readSchema query parser default operator is OR
[junit4] 2> 1922445 T10607 c:collection1 C1106 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1922446 T10607 c:collection1 C1106 oass.IndexSchema.loadCopyFields WARN Field title is not multivalued and destination for multiple copyFields (3)
[junit4] 2> 1922448 T10607 c:collection1 C1106 oasr.RestManager$Registry.registerManagedResource Registered ManagedResource impl org.apache.solr.rest.schema.analysis.ManagedWordSetResource for path /schema/analysis/stopwords/german
[junit4] 2> 1922448 T10607 c:collection1 C1106 oasr.RestManager$Registry.registerManagedResource Registered ManagedResource impl org.apache.solr.rest.schema.analysis.ManagedSynonymFilterFactory$SynonymManager for path /schema/analysis/synonyms/german
[junit4] 2> 1922454 T10607 c:collection1 C1106 oasr.RestManager$Registry.registerManagedResource Registered ManagedResource impl org.apache.solr.rest.schema.analysis.ManagedWordSetResource for path /schema/analysis/stopwords/english
[junit4] 2> 1922455 T10607 c:collection1 C1106 oasr.RestManager$Registry.registerManagedResource Registered ManagedResource impl org.apache.solr.rest.schema.analysis.ManagedSynonymFilterFactory$SynonymManager for path /schema/analysis/synonyms/english
[junit4] 2> 1922456 T10607 c:collection1 C1106 oasr.RestManager$Registry.registerManagedResource Added observer of type org.apache.solr.rest.schema.analysis.ManagedStopFilterFactory to existing ManagedResource /schema/analysis/stopwords/german
[junit4] 2> 1922456 T10607 c:collection1 C1106 oasr.RestManager$Registry.registerManagedResource Added observer of type org.apache.solr.rest.schema.analysis.ManagedSynonymFilterFactory to existing ManagedResource /schema/analysis/synonyms/german
[junit4] 2> 1922456 T10607 c:collection1 C1106 oasr.RestManager$Registry.registerManagedResource Added observer of type org.apache.solr.rest.schema.analysis.ManagedStopFilterFactory to existing ManagedResource /schema/analysis/stopwords/english
[junit4] 2> 1922456 T10607 c:collection1 C1106 oasr.RestManager$Registry.registerManagedResource Added observer of type org.apache.solr.rest.schema.analysis.ManagedSynonymFilterFactory to existing ManagedResource /schema/analysis/synonyms/english
[junit4] 2> 1922462 T10607 c:collection1 C1106 oasc.CoreContainer.reload Reloading SolrCore 'collection1' using configuration from configset C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1
[junit4] 2> 1922464 T10607 c:collection1 C1106 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-003\cores\core\data\
[junit4] 2> 1922464 T10607 c:collection1 C1106 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 1922464 T10607 c:collection1 C1106 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-003\cores\core\data\index/
[junit4] 2> 1922467 T10607 c:collection1 C1106 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1922467 T10607 c:collection1 C1106 oasc.RequestHandlers.applyInitParams WARN INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,args = {defaults={a=A,b=B}}}
[junit4] 2> 1922470 T10607 c:collection1 C1106 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1922471 T10607 c:collection1 C1106 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1922472 T10607 c:collection1 C1106 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1922473 T10607 c:collection1 C1106 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1922475 T10607 c:collection1 C1106 oasc.RequestHandlers.initHandlersFromConfig Registered paths: /admin/mbeans,standard,/dump,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
[junit4] 2> 1922476 T10607 c:collection1 C1106 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 1922476 T10607 c:collection1 C1106 oasu.CommitTracker.<init> Hard AutoCommit: if uncommited for 10ms; if 100 uncommited docs
[junit4] 2> 1922477 T10607 c:collection1 C1106 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 1922477 T10607 c:collection1 C1106 oass.SolrIndexSearcher.<init> Opening Searcher@1510d36[collection1] main
[junit4] 2> 1922478 T10607 c:collection1 C1106 oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage initialized to use dir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf
[junit4] 2> 1922478 T10607 c:collection1 C1106 oasr.RestManager.init Initializing RestManager with initArgs: {storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf}
[junit4] 2> 1922478 T10607 c:collection1 C1106 oasr.ManagedResourceStorage.load Reading _rest_managed.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf
[junit4] 2> 1922478 T10607 c:collection1 C1106 oasr.RestManager.init Initializing 4 registered ManagedResources
[junit4] 2> 1922478 T10607 c:collection1 C1106 oasr.ManagedResourceStorage.load Reading _schema_analysis_stopwords_english.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf
[junit4] 2> 1922478 T10607 c:collection1 C1106 oasr.ManagedResourceStorage.load Loaded LinkedHashMap at path _schema_analysis_stopwords_english.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf
[junit4] 2> 1922479 T10607 c:collection1 C1106 oasr.ManagedResource.processStoredData Loaded initArgs {ignoreCase=false} for /schema/analysis/stopwords/english
[junit4] 2> 1922479 T10607 c:collection1 C1106 oasrsa.ManagedWordSetResource.onManagedDataLoadedFromStorage Loaded 0 words for /schema/analysis/stopwords/english
[junit4] 2> 1922479 T10607 c:collection1 C1106 oasr.ManagedResource.notifyObserversDuringInit Notified 2 observers of /schema/analysis/stopwords/english
[junit4] 2> 1922479 T10607 c:collection1 C1106 oasr.ManagedResourceStorage.load Reading _schema_analysis_stopwords_german.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf
[junit4] 2> 1922480 T10607 c:collection1 C1106 oasr.ManagedResourceStorage.load Loaded LinkedHashMap at path _schema_analysis_stopwords_german.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf
[junit4] 2> 1922480 T10607 c:collection1 C1106 oasr.ManagedResource.processStoredData Loaded initArgs {ignoreCase=false} for /schema/analysis/stopwords/german
[junit4] 2> 1922480 T10607 c:collection1 C1106 oasrsa.ManagedWordSetResource.onManagedDataLoadedFromStorage Loaded 0 words for /schema/analysis/stopwords/german
[junit4] 2> 1922480 T10607 c:collection1 C1106 oasr.ManagedResource.notifyObserversDuringInit Notified 2 observers of /schema/analysis/stopwords/german
[junit4] 2> 1922480 T10607 c:collection1 C1106 oasr.ManagedResourceStorage.load Reading _schema_analysis_synonyms_english.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf
[junit4] 2> 1922481 T10607 c:collection1 C1106 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /schema/analysis/synonyms/english
[junit4] 2> 1922481 T10607 c:collection1 C1106 oasrsa.ManagedSynonymFilterFactory$SynonymManager.onManagedDataLoadedFromStorage Loaded 0 synonym mappings for /schema/analysis/synonyms/english
[junit4] 2> 1922481 T10607 c:collection1 C1106 oasr.ManagedResource.notifyObserversDuringInit Notified 2 observers of /schema/analysis/synonyms/english
[junit4] 2> 1922482 T10607 c:collection1 C1106 oasr.ManagedResourceStorage.load Reading _schema_analysis_synonyms_german.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf
[junit4] 2> 1922482 T10607 c:collection1 C1106 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /schema/analysis/synonyms/german
[junit4] 2> 1922482 T10607 c:collection1 C1106 oasrsa.ManagedSynonymFilterFactory$SynonymManager.onManagedDataLoadedFromStorage Loaded 0 synonym mappings for /schema/analysis/synonyms/german
[junit4] 2> 1922482 T10607 c:collection1 C1106 oasr.ManagedResource.notifyObserversDuringInit Notified 2 observers of /schema/analysis/synonyms/german
[junit4] 2> 1922483 T10607 c:collection1 C1106 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 1922483 T10607 c:collection1 C1106 oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter...
[junit4] 2> 1922483 T10607 c:collection1 C1106 oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused... core=collection1
[junit4] 2> 1922483 T10607 c:collection1 C1106 oasu.DefaultSolrCoreState.newIndexWriter Closing old IndexWriter... core=collection1
[junit4] 2> 1922483 T10616 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1510d36[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1922484 T10607 c:collection1 C1106 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=34, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=72.310546875, floorSegmentMB=0.8935546875, forceMergeDeletesPctAllowed=12.215781134846516, segmentsPerTier=27.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5718349491585829
[junit4] 2> 1922485 T10607 c:collection1 C1106 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=NRTCachingDirectory(SimpleFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-003\cores\core\data\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1e72146; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
[junit4] 2> 1922487 T10607 c:collection1 C1106 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1922487 T10607 c:collection1 C1106 oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used.
[junit4] 2> 1922487 T10607 c:collection1 C1106 oass.SolrIndexSearcher.<init> Opening Searcher@eb5a6[collection1] main
[junit4] 2> 1922487 T10607 c:collection1 C1106 oasc.CoreContainer.registerCore replacing core: collection1
[junit4] 2> 1922488 T10616 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@eb5a6[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1922488 T10607 c:collection1 C1106 oash.SolrConfigHandler$Command.handleCommands Executed config commands successfully and persited to File System [{"set-property":{
[junit4] 2> "updateHandler.autoCommit.maxDocs":100,
[junit4] 2> "updateHandler.autoCommit.maxTime":10,
[junit4] 2> "requestDispatcher.requestParsers.addHttpRequestToContext":true}}]
[junit4] 2> 1922488 T10607 c:collection1 C1106 oasc.SolrCore.execute [collection1] webapp=/solr path=/config params={wt=json} status=0 QTime=153
[junit4] 2> 1922489 T10607 c:collection1 C1106 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@12e01b2
[junit4] 2> 1922489 T10607 c:collection1 C1106 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 1922489 T10607 c:collection1 C1106 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> ASYNC NEW_CORE C1107 name=collection1 org.apache.solr.core.SolrCore@ebddbf
[junit4] 2> 1922492 T10608 c:collection1 C1107 oasc.SolrCore.execute [collection1] webapp=/solr path=/config/overlay params={wt=json} status=0 QTime=0
[junit4] 2> 1922495 T10609 c:collection1 C1107 oasc.SolrCore.execute [collection1] webapp=/solr path=/config params={wt=json} status=0 QTime=0
[junit4] 2> 1922498 T10604 c:collection1 C1107 oasc.SolrResourceLoader.persistConfLocally Written confile configoverlay.json
[junit4] 2> 1922500 T10604 c:collection1 C1107 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\'
[junit4] 2> 1922500 T10604 c:collection1 C1107 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.core.TestSolrConfigHandler%205E82983A0FE5F972-001/tempDir-001/collection1/lib/classes/' to classloader
[junit4] 2> 1922501 T10604 c:collection1 C1107 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.core.TestSolrConfigHandler%205E82983A0FE5F972-001/tempDir-001/collection1/lib/README' to classloader
[junit4] 2> 1922516 T10604 c:collection1 C1107 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
[junit4] 2> 1922518 T10604 c:collection1 C1107 oasc.SolrConfig.<init> Using Lucene MatchVersion: 6.0.0
[junit4] 2> 1922522 T10604 c:collection1 C1107 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-managed-schema.xml
[junit4] 2> 1922523 T10604 c:collection1 C1107 oass.IndexSchema.readSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf\managed-schema
[junit4] 2> 1922527 T10604 c:collection1 C1107 oass.IndexSchema.readSchema [collection1] Schema name=test-rest
[junit4] 2> 1922573 T10604 c:collection1 C1107 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 1922574 T10604 c:collection1 C1107 oass.IndexSchema.readSchema query parser default operator is OR
[junit4] 2> 1922574 T10604 c:collection1 C1107 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1922575 T10604 c:collection1 C1107 oass.IndexSchema.loadCopyFields WARN Field title is not multivalued and destination for multiple copyFields (3)
[junit4] 2> 1922577 T10604 c:collection1 C1107 oasr.RestManager$Registry.registerManagedResource Registered ManagedResource impl org.apache.solr.rest.schema.analysis.ManagedWordSetResource for path /schema/analysis/stopwords/german
[junit4] 2> 1922577 T10604 c:collection1 C1107 oasr.RestManager$Registry.registerManagedResource Registered ManagedResource impl org.apache.solr.rest.schema.analysis.ManagedSynonymFilterFactory$SynonymManager for path /schema/analysis/synonyms/german
[junit4] 2> 1922583 T10604 c:collection1 C1107 oasr.RestManager$Registry.registerManagedResource Registered ManagedResource impl org.apache.solr.rest.schema.analysis.ManagedWordSetResource for path /schema/analysis/stopwords/english
[junit4] 2> 1922584 T10604 c:collection1 C1107 oasr.RestManager$Registry.registerManagedResource Registered ManagedResource impl org.apache.solr.rest.schema.analysis.ManagedSynonymFilterFactory$SynonymManager for path /schema/analysis/synonyms/english
[junit4] 2> 1922585 T10604 c:collection1 C1107 oasr.RestManager$Registry.registerManagedResource Added observer of type org.apache.solr.rest.schema.analysis.ManagedStopFilterFactory to existing ManagedResource /schema/analysis/stopwords/german
[junit4] 2> 1922585 T10604 c:collection1 C1107 oasr.RestManager$Registry.registerManagedResource Added observer of type org.apache.solr.rest.schema.analysis.ManagedSynonymFilterFactory to existing ManagedResource /schema/analysis/synonyms/german
[junit4] 2> 1922585 T10604 c:collection1 C1107 oasr.RestManager$Registry.registerManagedResource Added observer of type org.apache.solr.rest.schema.analysis.ManagedStopFilterFactory to existing ManagedResource /schema/analysis/stopwords/english
[junit4] 2> 1922585 T10604 c:collection1 C1107 oasr.RestManager$Registry.registerManagedResource Added observer of type org.apache.solr.rest.schema.analysis.ManagedSynonymFilterFactory to existing ManagedResource /schema/analysis/synonyms/english
[junit4] 2> 1922591 T10604 c:collection1 C1107 oasc.CoreContainer.reload Reloading SolrCore 'collection1' using configuration from configset C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1
[junit4] 2> 1922592 T10604 c:collection1 C1107 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-003\cores\core\data\
[junit4] 2> 1922592 T10604 c:collection1 C1107 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 1922593 T10604 c:collection1 C1107 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-003\cores\core\data\index/
[junit4] 2> 1922595 T10604 c:collection1 C1107 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1922595 T10604 c:collection1 C1107 oasc.RequestHandlers.applyInitParams WARN INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,args = {defaults={a=A,b=B}}}
[junit4] 2> 1922596 T10604 c:collection1 C1107 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1922597 T10604 c:collection1 C1107 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1922598 T10604 c:collection1 C1107 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1922599 T10604 c:collection1 C1107 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1922601 T10604 c:collection1 C1107 oasc.RequestHandlers.initHandlersFromConfig Registered paths: /admin/mbeans,standard,/dump,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
[junit4] 2> 1922601 T10604 c:collection1 C1107 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 1922602 T10604 c:collection1 C1107 oasu.CommitTracker.<init> Hard AutoCommit: if uncommited for 10ms;
[junit4] 2> 1922602 T10604 c:collection1 C1107 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 1922603 T10604 c:collection1 C1107 oass.SolrIndexSearcher.<init> Opening Searcher@1df7111[collection1] main
[junit4] 2> 1922603 T10604 c:collection1 C1107 oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage initialized to use dir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf
[junit4] 2> 1922603 T10604 c:collection1 C1107 oasr.RestManager.init Initializing RestManager with initArgs: {storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf}
[junit4] 2> 1922604 T10604 c:collection1 C1107 oasr.ManagedResourceStorage.load Reading _rest_managed.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf
[junit4] 2> 1922604 T10604 c:collection1 C1107 oasr.RestManager.init Initializing 4 registered ManagedResources
[junit4] 2> 1922604 T10604 c:collection1 C1107 oasr.ManagedResourceStorage.load Reading _schema_analysis_stopwords_english.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf
[junit4] 2> 1922604 T10604 c:collection1 C1107 oasr.ManagedResourceStorage.load Loaded LinkedHashMap at path _schema_analysis_stopwords_english.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf
[junit4] 2> 1922605 T10604 c:collection1 C1107 oasr.ManagedResource.processStoredData Loaded initArgs {ignoreCase=false} for /schema/analysis/stopwords/english
[junit4] 2> 1922605 T10604 c:collection1 C1107 oasrsa.ManagedWordSetResource.onManagedDataLoadedFromStorage Loaded 0 words for /schema/analysis/stopwords/english
[junit4] 2> 1922605 T10604 c:collection1 C1107 oasr.ManagedResource.notifyObserversDuringInit Notified 2 observers of /schema/analysis/stopwords/english
[junit4] 2> 1922605 T10604 c:collection1 C1107 oasr.ManagedResourceStorage.load Reading _schema_analysis_stopwords_german.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf
[junit4] 2> 1922606 T10604 c:collection1 C1107 oasr.ManagedResourceStorage.load Loaded LinkedHashMap at path _schema_analysis_stopwords_german.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf
[junit4] 2> 1922606 T10604 c:collection1 C1107 oasr.ManagedResource.processStoredData Loaded initArgs {ignoreCase=false} for /schema/analysis/stopwords/german
[junit4] 2> 1922606 T10604 c:collection1 C1107 oasrsa.ManagedWordSetResource.onManagedDataLoadedFromStorage Loaded 0 words for /schema/analysis/stopwords/german
[junit4] 2> 1922606 T10604 c:collection1 C1107 oasr.ManagedResource.notifyObserversDuringInit Notified 2 observers of /schema/analysis/stopwords/german
[junit4] 2> 1922607 T10604 c:collection1 C1107 oasr.ManagedResourceStorage.load Reading _schema_analysis_synonyms_english.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf
[junit4] 2> 1922607 T10604 c:collection1 C1107 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /schema/analysis/synonyms/english
[junit4] 2> 1922607 T10604 c:collection1 C1107 oasrsa.ManagedSynonymFilterFactory$SynonymManager.onManagedDataLoadedFromStorage Loaded 0 synonym mappings for /schema/analysis/synonyms/english
[junit4] 2> 1922607 T10604 c:collection1 C1107 oasr.ManagedResource.notifyObserversDuringInit Notified 2 observers of /schema/analysis/synonyms/english
[junit4] 2> 1922608 T10604 c:collection1 C1107 oasr.ManagedResourceStorage.load Reading _schema_analysis_synonyms_german.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-001\collection1\conf
[junit4] 2> 1922608 T10604 c:collection1 C1107 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /schema/analysis/synonyms/german
[junit4] 2> 1922608 T10604 c:collection1 C1107 oasrsa.ManagedSynonymFilterFactory$SynonymManager.onManagedDataLoadedFromStorage Loaded 0 synonym mappings for /schema/analysis/synonyms/german
[junit4] 2> 1922608 T10604 c:collection1 C1107 oasr.ManagedResource.notifyObserversDuringInit Notified 2 observers of /schema/analysis/synonyms/german
[junit4] 2> 1922609 T10604 c:collection1 C1107 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 1922609 T10604 c:collection1 C1107 oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter...
[junit4] 2> 1922609 T10604 c:collection1 C1107 oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused... core=collection1
[junit4] 2> 1922609 T10604 c:collection1 C1107 oasu.DefaultSolrCoreState.newIndexWriter Closing old IndexWriter... core=collection1
[junit4] 2> 1922609 T10617 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1df7111[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1922610 T10604 c:collection1 C1107 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=34, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=72.310546875, floorSegmentMB=0.8935546875, forceMergeDeletesPctAllowed=12.215781134846516, segmentsPerTier=27.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5718349491585829
[junit4] 2> 1922610 T10604 c:collection1 C1107 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=NRTCachingDirectory(SimpleFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-003\cores\core\data\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1e72146; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
[junit4] 2> 1922611 T10604 c:collection1 C1107 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1922612 T10604 c:collection1 C1107 oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used.
[junit4] 2> 1922612 T10604 c:collection1 C1107 oass.SolrIndexSearcher.<init> Opening Searcher@620592[collection1] main
[junit4] 2> 1922612 T10604 c:collection1 C1107 oasc.CoreContainer.registerCore replacing core: collection1
[junit4] 2> 1922612 T10617 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@620592[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1922612 T10604 c:collection1 C1107 oash.SolrConfigHandler$Command.handleCommands Executed config commands successfully and persited to File System [{"unset-property":"updateHandler.autoCommit.maxDocs"}]
[junit4] 2> 1922614 T10604 c:collection1 C1107 oasc.SolrCore.execute [collection1] webapp=/solr path=/config params={wt=json} status=0 QTime=117
[junit4] 2> 1922615 T10604 c:collection1 C1107 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@ebddbf
[junit4] 2> 1922615 T10604 c:collection1 C1107 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,autocommit maxDocs=100,autocommit maxTime=10ms,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 1922615 T10604 c:collection1 C1107 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> ASYNC NEW_CORE C1108 name=collection1 org.apache.solr.core.SolrCore@1a75ab9
[junit4] 2> 1922618 T10605 c:collection1 C1108 oasc.SolrCore.execute [collection1] webapp=/solr path=/config/overlay params={wt=json} status=0 QTime=0
[junit4] 2> 1922624 T10600 oejs.AbstractConnector.doStop Stopped ServerConnector@1ff9efb{SSL-http/1.1}{127.0.0.1:0}
[junit4] 2> 1922625 T10600 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=19233401
[junit4] 2> 1922626 T10600 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1a75ab9
[junit4] 2> 1922626 T10600 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,autocommit maxTime=10ms,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 1922627 T10600 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 1922627 T10600 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 1922627 T10600 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 1922635 T10600 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 1922635 T10600 oasc.CachingDirectoryFactory.close Closing NRTCachingDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 1922635 T10600 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-003\cores\core\data [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-003\cores\core\data;done=false>>]
[junit4] 2> 1922635 T10600 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-003\cores\core\data
[junit4] 2> 1922635 T10600 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-003\cores\core\data\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-003\cores\core\data\index;done=false>>]
[junit4] 2> 1922636 T10600 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-003\cores\core\data\index
[junit4] 2> 1922637 T10600 oejsh.ContextHandler.doStop Stopped o.e.j.s.ServletContextHandler@a23f0b{/solr,null,UNAVAILABLE}
[junit4] 2> 1922644 T10600 oas.SolrTestCaseJ4.tearDown ###Ending testProperty
[junit4] 2> 1922649 T10600 oas.SolrTestCaseJ4.setUp ###Starting testUserProp
[junit4] 2> 1922919 T10600 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> 1922920 T10600 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 1922921 T10600 oas.SolrTestCaseJ4.writeCoreProperties Writing core.properties file to C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-006\cores\core
[junit4] 2> 1922923 T10600 oejs.Server.doStart jetty-9.2.9.v20150224
[junit4] 2> 1922929 T10600 oejsh.ContextHandler.doStart Started o.e.j.s.ServletContextHandler@61b1d0{/solr,null,AVAILABLE}
[junit4] 2> 1922935 T10600 oejs.AbstractConnector.doStart Started ServerConnector@723286{SSL-http/1.1}{127.0.0.1:56157}
[junit4] 2> 1922935 T10600 oejs.Server.doStart Started @1925842ms
[junit4] 2> 1922936 T10600 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {hostContext=/solr, hostPort=56157, configSetBaseDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-004, coreRootDirectory=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-006\cores}
[junit4] 2> 1922938 T10600 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@e2f2a
[junit4] 2> 1922938 T10600 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-004\'
[junit4] 2> 1922960 T10600 oasc.SolrXmlConfig.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-004\solr.xml
[junit4] 2> 1922966 T10600 oasc.CorePropertiesLocator.<init> Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-006\cores
[junit4] 2> 1922966 T10600 oasc.CoreContainer.<init> New CoreContainer 32957275
[junit4] 2> 1922966 T10600 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-004\]
[junit4] 2> 1922966 T10600 oasc.CoreContainer.load loading shared library: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-004\lib
[junit4] 2> 1922967 T10600 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: lib (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-004\lib).
[junit4] 2> 1922973 T10600 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 1922973 T10600 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: https
[junit4] 2> 1922974 T10600 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 1922974 T10600 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 1922974 T10600 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000
[junit4] 2> 1922974 T10600 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 1922975 T10600 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 1922975 T10600 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 1922975 T10600 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 1922975 T10600 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 1922976 T10600 oashc.HttpShardHandlerFactory.getParameter Setting useRetries to: false
[junit4] 2> 1922980 T10600 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1922984 T10600 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1922984 T10600 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1922984 T10600 oasc.CoreContainer.load Node Name: 127.0.0.1
[junit4] 2> 1922985 T10600 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-006\cores
[junit4] 2> 1922985 T10600 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {name=collection1, config=solrconfig-managed-schema.xml, transient=false, schema=schema-rest.xml, loadOnStartup=true, instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-006\cores\core, absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-006\cores\core\, configSet=collection1, dataDir=data\}
[junit4] 2> 1922985 T10600 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-006\cores\core\
[junit4] 2> 1922986 T10600 oasc.CorePropertiesLocator.discover Found 1 core definitions
[junit4] 2> 1922987 T10630 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-004\collection1\'
[junit4] 2> 1922988 T10630 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.core.TestSolrConfigHandler%205E82983A0FE5F972-001/tempDir-004/collection1/lib/classes/' to classloader
[junit4] 2> 1922989 T10630 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.core.TestSolrConfigHandler%205E82983A0FE5F972-001/tempDir-004/collection1/lib/README' to classloader
[junit4] 2> 1923009 T10630 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
[junit4] 2> 1923011 T10630 oasc.SolrConfig.<init> Using Lucene MatchVersion: 6.0.0
[junit4] 2> 1923014 T10630 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-managed-schema.xml
[junit4] 2> 1923018 T10630 oass.ManagedIndexSchemaFactory.readSchemaLocally The schema is configured as managed, but managed schema resource managed-schema not found - loading non-managed schema schema-rest.xml instead
[junit4] 2> 1923020 T10630 oass.IndexSchema.readSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-004\collection1\conf\schema-rest.xml
[junit4] 2> 1923022 T10630 oass.IndexSchema.readSchema [collection1] Schema name=test-rest
[junit4] 2> 1923073 T10630 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 1923073 T10630 oass.IndexSchema.readSchema query parser default operator is OR
[junit4] 2> 1923080 T10630 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1923081 T10630 oass.IndexSchema.loadCopyFields WARN Field title is not multivalued and destination for multiple copyFields (3)
[junit4] 2> 1923083 T10630 oasr.RestManager$Registry.registerManagedResource Registered ManagedResource impl org.apache.solr.rest.schema.analysis.ManagedWordSetResource for path /schema/analysis/stopwords/german
[junit4] 2> 1923083 T10630 oasr.RestManager$Registry.registerManagedResource Registered ManagedResource impl org.apache.solr.rest.schema.analysis.ManagedSynonymFilterFactory$SynonymManager for path /schema/analysis/synonyms/german
[junit4] 2> 1923088 T10630 oasr.RestManager$Registry.registerManagedResource Registered ManagedResource impl org.apache.solr.rest.schema.analysis.ManagedWordSetResource for path /schema/analysis/stopwords/english
[junit4] 2> 1923088 T10630 oasr.RestManager$Registry.registerManagedResource Registered ManagedResource impl org.apache.solr.rest.schema.analysis.ManagedSynonymFilterFactory$SynonymManager for path /schema/analysis/synonyms/english
[junit4] 2> 1923093 T10630 oasr.RestManager$Registry.registerManagedResource Added observer of type org.apache.solr.rest.schema.analysis.ManagedStopFilterFactory to existing ManagedResource /schema/analysis/stopwords/english
[junit4] 2> 1923093 T10630 oasr.RestManager$Registry.registerManagedResource Added observer of type org.apache.solr.rest.schema.analysis.ManagedSynonymFilterFactory to existing ManagedResource /schema/analysis/synonyms/english
[junit4] 2> 1923093 T10630 oasr.RestManager$Registry.registerManagedResource Added observer of type org.apache.solr.rest.schema.analysis.ManagedStopFilterFactory to existing ManagedResource /schema/analysis/stopwords/german
[junit4] 2> 1923093 T10630 oasr.RestManager$Registry.registerManagedResource Added observer of type org.apache.solr.rest.schema.analysis.ManagedSynonymFilterFactory to existing ManagedResource /schema/analysis/synonyms/german
[junit4] 2> 1923095 T10630 oass.ManagedIndexSchema.persistManagedSchema Upgraded to managed schema at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-004\collection1\conf\managed-schema
[junit4] 2> 1923130 T10630 oass.ManagedIndexSchemaFactory.upgradeToManagedSchema After upgrading to managed schema, renamed the non-managed schema C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-004\collection1\conf\schema-rest.xml to C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-004\collection1\conf\schema-rest.xml.bak
[junit4] 2> 1923131 T10630 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from configset C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-004\collection1
[junit4] 2> 1923131 T10630 c:collection1 oasc.SolrCore.initDirectoryFactory solr.NRTCachingDirectoryFactory
[junit4] 2> 1923132 T10630 c:collection1 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-004\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-006\cores\core\data\
[junit4] 2> 1923132 T10630 c:collection1 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 1923133 T10630 c:collection1 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-006\cores\core\data
[junit4] 2> 1923133 T10630 c:collection1 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-006\cores\core\data\index/
[junit4] 2> 1923133 T10630 c:collection1 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-006\cores\core\data\index' doesn't exist. Creating new index...
[junit4] 2> 1923134 T10630 c:collection1 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-006\cores\core\data\index
[junit4] 2> 1923134 T10630 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=34, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=72.310546875, floorSegmentMB=0.8935546875, forceMergeDeletesPctAllowed=12.215781134846516, segmentsPerTier=27.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5718349491585829
[junit4] 2> 1923139 T10630 c:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=NRTCachingDirectory(SimpleFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-006\cores\core\data\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@17a163c; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
[junit4] 2> 1923139 T10630 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1923141 T10630 c:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1923141 T10630 c:collection1 oasc.RequestHandlers.applyInitParams WARN INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,args = {defaults={a=A,b=B}}}
[junit4] 2> 1923146 T10630 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1923147 T10630 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1923148 T10630 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1923149 T10630 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1923151 T10630 c:collection1 oasc.RequestHandlers.initHandlersFromConfig Registered paths: /admin/mbeans,standard,/dump,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
[junit4] 2> 1923151 T10630 c:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 1923152 T10630 c:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 1923152 T10630 c:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 1923152 T10630 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=16, maxMergeAtOnceExplicit=17, maxMergedSegmentMB=51.3076171875, floorSegmentMB=0.34765625, forceMergeDeletesPctAllowed=9.41018951041065, segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 1923153 T10630 c:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=NRTCachingDirectory(SimpleFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-006\cores\core\data\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@17a163c; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
[junit4] 2> 1923153 T10630 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1923153 T10630 c:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@f14d0c[collection1] main
[junit4] 2> 1923154 T10630 c:collection1 oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage initialized to use dir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-004\collection1\conf
[junit4] 2> 1923154 T10630 c:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-004\collection1\conf}
[junit4] 2> 1923154 T10630 c:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-004\collection1\conf
[junit4] 2> 1923154 T10630 c:collection1 oasr.RestManager.init Initializing 4 registered ManagedResources
[junit4] 2> 1923154 T10630 c:collection1 oasr.ManagedResourceStorage.load Reading _schema_analysis_stopwords_english.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-004\collection1\conf
[junit4] 2> 1923155 T10630 c:collection1 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /schema/analysis/stopwords/english
[junit4] 2> 1923156 T10630 c:collection1 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _schema_analysis_stopwords_english.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-004\collection1\conf
[junit4] 2> 1923156 T10630 c:collection1 oasrsa.ManagedWordSetResource.onManagedDataLoadedFromStorage Loaded 0 words for /schema/analysis/stopwords/english
[junit4] 2> 1923156 T10630 c:collection1 oasr.ManagedResource.notifyObserversDuringInit Notified 2 observers of /schema/analysis/stopwords/english
[junit4] 2> 1923157 T10630 c:collection1 oasr.ManagedResourceStorage.load Reading _schema_analysis_stopwords_german.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-004\collection1\conf
[junit4] 2> 1923157 T10630 c:collection1 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /schema/analysis/stopwords/german
[junit4] 2> 1923157 T10630 c:collection1 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _schema_analysis_stopwords_german.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-004\collection1\conf
[junit4] 2> 1923158 T10630 c:collection1 oasrsa.ManagedWordSetResource.onManagedDataLoadedFromStorage Loaded 0 words for /schema/analysis/stopwords/german
[junit4] 2> 1923158 T10630 c:collection1 oasr.ManagedResource.notifyObserversDuringInit Notified 2 observers of /schema/analysis/stopwords/german
[junit4] 2> 1923158 T10630 c:collection1 oasr.ManagedResourceStorage.load Reading _schema_analysis_synonyms_english.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-004\collection1\conf
[junit4] 2> 1923159 T10630 c:collection1 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /schema/analysis/synonyms/english
[junit4] 2> 1923159 T10630 c:collection1 oasrsa.ManagedSynonymFilterFactory$SynonymManager.onManagedDataLoadedFromStorage Loaded 0 synonym mappings for /schema/analysis/synonyms/english
[junit4] 2> 1923159 T10630 c:collection1 oasr.ManagedResource.notifyObserversDuringInit Notified 2 observers of /schema/analysis/synonyms/english
[junit4] 2> 1923159 T10630 c:collection1 oasr.ManagedResourceStorage.load Reading _schema_analysis_synonyms_german.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-004\collection1\conf
[junit4] 2> 1923160 T10630 c:collection1 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /schema/analysis/synonyms/german
[junit4] 2> 1923160 T10630 c:collection1 oasrsa.ManagedSynonymFilterFactory$SynonymManager.onManagedDataLoadedFromStorage Loaded 0 synonym mappings for /schema/analysis/synonyms/german
[junit4] 2> 1923160 T10630 c:collection1 oasr.ManagedResource.notifyObserversDuringInit Notified 2 observers of /schema/analysis/synonyms/german
[junit4] 2> 1923160 T10630 c:collection1 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 1923160 T10630 c:collection1 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 1923160 T10631 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@f14d0c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1923161 T10600 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4] 2> 1923161 T10600 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 1923161 T10600 oas.SolrJettyTestBase.createJetty Jetty Assigned Port#56157
[junit4] 2> ASYNC NEW_CORE C1109 name=collection1 org.apache.solr.core.SolrCore@1e649dd
[junit4] 2> 1923212 T10625 c:collection1 C1109 oasc.SolrResourceLoader.persistConfLocally Written confile configoverlay.json
[junit4] 2> 1923213 T10625 c:collection1 C1109 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-004\collection1\'
[junit4] 2> 1923215 T10625 c:collection1 C1109 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.core.TestSolrConfigHandler%205E82983A0FE5F972-001/tempDir-004/collection1/lib/classes/' to classloader
[junit4] 2> 1923216 T10625 c:collection1 C1109 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.core.TestSolrConfigHandler%205E82983A0FE5F972-001/tempDir-004/collection1/lib/README' to classloader
[junit4] 2> 1923250 T10625 c:collection1 C1109 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
[junit4] 2> 1923252 T10625 c:collection1 C1109 oasc.SolrConfig.<init> Using Lucene MatchVersion: 6.0.0
[junit4] 2> 1923255 T10625 c:collection1 C1109 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-managed-schema.xml
[junit4] 2> 1923257 T10625 c:collection1 C1109 oass.IndexSchema.readSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-004\collection1\conf\managed-schema
[junit4] 2> 1923261 T10625 c:collection1 C1109 oass.IndexSchema.readSchema [collection1] Schema name=test-rest
[junit4] 2> 1923309 T10625 c:collection1 C1109 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 1923310 T10625 c:collection1 C1109 oass.IndexSchema.readSchema query parser default operator is OR
[junit4] 2> 1923310 T10625 c:collection1 C1109 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1923310 T10625 c:collection1 C1109 oass.IndexSchema.loadCopyFields WARN Field title is not multivalued and destination for multiple copyFields (3)
[junit4] 2> 1923312 T10625 c:collection1 C1109 oasr.RestManager$Registry.registerManagedResource Registered ManagedResource impl org.apache.solr.rest.schema.analysis.ManagedWordSetResource for path /schema/analysis/stopwords/german
[junit4] 2> 1923312 T10625 c:collection1 C1109 oasr.RestManager$Registry.registerManagedResource Registered ManagedResource impl org.apache.solr.rest.schema.analysis.ManagedSynonymFilterFactory$SynonymManager for path /schema/analysis/synonyms/german
[juni
[...truncated too long message...]
edDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-012\cores\core\data;done=false>>]
[junit4] 2> 1927021 T10600 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-012\cores\core\data
[junit4] 2> 1927021 T10600 oejsh.ContextHandler.doStop Stopped o.e.j.s.ServletContextHandler@84fe0f{/solr,null,UNAVAILABLE}
[junit4] 2> 1927023 T10600 oas.SolrTestCaseJ4.tearDown ###Ending testReqHandlerAPIs
[junit4] 2> 1927024 T10600 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: test params are: codec=SimpleText, sim=RandomSimilarityProvider(queryNorm=false,coord=no): {}, locale=fr_FR, timezone=America/Sao_Paulo
[junit4] 2> NOTE: Windows 7 6.1 x86/Oracle Corporation 1.8.0_40 (32-bit)/cpus=3,threads=1,free=8268152,total=341835776
[junit4] 2> NOTE: All tests run in this JVM: [DocumentAnalysisRequestHandlerTest, TestXIncludeConfig, TestSimpleQParserPlugin, TestJmxIntegration, TestHighFrequencyDictionaryFactory, TestManagedSchema, DistributedSuggestComponentTest, TestHashPartitioner, DistributedDebugComponentTest, MigrateRouteKeyTest, AddSchemaFieldsUpdateProcessorFactoryTest, DocValuesTest, TestFileDictionaryLookup, SampleTest, SolrInfoMBeanTest, TestUniqueKeyFieldResource, CursorMarkTest, OverseerTest, LeaderFailoverAfterPartitionTest, UUIDUpdateProcessorFallbackTest, CacheHeaderTest, DeleteShardTest, CloudExitableDirectoryReaderTest, TestDynamicFieldCollectionResource, HdfsDirectoryTest, TestConfigSets, TestQueryTypes, SuggesterTest, DirectSolrConnectionTest, MultiTermTest, FacetPivotSmallTest, TestCoreContainer, TestCharFilters, TestInitQParser, SortByFunctionTest, ClusterStateTest, ClusterStateUpdateTest, SharedFSAutoReplicaFailoverUtilsTest, DefaultValueUpdateProcessorTest, TestDocumentBuilder, NoCacheHeaderTest, TestMacros, TestIndexSearcher, SimpleMLTQParserTest, TestDistribDocBasedVersion, AnalysisAfterCoreReloadTest, PathHierarchyTokenizerFactoryTest, TestFunctionQuery, TestQueryUtils, TestUpdate, HdfsRecoveryZkTest, TestCustomSort, TestFieldSortValues, DistanceFunctionTest, SolrCloudExampleTest, AssignTest, TestCSVResponseWriter, ShardRoutingTest, SolrCoreTest, DistributedIntervalFacetingTest, ParsingFieldUpdateProcessorsTest, TestFastLRUCache, ZkControllerTest, TestFaceting, URLClassifyProcessorTest, TestImplicitCoreProperties, ChaosMonkeyNothingIsSafeTest, TestOmitPositions, DocValuesMultiTest, LukeRequestHandlerTest, TestGroupingSearch, IndexSchemaRuntimeFieldTest, AddBlockUpdateTest, SuggesterWFSTTest, PingRequestHandlerTest, SimpleFacetsTest, UUIDFieldTest, AtomicUpdatesTest, DistributedQueueTest, SolrCoreCheckLockOnStartupTest, TestRestoreCore, TestStressLucene, TestLFUCache, CoreAdminHandlerTest, UniqFieldsUpdateProcessorFactoryTest, DistributedQueryElevationComponentTest, TestFieldResource, SystemInfoHandlerTest, TestJmxMonitoredMap, TestComplexPhraseQParserPlugin, DistribDocExpirationUpdateProcessorTest, SynonymTokenizerTest, TestReplicaProperties, TestManagedResourceStorage, TestPostingsSolrHighlighter, TimeZoneUtilsTest, SliceStateTest, TestSchemaManager, TestReplicationHandler, TestArbitraryIndexDir, TestComponentsName, ChangedSchemaMergeTest, TestSweetSpotSimilarityFactory, DeleteReplicaTest, OverriddenZkACLAndCredentialsProvidersTest, TestShardHandlerFactory, SolrPluginUtilsTest, DistribJoinFromCollectionTest, RankQueryTest, SOLR749Test, SolrIndexSplitterTest, TestStressReorder, MergeStrategyTest, HdfsUnloadDistributedZkTest, TestSchemaNameResource, TestPerFieldSimilarity, BadComponentTest, TestChildDocTransformer, BasicDistributedZkTest, BasicDistributedZk2Test, UnloadDistributedZkTest, SyncSliceTest, LeaderElectionIntegrationTest, LeaderElectionTest, TestZkChroot, TestRandomDVFaceting, ShardRoutingCustomTest, TestDistributedSearch, LoggingHandlerTest, TestCollationField, ReturnFieldsTest, TestAnalyzedSuggestions, BinaryUpdateRequestHandlerTest, CSVRequestHandlerTest, AlternateDirectoryTest, TestQuerySenderNoQuery, ResponseLogComponentTest, TestStressRecovery, TestBinaryField, MinimalSchemaTest, OutputWriterTest, ExternalFileFieldSortTest, TestSolrCoreProperties, NotRequiredUniqueKeyTest, TestPhraseSuggestions, TestLMDirichletSimilarityFactory, TestIBSimilarityFactory, TestFastWriter, ScriptEngineTest, DOMUtilTest, ZkNodePropsTest, CircularListTest, DistributedMLTComponentTest, SolrTestCaseJ4Test, TestDistributedMissingSort, TestSimpleTrackingShardHandler, CollectionsAPIAsyncDistributedZkTest, DistribCursorPagingTest, ExternalCollectionsTest, MultiThreadedOCPTest, RemoteQueryErrorTest, SSLMigrationTest, SaslZkACLProviderTest, SimpleCollectionCreateDeleteTest, TestCloudInspectUtil, TestCloudPivotFacet, TestCollectionAPI, TestLeaderElectionZkExpiry, TestMiniSolrCloudCluster, TestRequestStatusCollectionAPI, TestShortCircuitedRequests, HdfsChaosMonkeySafeLeaderTest, HdfsCollectionsAPIDistributedZkTest, HdfsSyncSliceTest, HdfsThreadLeakTest, HdfsWriteToMultipleCollectionsTest, StressHdfsTest, TestClusterStateMutator, ZkStateWriterTest, TestConfigOverlay, TestInfoStreamLogging, TestInitParams, TestNRTOpen, TestSolrConfigHandler]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestSolrConfigHandler -Dtests.seed=5E82983A0FE5F972 -Dtests.slow=true -Dtests.locale=fr_FR -Dtests.timezone=America/Sao_Paulo -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 0.00s J0 | TestSolrConfigHandler (suite) <<<
[junit4] > Throwable #1: java.io.IOException: Could not remove the following files (in the order of attempts):
[junit4] > C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-010\collection1\conf\configoverlay.json: java.nio.file.FileSystemException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-010\collection1\conf\configoverlay.json: The process cannot access the file because it is being used by another process.
[junit4] > C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-010\collection1\conf: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-010\collection1\conf
[junit4] > C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-010\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-010\collection1
[junit4] > C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-010: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-010
[junit4] > C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-010: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001\tempDir-010
[junit4] > C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001: java.nio.file.DirectoryNotEmptyException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler 5E82983A0FE5F972-001
[junit4] > at __randomizedtesting.SeedInfo.seed([5E82983A0FE5F972]:0)
[junit4] > at org.apache.lucene.util.IOUtils.rm(IOUtils.java:286)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] Completed [406/482] on J0 in 5.64s, 4 tests, 1 error <<< FAILURES!
[...truncated 230 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:526: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:474: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:61: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\extra-targets.xml:39: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:229: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:511: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1415: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:973: There were test failures: 482 suites, 1910 tests, 1 suite-level error, 58 ignored (30 assumptions)
Total time: 54 minutes 14 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 32bit/jdk1.8.0_40 -server -XX:+UseParallelGC
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
[JENKINS] Lucene-Solr-trunk-Windows (64bit/jdk1.8.0_40) - Build #
4654 - Still Failing!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/4654/
Java: 64bit/jdk1.8.0_40 -XX:-UseCompressedOops -XX:+UseSerialGC
2 tests failed.
FAILED: org.apache.lucene.index.TestDocumentsWriterStallControl.testSimpleStall
Error Message:
Test abandoned because suite timeout was reached.
Stack Trace:
java.lang.Exception: Test abandoned because suite timeout was reached.
at __randomizedtesting.SeedInfo.seed([161254B3A4E45966]:0)
FAILED: junit.framework.TestSuite.org.apache.lucene.index.TestDocumentsWriterStallControl
Error Message:
Suite timeout exceeded (>= 7200000 msec).
Stack Trace:
java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
at __randomizedtesting.SeedInfo.seed([161254B3A4E45966]:0)
Build Log:
[...truncated 1588 lines...]
[junit4] Suite: org.apache.lucene.index.TestDocumentsWriterStallControl
[junit4] 2> ??? 09, 2015 3:03:11 ? com.carrotsearch.randomizedtesting.ThreadLeakControl$2 evaluate
[junit4] 2> WARNING: Suite execution timed out: org.apache.lucene.index.TestDocumentsWriterStallControl
[junit4] 2> 1) Thread[id=1, name=main, state=WAITING, group=main]
[junit4] 2> at java.lang.Object.wait(Native Method)
[junit4] 2> at java.lang.Thread.join(Thread.java:1245)
[junit4] 2> at java.lang.Thread.join(Thread.java:1319)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSuite(RandomizedRunner.java:578)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.run(RandomizedRunner.java:444)
[junit4] 2> at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:199)
[junit4] 2> at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:310)
[junit4] 2> at com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:12)
[junit4] 2> 2) Thread[id=193, name=SUITE-TestDocumentsWriterStallControl-seed#[161254B3A4E45966], state=RUNNABLE, group=TGRP-TestDocumentsWriterStallControl]
[junit4] 2> at java.lang.Thread.getStackTrace(Thread.java:1552)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.getThreadsWithTraces(ThreadLeakControl.java:690)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.formatThreadStacksFull(ThreadLeakControl.java:679)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.access$900(ThreadLeakControl.java:62)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$2.evaluate(ThreadLeakControl.java:412)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSuite(RandomizedRunner.java:651)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.access$200(RandomizedRunner.java:138)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$1.run(RandomizedRunner.java:568)
[junit4] 2> 3) Thread[id=194, name=TEST-TestDocumentsWriterStallControl.testSimpleStall-seed#[161254B3A4E45966], state=TIMED_WAITING, group=TGRP-TestDocumentsWriterStallControl]
[junit4] 2> at java.lang.Thread.sleep(Native Method)
[junit4] 2> at org.apache.lucene.index.TestDocumentsWriterStallControl.awaitState(TestDocumentsWriterStallControl.java:351)
[junit4] 2> at org.apache.lucene.index.TestDocumentsWriterStallControl.testSimpleStall(TestDocumentsWriterStallControl.java:49)
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:497)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886)
[junit4] 2> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
[junit4] 2> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792)
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 4) Thread[id=10, name=JUnit4-serializer-daemon, state=TIMED_WAITING, group=main]
[junit4] 2> at java.lang.Thread.sleep(Native Method)
[junit4] 2> at com.carrotsearch.ant.tasks.junit4.events.Serializer$1.run(Serializer.java:47)
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestDocumentsWriterStallControl -Dtests.method=testSimpleStall -Dtests.seed=161254B3A4E45966 -Dtests.slow=true -Dtests.locale=ar -Dtests.timezone=IET -Dtests.asserts=true -Dtests.file.encoding=Cp1252
[junit4] ERROR 7219s J0 | TestDocumentsWriterStallControl.testSimpleStall <<<
[junit4] > Throwable #1: java.lang.Exception: Test abandoned because suite timeout was reached.
[junit4] > at __randomizedtesting.SeedInfo.seed([161254B3A4E45966]:0)
[junit4] 2> ??? 09, 2015 3:03:11 ? com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> ??? 09, 2015 3:03:31 ? com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> SEVERE: 1 thread leaked from SUITE scope at org.apache.lucene.index.TestDocumentsWriterStallControl:
[junit4] 2> 1) Thread[id=194, name=TEST-TestDocumentsWriterStallControl.testSimpleStall-seed#[161254B3A4E45966], state=TIMED_WAITING, group=TGRP-TestDocumentsWriterStallControl]
[junit4] 2> at java.lang.Thread.sleep(Native Method)
[junit4] 2> at org.apache.lucene.index.TestDocumentsWriterStallControl.awaitState(TestDocumentsWriterStallControl.java:351)
[junit4] 2> at org.apache.lucene.index.TestDocumentsWriterStallControl.testSimpleStall(TestDocumentsWriterStallControl.java:49)
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:497)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886)
[junit4] 2> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
[junit4] 2> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792)
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> ??? 09, 2015 3:03:31 ? com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: Starting to interrupt leaked threads:
[junit4] 2> 1) Thread[id=194, name=TEST-TestDocumentsWriterStallControl.testSimpleStall-seed#[161254B3A4E45966], state=TIMED_WAITING, group=TGRP-TestDocumentsWriterStallControl]
[junit4] 2> Apr 09, 2015 7:03:32 PM com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: All leaked threads terminated.
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene50): {}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=false,coord=no): {}, locale=ar, timezone=IET
[junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.8.0_40 (64-bit)/cpus=3,threads=1,free=20511336,total=82989056
[junit4] 2> NOTE: All tests run in this JVM: [TestPayloadExplanations, TestForceMergeForever, TestInPlaceMergeSorter, TestDeterminism, Test2BPostings, TestNumericUtils, TestIndexWriterOutOfFileDescriptors, Nested1, TestForUtil, TestWorstCaseTestBehavior, TestAssertions, TestIndexWriterExceptions, TestIndexInput, TestDocValuesScoring, TestCompressingTermVectorsFormat, Test4GBStoredFields, TestStressIndexing, TestSearcherManager, TestCharsRef, TestTopFieldCollector, TestManyFields, TestStressAdvance, TestFSTs, TestIntroSorter, TestPositionIncrement, TestLucene50NormsFormat, TestQueryWrapperFilter, TestTermdocPerf, TestLucene50FieldInfoFormat, TestRegexpQuery, TestFilteredSearch, TestDisjunctionMaxQuery, TestRateLimiter, TestArrayUtil, TestDirectory, TestCodecs, TestDocumentsWriterStallControl]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestDocumentsWriterStallControl -Dtests.seed=161254B3A4E45966 -Dtests.slow=true -Dtests.locale=ar -Dtests.timezone=IET -Dtests.asserts=true -Dtests.file.encoding=Cp1252
[junit4] ERROR 0.00s J0 | TestDocumentsWriterStallControl (suite) <<<
[junit4] > Throwable #1: java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
[junit4] > at __randomizedtesting.SeedInfo.seed([161254B3A4E45966]:0)
[junit4] Completed [347/414] on J0 in 7261.53s, 2 tests, 2 errors <<< FAILURES!
[...truncated 216 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:526: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:474: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:61: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\extra-targets.xml:39: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\build.xml:50: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1415: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:973: There were test failures: 414 suites, 3435 tests, 1 suite-level error, 1 error, 74 ignored (64 assumptions)
Total time: 124 minutes 9 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 64bit/jdk1.8.0_40 -XX:-UseCompressedOops -XX:+UseSerialGC
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any