Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/4846/ Java: 32bit/jdk1.8.0_45 -server -XX:+UseSerialGC
2 tests failed. FAILED: junit.framework.TestSuite.org.apache.solr.highlight.HighlighterTest Error Message: Suite timeout exceeded (>= 7200000 msec). Stack Trace: java.lang.Exception: Suite timeout exceeded (>= 7200000 msec). at __randomizedtesting.SeedInfo.seed([7CC600A9A408E871]:0) FAILED: org.apache.solr.highlight.HighlighterTest.payloadFilteringSpanQuery 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([7CC600A9A408E871]:0) Build Log: [...truncated 10931 lines...] [junit4] Suite: org.apache.solr.highlight.HighlighterTest [junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.highlight.HighlighterTest 7CC600A9A408E871-001\init-core-data-001 [junit4] 2> 1650126 T8069 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (false) and clientAuth (false) [junit4] 2> 1650128 T8069 oas.SolrTestCaseJ4.initCore ####initCore [junit4] 2> 1650128 T8069 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\' [junit4] 2> 1650129 T8069 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> 1650130 T8069 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> 1650173 T8069 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1 [junit4] 2> 1650194 T8069 oasc.SolrConfig.<init> Using Lucene MatchVersion: 6.0.0 [junit4] 2> 1650209 T8069 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 1650209 T8069 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> 1650214 T8069 oass.IndexSchema.readSchema [null] Schema name=test [junit4] 2> 1650289 T8069 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 1650297 T8069 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 1650298 T8069 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 1650302 T8069 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 1650304 T8069 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 1650306 T8069 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1650307 T8069 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 1650307 T8069 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 1650307 T8069 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1650308 T8069 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 1650308 T8069 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 1650308 T8069 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 1650308 T8069 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> 1650309 T8069 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\' [junit4] 2> 1650322 T8069 oasc.CoreContainer.<init> New CoreContainer 17714728 [junit4] 2> 1650323 T8069 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\] [junit4] 2> 1650323 T8069 oasc.CoreContainer.load loading shared library: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\lib [junit4] 2> 1650323 T8069 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> 1650330 T8069 oashc.HttpShardHandlerFactory.init created with socketTimeout : 600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 1650333 T8069 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true [junit4] 2> 1650334 T8069 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 1650334 T8069 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 1650335 T8069 oasc.CoreContainer.load Node Name: testNode [junit4] 2> 1650335 T8069 oasc.CoreContainer.initializeAuthenticationPlugin No authentication plugin used. [junit4] 2> 1650344 T8069 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\J0\temp\solr.highlight.HighlighterTest 7CC600A9A408E871-001\init-core-data-001, shard=shard1} [junit4] 2> 1650345 T8070 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\' [junit4] 2> 1650346 T8070 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> 1650346 T8070 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> 1650364 T8070 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1 [junit4] 2> 1650370 T8070 oasc.SolrConfig.<init> Using Lucene MatchVersion: 6.0.0 [junit4] 2> 1650399 T8070 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 1650399 T8070 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> 1650404 T8070 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 1650474 T8070 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 1650479 T8070 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 1650481 T8070 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 1650485 T8070 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 1650487 T8070 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 1650489 T8070 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1650489 T8070 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 1650489 T8070 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 1650489 T8070 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1650490 T8070 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 1650490 T8070 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 1650490 T8070 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> 1650490 T8070 x:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 1650491 T8070 x: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=[null] [junit4] 2> 1650491 T8070 x:collection1 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d86cd9 [junit4] 2> 1650491 T8070 x:collection1 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.highlight.HighlighterTest 7CC600A9A408E871-001\init-core-data-001\ [junit4] 2> 1650492 T8070 x: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.highlight.HighlighterTest 7CC600A9A408E871-001\init-core-data-001\index/ [junit4] 2> 1650492 T8070 x: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.highlight.HighlighterTest 7CC600A9A408E871-001\init-core-data-001\index' doesn't exist. Creating new index... [junit4] 2> 1650492 T8070 x:collection1 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.highlight.HighlighterTest 7CC600A9A408E871-001\init-core-data-001\index [junit4] 2> 1650492 T8070 x:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=31, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.15520104308546642] [junit4] 2> 1650493 T8070 x:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@364638 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1b65bf9),segFN=segments_1,generation=1} [junit4] 2> 1650493 T8070 x:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 1650496 T8070 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 1650496 T8070 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 1650497 T8070 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 1650497 T8070 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 1650497 T8070 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 1650497 T8070 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 1650497 T8070 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields" [junit4] 2> 1650497 T8070 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields" [junit4] 2> 1650498 T8070 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 1650498 T8070 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 1650498 T8070 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 1650498 T8070 x:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 1650502 T8070 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1650503 T8070 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1650505 T8070 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1650505 T8070 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1650509 T8070 x:collection1 oasc.PluginBag.createPlugin requestHandler : 'lazy' created with startup=lazy [junit4] 2> 1650510 T8070 x: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> 1650511 T8070 x:collection1 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler. [junit4] 2> 1650511 T8070 x:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 1650513 T8070 x:collection1 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 1650514 T8070 x:collection1 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 1650514 T8070 x:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 1650515 T8070 x:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 1650516 T8070 x:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=25, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 1650516 T8070 x:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@364638 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1b65bf9),segFN=segments_1,generation=1} [junit4] 2> 1650516 T8070 x:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 1650517 T8070 x:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@fa69e7[collection1] main [junit4] 2> 1650517 T8070 x:collection1 oasu.UpdateLog.onFirstSearcher On first searcher opened, looking up max value of version field [junit4] 2> 1650517 T8070 x:collection1 oasu.VersionInfo.getMaxVersionFromIndex Refreshing highest value of _version_ for 65536 version buckets from index [junit4] 2> 1650517 T8070 x:collection1 oasu.VersionInfo.getMaxVersionFromIndex WARN No terms found for _version_, cannot seed version bucket highest value from index [junit4] 2> 1650517 T8070 x:collection1 oasu.UpdateLog.seedBucketsWithHighestVersion WARN Could not find max version in index or recent updates, using new clock 1502022332634365952 [junit4] 2> 1650519 T8070 x:collection1 oasu.UpdateLog.seedBucketsWithHighestVersion Took 2 ms to seed version buckets with highest version 1502022332634365952 [junit4] 2> 1650520 T8070 x:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO} [junit4] 2> 1650520 T8070 x:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage [junit4] 2> 1650520 T8070 x:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 1650520 T8070 x:collection1 oashc.SpellCheckComponent.inform Initializing spell checkers [junit4] 2> 1650529 T8070 x:collection1 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1650570 T8070 x:collection1 oash.ReplicationHandler.inform Commits will be reserved for 10000 [junit4] 2> 1650571 T8070 x:collection1 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 1650573 T8069 oas.SolrTestCaseJ4.initCore ####initCore end [junit4] 2> 1650575 T8069 oas.SolrTestCaseJ4.setUp ###Starting payloadFilteringSpanQuery [junit4] 2> ASYNC NEW_CORE C3017 name=collection1 org.apache.solr.core.SolrCore@2e282f [junit4] 2> 1650577 T8069 C3017 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:* (-1502022332695183360)} 0 2 [junit4] 2> 1650583 T8069 C3017 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[0 (1502022332699377664)]} 0 4 [junit4] 2> 1650584 T8069 C3017 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1650593 T8069 C3017 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@364638 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1b65bf9),segFN=segments_1,generation=1} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@364638 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1b65bf9),segFN=segments_2,generation=2} [junit4] 2> 1650594 T8069 C3017 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2 [junit4] 2> 1650595 T8069 C3017 oasc.SolrCore.getSearcher WARN [collection1] PERFORMANCE WARNING: Overlapping onDeckSearchers=2 [junit4] 2> 1650596 T8069 C3017 oass.SolrIndexSearcher.<init> Opening Searcher@1329281[collection1] main [junit4] 2> 1650596 T8069 C3017 oasu.UpdateLog.onFirstSearcher On first searcher opened, looking up max value of version field [junit4] 2> 1650597 T8071 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default [junit4] 2> 1650597 T8071 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: direct [junit4] 2> 1650597 T8071 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak [junit4] 2> 1650597 T8071 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: multipleFields [junit4] 2> 1650598 T8071 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: jarowinkler [junit4] 2> 1650598 T8071 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: external [junit4] 2> 1650599 T8071 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: freq [junit4] 2> 1650599 T8071 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: fqcn [junit4] 2> 1650599 T8071 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: perDict [junit4] 2> 1650599 T8071 x:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@fa69e7[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 7257252 T8068 ccr.ThreadLeakControl$2.evaluate WARNING Suite execution timed out: org.apache.solr.highlight.HighlighterTest [junit4] 2> ==== jstack at approximately timeout time ==== [junit4] 2> "Thread-2968" ID=8072 WAITING on java.lang.Object@341078 [junit4] 2> at java.lang.Object.wait(Native Method) [junit4] 2> - waiting on java.lang.Object@341078 [junit4] 2> at java.lang.Object.wait(Object.java:502) [junit4] 2> at org.apache.solr.core.CloserThread.run(CoreContainer.java:1035) [junit4] 2> [junit4] 2> "searcherExecutor-4057-thread-1" ID=8071 WAITING on java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@aa4378 [junit4] 2> at sun.misc.Unsafe.park(Native Method) [junit4] 2> - waiting on java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@aa4378 [junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) [junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) [junit4] 2> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> [junit4] 2> "TEST-HighlighterTest.payloadFilteringSpanQuery-seed#[7CC600A9A408E871]" ID=8069 WAITING on java.util.concurrent.locks.ReentrantReadWriteLock$FairSync@85bc37 [junit4] 2> at sun.misc.Unsafe.park(Native Method) [junit4] 2> - waiting on java.util.concurrent.locks.ReentrantReadWriteLock$FairSync@85bc37 [junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) [junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:836) [junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireQueued(AbstractQueuedSynchronizer.java:870) [junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquire(AbstractQueuedSynchronizer.java:1199) [junit4] 2> at java.util.concurrent.locks.ReentrantReadWriteLock$WriteLock.lock(ReentrantReadWriteLock.java:943) [junit4] 2> at org.apache.solr.update.VersionInfo.blockUpdates(VersionInfo.java:119) [junit4] 2> at org.apache.solr.update.UpdateLog.onFirstSearcher(UpdateLog.java:1604) [junit4] 2> at org.apache.solr.core.SolrCore.getSearcher(SolrCore.java:1810) [junit4] 2> at org.apache.solr.core.SolrCore.getSearcher(SolrCore.java:1505) [junit4] 2> at org.apache.solr.update.DirectUpdateHandler2.commit(DirectUpdateHandler2.java:617) [junit4] 2> - locked java.lang.Object@c683c2 [junit4] 2> at org.apache.solr.update.processor.RunUpdateProcessor.processCommit(RunUpdateProcessorFactory.java:95) [junit4] 2> at org.apache.solr.update.processor.UpdateRequestProcessor.processCommit(UpdateRequestProcessor.java:64) [junit4] 2> at org.apache.solr.update.processor.DistributedUpdateProcessor.doLocalCommit(DistributedUpdateProcessor.java:1642) [junit4] 2> at org.apache.solr.update.processor.DistributedUpdateProcessor.processCommit(DistributedUpdateProcessor.java:1619) [junit4] 2> at org.apache.solr.update.processor.LogUpdateProcessor.processCommit(LogUpdateProcessorFactory.java:161) [junit4] 2> at org.apache.solr.handler.loader.XMLLoader.processUpdate(XMLLoader.java:270) [junit4] 2> at org.apache.solr.handler.loader.XMLLoader.load(XMLLoader.java:177) [junit4] 2> at org.apache.solr.handler.UpdateRequestHandler$1.load(UpdateRequestHandler.java:98) [junit4] 2> at org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:74) [junit4] 2> at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:143) [junit4] 2> at org.apache.solr.core.SolrCore.execute(SolrCore.java:2051) [junit4] 2> at org.apache.solr.servlet.DirectSolrConnection.request(DirectSolrConnection.java:131) [junit4] 2> at org.apache.solr.util.TestHarness.update(TestHarness.java:267) [junit4] 2> at org.apache.solr.util.BaseTestHarness.checkUpdateStatus(BaseTestHarness.java:282) [junit4] 2> at org.apache.solr.util.BaseTestHarness.validateUpdate(BaseTestHarness.java:252) [junit4] 2> at org.apache.solr.SolrTestCaseJ4.checkUpdateU(SolrTestCaseJ4.java:748) [junit4] 2> at org.apache.solr.SolrTestCaseJ4.assertU(SolrTestCaseJ4.java:727) [junit4] 2> at org.apache.solr.SolrTestCaseJ4.assertU(SolrTestCaseJ4.java:721) [junit4] 2> at org.apache.solr.highlight.HighlighterTest.payloadFilteringSpanQuery(HighlighterTest.java:1105) [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> Locked synchronizers: [junit4] 2> - java.util.concurrent.locks.ReentrantLock$FairSync@1600688 [junit4] 2> - java.util.concurrent.locks.ReentrantLock$NonfairSync@e69890 [junit4] 2> [junit4] 2> "SUITE-HighlighterTest-seed#[7CC600A9A408E871]" ID=8068 RUNNABLE [junit4] 2> at sun.management.ThreadImpl.dumpThreads0(Native Method) [junit4] 2> at sun.management.ThreadImpl.dumpAllThreads(ThreadImpl.java:446) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.formatThreadStacksFull(ThreadLeakControl.java:671) [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> - locked java.lang.Object@23fb76 [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> [junit4] 2> "TimeLimitedCollector timer thread" ID=5325 TIMED_WAITING [junit4] 2> at java.lang.Thread.sleep(Native Method) [junit4] 2> at org.apache.lucene.search.TimeLimitingCollector$TimerThread.run(TimeLimitingCollector.java:256) [junit4] 2> [junit4] 2> "JUnit4-serializer-daemon" ID=10 TIMED_WAITING [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> [junit4] 2> "Attach Listener" ID=5 RUNNABLE [junit4] 2> [junit4] 2> "Signal Dispatcher" ID=4 RUNNABLE [junit4] 2> [junit4] 2> "Finalizer" ID=3 WAITING on java.lang.ref.ReferenceQueue$Lock@3a7078 [junit4] 2> at java.lang.Object.wait(Native Method) [junit4] 2> - waiting on java.lang.ref.ReferenceQueue$Lock@3a7078 [junit4] 2> at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:143) [junit4] 2> at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:164) [junit4] 2> at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:209) [junit4] 2> [junit4] 2> "Reference Handler" ID=2 WAITING on java.lang.ref.Reference$Lock@60a32b [junit4] 2> at java.lang.Object.wait(Native Method) [junit4] 2> - waiting on java.lang.ref.Reference$Lock@60a32b [junit4] 2> at java.lang.Object.wait(Object.java:502) [junit4] 2> at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:157) [junit4] 2> [junit4] 2> "main" ID=1 WAITING on com.carrotsearch.randomizedtesting.RandomizedRunner$1@1974943 [junit4] 2> at java.lang.Object.wait(Native Method) [junit4] 2> - waiting on com.carrotsearch.randomizedtesting.RandomizedRunner$1@1974943 [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> [junit4] 2> ^^============================================== [junit4] 2> [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=HighlighterTest -Dtests.method=payloadFilteringSpanQuery -Dtests.seed=7CC600A9A408E871 -Dtests.slow=true -Dtests.locale=es_NI -Dtests.timezone=America/Moncton -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] ERROR 7257s J0 | HighlighterTest.payloadFilteringSpanQuery <<< [junit4] > Throwable #1: java.lang.Exception: Test abandoned because suite timeout was reached. [junit4] > at __randomizedtesting.SeedInfo.seed([7CC600A9A408E871]:0) [junit4] 2> 7257277 T8068 ccr.ThreadLeakControl.checkThreadLeaks WARNING Will linger awaiting termination of 3 leaked thread(s). [junit4] 2> 7277320 T8068 ccr.ThreadLeakControl.checkThreadLeaks SEVERE 3 threads leaked from SUITE scope at org.apache.solr.highlight.HighlighterTest: [junit4] 2> 1) Thread[id=8069, name=TEST-HighlighterTest.payloadFilteringSpanQuery-seed#[7CC600A9A408E871], state=WAITING, group=TGRP-HighlighterTest] [junit4] 2> at sun.misc.Unsafe.park(Native Method) [junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) [junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:836) [junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireQueued(AbstractQueuedSynchronizer.java:870) [junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquire(AbstractQueuedSynchronizer.java:1199) [junit4] 2> at java.util.concurrent.locks.ReentrantReadWriteLock$WriteLock.lock(ReentrantReadWriteLock.java:943) [junit4] 2> at org.apache.solr.update.VersionInfo.blockUpdates(VersionInfo.java:119) [junit4] 2> at org.apache.solr.update.UpdateLog.onFirstSearcher(UpdateLog.java:1604) [junit4] 2> at org.apache.solr.core.SolrCore.getSearcher(SolrCore.java:1810) [junit4] 2> at org.apache.solr.core.SolrCore.getSearcher(SolrCore.java:1505) [junit4] 2> at org.apache.solr.update.DirectUpdateHandler2.commit(DirectUpdateHandler2.java:617) [junit4] 2> at org.apache.solr.update.processor.RunUpdateProcessor.processCommit(RunUpdateProcessorFactory.java:95) [junit4] 2> at org.apache.solr.update.processor.UpdateRequestProcessor.processCommit(UpdateRequestProcessor.java:64) [junit4] 2> at org.apache.solr.update.processor.DistributedUpdateProcessor.doLocalCommit(DistributedUpdateProcessor.java:1642) [junit4] 2> at org.apache.solr.update.processor.DistributedUpdateProcessor.processCommit(DistributedUpdateProcessor.java:1619) [junit4] 2> at org.apache.solr.update.processor.LogUpdateProcessor.processCommit(LogUpdateProcessorFactory.java:161) [junit4] 2> at org.apache.solr.handler.loader.XMLLoader.processUpdate(XMLLoader.java:270) [junit4] 2> at org.apache.solr.handler.loader.XMLLoader.load(XMLLoader.java:177) [junit4] 2> at org.apache.solr.handler.UpdateRequestHandler$1.load(UpdateRequestHandler.java:98) [junit4] 2> at org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:74) [junit4] 2> at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:143) [junit4] 2> at org.apache.solr.core.SolrCore.execute(SolrCore.java:2051) [junit4] 2> at org.apache.solr.servlet.DirectSolrConnection.request(DirectSolrConnection.java:131) [junit4] 2> at org.apache.solr.util.TestHarness.update(TestHarness.java:267) [junit4] 2> at org.apache.solr.util.BaseTestHarness.checkUpdateStatus(BaseTestHarness.java:282) [junit4] 2> at org.apache.solr.util.BaseTestHarness.validateUpdate(BaseTestHarness.java:252) [junit4] 2> at org.apache.solr.SolrTestCaseJ4.checkUpdateU(SolrTestCaseJ4.java:748) [junit4] 2> at org.apache.solr.SolrTestCaseJ4.assertU(SolrTestCaseJ4.java:727) [junit4] 2> at org.apache.solr.SolrTestCaseJ4.assertU(SolrTestCaseJ4.java:721) [junit4] 2> at org.apache.solr.highlight.HighlighterTest.payloadFilteringSpanQuery(HighlighterTest.java:1105) [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> 2) Thread[id=8071, name=searcherExecutor-4057-thread-1, state=WAITING, group=TGRP-HighlighterTest] [junit4] 2> at sun.misc.Unsafe.park(Native Method) [junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) [junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) [junit4] 2> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> 3) Thread[id=8072, name=Thread-2968, state=WAITING, group=TGRP-HighlighterTest] [junit4] 2> at java.lang.Object.wait(Native Method) [junit4] 2> at java.lang.Object.wait(Object.java:502) [junit4] 2> at org.apache.solr.core.CloserThread.run(CoreContainer.java:1035) [junit4] 2> 7277322 T8068 ccr.ThreadLeakControl.tryToInterruptAll Starting to interrupt leaked threads: [junit4] 2> 1) Thread[id=8069, name=TEST-HighlighterTest.payloadFilteringSpanQuery-seed#[7CC600A9A408E871], state=WAITING, group=TGRP-HighlighterTest] [junit4] 2> 2) Thread[id=8071, name=searcherExecutor-4057-thread-1, state=WAITING, group=TGRP-HighlighterTest] [junit4] 2> 3) Thread[id=8072, name=Thread-2968, state=WAITING, group=TGRP-HighlighterTest] [junit4] 2> 7280855 T8068 ccr.ThreadLeakControl.tryToInterruptAll SEVERE There are still zombie threads that couldn't be terminated: [junit4] 2> 1) Thread[id=8069, name=TEST-HighlighterTest.payloadFilteringSpanQuery-seed#[7CC600A9A408E871], state=WAITING, group=TGRP-HighlighterTest] [junit4] 2> at sun.misc.Unsafe.park(Native Method) [junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) [junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:836) [junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireQueued(AbstractQueuedSynchronizer.java:870) [junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquire(AbstractQueuedSynchronizer.java:1199) [junit4] 2> at java.util.concurrent.locks.ReentrantReadWriteLock$WriteLock.lock(ReentrantReadWriteLock.java:943) [junit4] 2> at org.apache.solr.update.VersionInfo.blockUpdates(VersionInfo.java:119) [junit4] 2> at org.apache.solr.update.UpdateLog.onFirstSearcher(UpdateLog.java:1604) [junit4] 2> at org.apache.solr.core.SolrCore.getSearcher(SolrCore.java:1810) [junit4] 2> at org.apache.solr.core.SolrCore.getSearcher(SolrCore.java:1505) [junit4] 2> at org.apache.solr.update.DirectUpdateHandler2.commit(DirectUpdateHandler2.java:617) [junit4] 2> at org.apache.solr.update.processor.RunUpdateProcessor.processCommit(RunUpdateProcessorFactory.java:95) [junit4] 2> at org.apache.solr.update.processor.UpdateRequestProcessor.processCommit(UpdateRequestProcessor.java:64) [junit4] 2> at org.apache.solr.update.processor.DistributedUpdateProcessor.doLocalCommit(DistributedUpdateProcessor.java:1642) [junit4] 2> at org.apache.solr.update.processor.DistributedUpdateProcessor.processCommit(DistributedUpdateProcessor.java:1619) [junit4] 2> at org.apache.solr.update.processor.LogUpdateProcessor.processCommit(LogUpdateProcessorFactory.java:161) [junit4] 2> at org.apache.solr.handler.loader.XMLLoader.processUpdate(XMLLoader.java:270) [junit4] 2> at org.apache.solr.handler.loader.XMLLoader.load(XMLLoader.java:177) [junit4] 2> at org.apache.solr.handler.UpdateRequestHandler$1.load(UpdateRequestHandler.java:98) [junit4] 2> at org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:74) [junit4] 2> at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:143) [junit4] 2> at org.apache.solr.core.SolrCore.execute(SolrCore.java:2051) [junit4] 2> at org.apache.solr.servlet.DirectSolrConnection.request(DirectSolrConnection.java:131) [junit4] 2> at org.apache.solr.util.TestHarness.update(TestHarness.java:267) [junit4] 2> at org.apache.solr.util.BaseTestHarness.checkUpdateStatus(BaseTestHarness.java:282) [junit4] 2> at org.apache.solr.util.BaseTestHarness.validateUpdate(BaseTestHarness.java:252) [junit4] 2> at org.apache.solr.SolrTestCaseJ4.checkUpdateU(SolrTestCaseJ4.java:748) [junit4] 2> at org.apache.solr.SolrTestCaseJ4.assertU(SolrTestCaseJ4.java:727) [junit4] 2> at org.apache.solr.SolrTestCaseJ4.assertU(SolrTestCaseJ4.java:721) [junit4] 2> at org.apache.solr.highlight.HighlighterTest.payloadFilteringSpanQuery(HighlighterTest.java:1105) [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> 2) Thread[id=8071, name=searcherExecutor-4057-thread-1, state=WAITING, group=TGRP-HighlighterTest] [junit4] 2> at sun.misc.Unsafe.park(Native Method) [junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) [junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) [junit4] 2> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> 3) Thread[id=8072, name=Thread-2968, state=WAITING, group=TGRP-HighlighterTest] [junit4] 2> at java.lang.Object.wait(Native Method) [junit4] 2> at java.lang.Object.wait(Object.java:502) [junit4] 2> at org.apache.solr.core.CloserThread.run(CoreContainer.java:1035) [junit4] 2> NOTE: test params are: codec=Asserting(Lucene50): {range_facet_l_dv=PostingsFormat(name=Memory doPackFST= true), _version_=FSTOrd50, multiDefault=PostingsFormat(name=LuceneVarGapFixedInterval), intDefault=FSTOrd50, payloadDelimited=BlockTreeOrds(blocksize=128), id=PostingsFormat(name=Memory doPackFST= true), range_facet_i_dv=FSTOrd50, range_facet_l=FSTOrd50, timestamp=FSTOrd50}, docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene50), range_facet_i_dv=DocValuesFormat(name=Direct), timestamp=DocValuesFormat(name=Direct)}, sim=RandomSimilarityProvider(queryNorm=true,coord=crazy): {}, locale=es_NI, timezone=America/Moncton [junit4] 2> NOTE: Windows 7 6.1 x86/Oracle Corporation 1.8.0_45 (32-bit)/cpus=3,threads=4,free=166405240,total=377364480 [junit4] 2> NOTE: All tests run in this JVM: [CoreMergeIndexesAdminHandlerTest, DistanceFunctionTest, NoCacheHeaderTest, TestConfigOverlay, TestCloudManagedSchema, TestSchemaManager, SimpleMLTQParserTest, TestFieldResource, TestTrackingShardHandlerFactory, TestDefaultStatsCache, TestCSVLoader, PathHierarchyTokenizerFactoryTest, ConnectionManagerTest, TestUpdate, TestComplexPhraseQParserPlugin, DefaultValueUpdateProcessorTest, ClusterStateTest, TestAnalyzedSuggestions, UUIDFieldTest, MultiThreadedOCPTest, TestSchemaNameResource, ShowFileRequestHandlerTest, TestComponentsName, ResponseLogComponentTest, TestFreeTextSuggestions, FacetPivotSmallTest, TestLRUCache, TestSort, InfoHandlerTest, DirectUpdateHandlerTest, TestPartialUpdateDeduplication, TestIndexingPerformance, BaseCdcrDistributedZkTest, OverriddenZkACLAndCredentialsProvidersTest, TestFaceting, CacheHeaderTest, BadComponentTest, TestOverriddenPrefixQueryForCustomFieldType, DistributedSpellCheckComponentTest, TestAuthenticationFramework, DeleteReplicaTest, SolrInfoMBeanTest, TestFastLRUCache, TestRawResponseWriter, TestBM25SimilarityFactory, ClusterStateUpdateTest, ChangedSchemaMergeTest, TestDistributedMissingSort, MergeStrategyTest, DistanceUnitsTest, StressHdfsTest, BasicDistributedZkTest, DocumentAnalysisRequestHandlerTest, TestHighFrequencyDictionaryFactory, ZkStateWriterTest, TestDocBasedVersionConstraints, TestCloudSchemaless, SampleTest, TestStressVersions, TestStressLucene, TestCSVResponseWriter, TestRemoveLastDynamicCopyField, HdfsSyncSliceTest, CollectionReloadTest, TestReRankQParserPlugin, TestFileDictionaryLookup, NumericFieldsTest, JSONWriterTest, DOMUtilTest, TestCharFilters, TestSolrConfigHandlerConcurrent, TestDynamicFieldResource, TestSurroundQueryParser, CoreAdminHandlerTest, PingRequestHandlerTest, TestInitQParser, OverseerTest, RulesTest, UniqFieldsUpdateProcessorFactoryTest, TestArbitraryIndexDir, TestPhraseSuggestions, RequestHandlersTest, DistributedFacetPivotWhiteBoxTest, ReplicationFactorTest, TestQueryTypes, TestJsonFacets, DistribCursorPagingTest, AlternateDirectoryTest, TestReloadAndDeleteDocs, LeaderFailoverAfterPartitionTest, TestElisionMultitermQuery, TestGroupingSearch, TestRandomDVFaceting, TestChildDocTransformer, SimpleCollectionCreateDeleteTest, TestExactSharedStatsCache, AnalysisAfterCoreReloadTest, SoftAutoCommitTest, PrimUtilsTest, TestFieldSortValues, DocValuesTest, IndexSchemaRuntimeFieldTest, QueryResultKeyTest, TestLeaderElectionZkExpiry, TestStressRecovery, TestOrdValues, TestSchemaVersionResource, TestConfigSets, TestManagedSchema, RuleEngineTest, DistributedQueryElevationComponentTest, TestCustomSort, DocExpirationUpdateProcessorFactoryTest, DirectSolrConnectionTest, DistributedQueryComponentCustomSortTest, ZkControllerTest, TestHashQParserPlugin, TestFieldTypeCollectionResource, TestQueryUtils, ConcurrentDeleteAndCreateCollectionTest, SuggesterWFSTTest, TestExtendedDismaxParser, UnloadDistributedZkTest, SyncSliceTest, LeaderElectionIntegrationTest, RecoveryZkTest, TestReplicationHandler, ZkSolrClientTest, ShardRoutingCustomTest, TestDistributedSearch, HighlighterTest] [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=HighlighterTest -Dtests.seed=7CC600A9A408E871 -Dtests.slow=true -Dtests.locale=es_NI -Dtests.timezone=America/Moncton -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] ERROR 0.00s J0 | HighlighterTest (suite) <<< [junit4] > Throwable #1: java.lang.Exception: Suite timeout exceeded (>= 7200000 msec). [junit4] > at __randomizedtesting.SeedInfo.seed([7CC600A9A408E871]:0) [junit4] Completed [502/502] on J0 in 7280.90s, 1 test, 2 errors <<< FAILURES! [...truncated 11 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:512: 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: 502 suites, 1951 tests, 1 suite-level error, 1 error, 66 ignored (34 assumptions) Total time: 166 minutes 43 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts Recording test results Email was triggered for: Failure - Any Sending email for trigger: Failure - Any
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org