Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Windows/4713/ Java: 64bit/jdk1.8.0_45 -XX:-UseCompressedOops -XX:+UseG1GC
2 tests failed. FAILED: org.apache.solr.update.AddBlockUpdateTest.testBasics 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([B97DDB37E5236F52]:0) FAILED: junit.framework.TestSuite.org.apache.solr.update.AddBlockUpdateTest Error Message: Suite timeout exceeded (>= 7200000 msec). Stack Trace: java.lang.Exception: Suite timeout exceeded (>= 7200000 msec). at __randomizedtesting.SeedInfo.seed([B97DDB37E5236F52]:0) Build Log: [...truncated 10741 lines...] [junit4] Suite: org.apache.solr.update.AddBlockUpdateTest [junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.AddBlockUpdateTest B97DDB37E5236F52-001\init-core-data-001 [junit4] 2> 65460 T270 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (false) and clientAuth (false) [junit4] 2> 65462 T270 oas.SolrTestCaseJ4.initCore ####initCore [junit4] 2> 65463 T270 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\' [junit4] 2> 65464 T270 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-5.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 65464 T270 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-5.x-Windows/solr/core/src/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 65550 T270 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1 [junit4] 2> 65587 T270 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0 [junit4] 2> 65637 T270 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 65638 T270 oass.IndexSchema.readSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\schema15.xml [junit4] 2> 65647 T270 oass.IndexSchema.readSchema [null] Schema name=test [junit4] 2> 65844 T270 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 65846 T270 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 65848 T270 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 65851 T270 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 65871 T270 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 65871 T270 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr [junit4] 2> 65872 T270 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\' [junit4] 2> 65895 T270 oasc.CoreContainer.<init> New CoreContainer 1444983516 [junit4] 2> 65896 T270 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\] [junit4] 2> 65896 T270 oasc.CoreContainer.load loading shared library: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\lib [junit4] 2> 65896 T270 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: lib (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\lib). [junit4] 2> 65911 T270 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> 65917 T270 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true [junit4] 2> 65919 T270 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 65920 T270 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 65920 T270 oasc.CoreContainer.load Node Name: testNode [junit4] 2> 65920 T270 oasc.CoreContainer.initializeAuthenticationPlugin No authentication plugin used. [junit4] 2> 65921 T270 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {name=collection1, config=solrconfig.xml, transient=false, schema=schema15.xml, loadOnStartup=true, instanceDir=collection1, collection=collection1, absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.AddBlockUpdateTest B97DDB37E5236F52-001\init-core-data-001, shard=shard1} [junit4] 2> 65924 T271 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\' [junit4] 2> 65926 T271 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-5.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 65926 T271 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-5.x-Windows/solr/core/src/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 65956 T271 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1 [junit4] 2> 65967 T271 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0 [junit4] 2> 66016 T271 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 66017 T271 oass.IndexSchema.readSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\schema15.xml [junit4] 2> 66032 T271 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 66184 T271 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 66186 T271 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 66188 T271 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 66192 T271 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 66211 T271 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\ [junit4] 2> 66212 T271 x:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 66212 T271 x:collection1 oasc.SolrCore.<init> [[collection1] ] Opening new SolrCore at [C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\], dataDir=[null] [junit4] 2> 66212 T271 x:collection1 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@6b5f637b [junit4] 2> 66212 T271 x:collection1 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.AddBlockUpdateTest B97DDB37E5236F52-001\init-core-data-001\ [junit4] 2> 66212 T271 x:collection1 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.AddBlockUpdateTest B97DDB37E5236F52-001\init-core-data-001\index/ [junit4] 2> 66213 T271 x:collection1 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.AddBlockUpdateTest B97DDB37E5236F52-001\init-core-data-001\index' doesn't exist. Creating new index... [junit4] 2> 66213 T271 x:collection1 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.AddBlockUpdateTest B97DDB37E5236F52-001\init-core-data-001\index [junit4] 2> 66213 T271 x:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=45, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 66214 T271 x:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@3218c699 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1fbab035),segFN=segments_1,generation=1} [junit4] 2> 66214 T271 x:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 66344 T271 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 66350 T271 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 66350 T271 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 66350 T271 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 66350 T271 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 66350 T271 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 66350 T271 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields" [junit4] 2> 66361 T271 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields" [junit4] 2> 66362 T271 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 66403 T271 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 66404 T271 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 66404 T271 x:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 66409 T271 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 66411 T271 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 66414 T271 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 66416 T271 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 66442 T271 x:collection1 oasc.PluginBag.createPlugin requestHandler : 'lazy' created with startup=lazy [junit4] 2> 66475 T271 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> 66477 T271 x:collection1 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler. [junit4] 2> 66477 T271 x:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 66478 T271 x:collection1 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 66479 T271 x:collection1 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=256 [junit4] 2> 66480 T271 x:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 66480 T271 x:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 66481 T271 x:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=41, maxMergeAtOnceExplicit=24, maxMergedSegmentMB=50.806640625, floorSegmentMB=1.3046875, forceMergeDeletesPctAllowed=2.900471970471259, segmentsPerTier=13.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.24668523085852662 [junit4] 2> 66481 T271 x:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@3218c699 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1fbab035),segFN=segments_1,generation=1} [junit4] 2> 66482 T271 x:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 66482 T271 x:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@4a4e6dc2[collection1] main [junit4] 2> 66485 T271 x:collection1 oasu.UpdateLog.onFirstSearcher On first searcher opened, looking up max value of version field [junit4] 2> 66486 T271 x:collection1 oasu.VersionInfo.getMaxVersionFromIndex Refreshing highest value of _version_ for 256 version buckets from index [junit4] 2> 66486 T271 x:collection1 oasu.VersionInfo.getMaxVersionFromIndex WARN No terms found for _version_, cannot seed version bucket highest value from index [junit4] 2> 66486 T271 x:collection1 oasu.UpdateLog.seedBucketsWithHighestVersion WARN Could not find max version in index or recent updates, using new clock 1501730989020282880 [junit4] 2> 66486 T271 x:collection1 oasu.UpdateLog.seedBucketsWithHighestVersion Took 0 ms to seed version buckets with highest version 1501730989020282880 [junit4] 2> 66487 T271 x:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO} [junit4] 2> 66487 T271 x:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage [junit4] 2> 66487 T271 x:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 66487 T271 x:collection1 oashc.SpellCheckComponent.inform Initializing spell checkers [junit4] 2> 66592 T271 x:collection1 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 66814 T271 x:collection1 oash.ReplicationHandler.inform Commits will be reserved for 10000 [junit4] 2> 66816 T271 x:collection1 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 66828 T270 oas.SolrTestCaseJ4.initCore ####initCore end [junit4] 2> 66836 T270 oas.SolrTestCaseJ4.setUp ###Starting testBasics [junit4] 2> ASYNC NEW_CORE C32 name=collection1 org.apache.solr.core.SolrCore@7706ca2a [junit4] 2> 66845 T270 C32 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:* (-1501730989388333056)} 0 5 [junit4] 2> 66856 T270 C32 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=true,softCommit=false,prepareCommit=false} [junit4] 2> 66856 T270 C32 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit. [junit4] 2> 66857 T270 C32 oasc.SolrCore.getSearcher WARN [collection1] PERFORMANCE WARNING: Overlapping onDeckSearchers=2 [junit4] 2> 66860 T272 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default [junit4] 2> 66863 T270 C32 oasc.SolrCore.openNewSearcher SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher [junit4] 2> 66864 T270 C32 oasu.UpdateLog.onFirstSearcher On first searcher opened, looking up max value of version field [junit4] 2> 66869 T272 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: direct [junit4] 2> 66869 T272 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak [junit4] 2> 66869 T272 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: multipleFields [junit4] 2> 66872 T272 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: jarowinkler [junit4] 2> 66874 T272 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: external [junit4] 2> 66875 T272 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: freq [junit4] 2> 66876 T272 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: fqcn [junit4] 2> 66876 T272 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: perDict [junit4] 2> 66878 T272 x:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4a4e6dc2[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 7298398 T269 ccr.ThreadLeakControl$2.evaluate WARNING Suite execution timed out: org.apache.solr.update.AddBlockUpdateTest [junit4] 2> ==== jstack at approximately timeout time ==== [junit4] 2> "RMI TCP Connection(idle)" ID=297 TIMED_WAITING on java.util.concurrent.SynchronousQueue$TransferStack@9972d2f [junit4] 2> at sun.misc.Unsafe.park(Native Method) [junit4] 2> - timed waiting on java.util.concurrent.SynchronousQueue$TransferStack@9972d2f [junit4] 2> at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) [junit4] 2> at java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460) [junit4] 2> at java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:362) [junit4] 2> at java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:941) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1066) [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> "Thread-92" ID=273 WAITING on java.lang.Object@215f452d [junit4] 2> at java.lang.Object.wait(Native Method) [junit4] 2> - waiting on java.lang.Object@215f452d [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-116-thread-1" ID=272 WAITING on java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@38544495 [junit4] 2> at sun.misc.Unsafe.park(Native Method) [junit4] 2> - waiting on java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@38544495 [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-AddBlockUpdateTest.testBasics-seed#[B97DDB37E5236F52]" ID=270 WAITING on java.util.concurrent.locks.ReentrantReadWriteLock$FairSync@287f1e7c [junit4] 2> at sun.misc.Unsafe.park(Native Method) [junit4] 2> - waiting on java.util.concurrent.locks.ReentrantReadWriteLock$FairSync@287f1e7c [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:118) [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@59767234 [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:1635) [junit4] 2> at org.apache.solr.update.processor.DistributedUpdateProcessor.processCommit(DistributedUpdateProcessor.java:1612) [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.update.AddBlockUpdateTest.prepare(AddBlockUpdateTest.java:107) [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$7.evaluate(RandomizedRunner.java:870) [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@69b8d260 [junit4] 2> - java.util.concurrent.locks.ReentrantLock$NonfairSync@32958457 [junit4] 2> [junit4] 2> "SUITE-AddBlockUpdateTest-seed#[B97DDB37E5236F52]" ID=269 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@42723e95 [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> "RMI TCP Accept-0" ID=24 RUNNABLE (in native code) [junit4] 2> at java.net.DualStackPlainSocketImpl.accept0(Native Method) [junit4] 2> at java.net.DualStackPlainSocketImpl.socketAccept(DualStackPlainSocketImpl.java:131) [junit4] 2> at java.net.AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:404) [junit4] 2> at java.net.PlainSocketImpl.accept(PlainSocketImpl.java:199) [junit4] 2> - locked java.net.SocksSocketImpl@6df6cf69 [junit4] 2> at java.net.ServerSocket.implAccept(ServerSocket.java:545) [junit4] 2> at java.net.ServerSocket.accept(ServerSocket.java:513) [junit4] 2> at sun.rmi.transport.tcp.TCPTransport$AcceptLoop.executeAcceptLoop(TCPTransport.java:400) [junit4] 2> at sun.rmi.transport.tcp.TCPTransport$AcceptLoop.run(TCPTransport.java:372) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> [junit4] 2> "RMI RenewClean-[127.0.0.1:49220]" ID=20 TIMED_WAITING on java.lang.ref.ReferenceQueue$Lock@73df59bc [junit4] 2> at java.lang.Object.wait(Native Method) [junit4] 2> - timed waiting on java.lang.ref.ReferenceQueue$Lock@73df59bc [junit4] 2> at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:143) [junit4] 2> at sun.rmi.transport.DGCClient$EndpointEntry$RenewCleanThread.run(DGCClient.java:536) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> [junit4] 2> "RMI Scheduler(0)" ID=19 TIMED_WAITING on java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@23032545 [junit4] 2> at sun.misc.Unsafe.park(Native Method) [junit4] 2> - timed waiting on java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@23032545 [junit4] 2> at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) [junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078) [junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093) [junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809) [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> "GC Daemon" ID=17 TIMED_WAITING on sun.misc.GC$LatencyLock@70563126 [junit4] 2> at java.lang.Object.wait(Native Method) [junit4] 2> - timed waiting on sun.misc.GC$LatencyLock@70563126 [junit4] 2> at sun.misc.GC$Daemon.run(GC.java:117) [junit4] 2> [junit4] 2> "RMI Reaper" ID=16 WAITING on java.lang.ref.ReferenceQueue$Lock@2b8025c2 [junit4] 2> at java.lang.Object.wait(Native Method) [junit4] 2> - waiting on java.lang.ref.ReferenceQueue$Lock@2b8025c2 [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 sun.rmi.transport.ObjectTable$Reaper.run(ObjectTable.java:351) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> [junit4] 2> "RMI TCP Accept-0" ID=15 RUNNABLE (in native code) [junit4] 2> at java.net.DualStackPlainSocketImpl.accept0(Native Method) [junit4] 2> at java.net.DualStackPlainSocketImpl.socketAccept(DualStackPlainSocketImpl.java:131) [junit4] 2> at java.net.AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:404) [junit4] 2> at java.net.PlainSocketImpl.accept(PlainSocketImpl.java:199) [junit4] 2> - locked java.net.SocksSocketImpl@221b9bb7 [junit4] 2> at java.net.ServerSocket.implAccept(ServerSocket.java:545) [junit4] 2> at java.net.ServerSocket.accept(ServerSocket.java:513) [junit4] 2> at sun.rmi.transport.tcp.TCPTransport$AcceptLoop.executeAcceptLoop(TCPTransport.java:400) [junit4] 2> at sun.rmi.transport.tcp.TCPTransport$AcceptLoop.run(TCPTransport.java:372) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> [junit4] 2> "RMI TCP Accept-0" ID=14 RUNNABLE (in native code) [junit4] 2> at java.net.DualStackPlainSocketImpl.accept0(Native Method) [junit4] 2> at java.net.DualStackPlainSocketImpl.socketAccept(DualStackPlainSocketImpl.java:131) [junit4] 2> at java.net.AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:404) [junit4] 2> at java.net.PlainSocketImpl.accept(PlainSocketImpl.java:199) [junit4] 2> - locked java.net.SocksSocketImpl@1808bbbc [junit4] 2> at java.net.ServerSocket.implAccept(ServerSocket.java:545) [junit4] 2> at java.net.ServerSocket.accept(ServerSocket.java:513) [junit4] 2> at sun.rmi.transport.tcp.TCPTransport$AcceptLoop.executeAcceptLoop(TCPTransport.java:400) [junit4] 2> at sun.rmi.transport.tcp.TCPTransport$AcceptLoop.run(TCPTransport.java:372) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> [junit4] 2> "JUnit4-serializer-daemon" ID=11 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=6 RUNNABLE [junit4] 2> [junit4] 2> "Signal Dispatcher" ID=5 RUNNABLE [junit4] 2> [junit4] 2> "Finalizer" ID=3 WAITING on java.lang.ref.ReferenceQueue$Lock@5996669a [junit4] 2> at java.lang.Object.wait(Native Method) [junit4] 2> - waiting on java.lang.ref.ReferenceQueue$Lock@5996669a [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@7392f65f [junit4] 2> at java.lang.Object.wait(Native Method) [junit4] 2> - waiting on java.lang.ref.Reference$Lock@7392f65f [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@48aa2714 [junit4] 2> at java.lang.Object.wait(Native Method) [junit4] 2> - waiting on com.carrotsearch.randomizedtesting.RandomizedRunner$1@48aa2714 [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=AddBlockUpdateTest -Dtests.method=testBasics -Dtests.seed=B97DDB37E5236F52 -Dtests.slow=true -Dtests.locale=is -Dtests.timezone=Africa/Luanda -Dtests.asserts=true -Dtests.file.encoding=US-ASCII [junit4] ERROR 7297s J0 | AddBlockUpdateTest.testBasics <<< [junit4] > Throwable #1: java.lang.Exception: Test abandoned because suite timeout was reached. [junit4] > at __randomizedtesting.SeedInfo.seed([B97DDB37E5236F52]:0) [junit4] 2> 7298431 T269 ccr.ThreadLeakControl.checkThreadLeaks WARNING Will linger awaiting termination of 3 leaked thread(s). [junit4] 2> 7318558 T269 ccr.ThreadLeakControl.checkThreadLeaks SEVERE 3 threads leaked from SUITE scope at org.apache.solr.update.AddBlockUpdateTest: [junit4] 2> 1) Thread[id=272, name=searcherExecutor-116-thread-1, state=WAITING, group=TGRP-AddBlockUpdateTest] [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> 2) Thread[id=273, name=Thread-92, state=WAITING, group=TGRP-AddBlockUpdateTest] [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> 3) Thread[id=270, name=TEST-AddBlockUpdateTest.testBasics-seed#[B97DDB37E5236F52], state=WAITING, group=TGRP-AddBlockUpdateTest] [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:118) [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:1635) [junit4] 2> at org.apache.solr.update.processor.DistributedUpdateProcessor.processCommit(DistributedUpdateProcessor.java:1612) [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.update.AddBlockUpdateTest.prepare(AddBlockUpdateTest.java:107) [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$7.evaluate(RandomizedRunner.java:870) [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> 7318560 T269 ccr.ThreadLeakControl.tryToInterruptAll Starting to interrupt leaked threads: [junit4] 2> 1) Thread[id=272, name=searcherExecutor-116-thread-1, state=WAITING, group=TGRP-AddBlockUpdateTest] [junit4] 2> 2) Thread[id=273, name=Thread-92, state=WAITING, group=TGRP-AddBlockUpdateTest] [junit4] 2> 3) Thread[id=270, name=TEST-AddBlockUpdateTest.testBasics-seed#[B97DDB37E5236F52], state=WAITING, group=TGRP-AddBlockUpdateTest] [junit4] 2> 7321584 T269 ccr.ThreadLeakControl.tryToInterruptAll SEVERE There are still zombie threads that couldn't be terminated: [junit4] 2> 1) Thread[id=272, name=searcherExecutor-116-thread-1, state=WAITING, group=TGRP-AddBlockUpdateTest] [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> 2) Thread[id=273, name=Thread-92, state=WAITING, group=TGRP-AddBlockUpdateTest] [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> 3) Thread[id=270, name=TEST-AddBlockUpdateTest.testBasics-seed#[B97DDB37E5236F52], state=WAITING, group=TGRP-AddBlockUpdateTest] [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:118) [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:1635) [junit4] 2> at org.apache.solr.update.processor.DistributedUpdateProcessor.processCommit(DistributedUpdateProcessor.java:1612) [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.update.AddBlockUpdateTest.prepare(AddBlockUpdateTest.java:107) [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$7.evaluate(RandomizedRunner.java:870) [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> NOTE: test params are: codec=Lucene50, sim=RandomSimilarityProvider(queryNorm=false,coord=crazy): {}, locale=is, timezone=Africa/Luanda [junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.8.0_45 (64-bit)/cpus=3,threads=4,free=59330704,total=134217728 [junit4] 2> NOTE: All tests run in this JVM: [TestJmxMonitoredMap, TestDistribDocBasedVersion, TestPerFieldSimilarity, OutputWriterTest, TestRemoveLastDynamicCopyField, TestSerializedLuceneMatchVersion, TestXIncludeConfig, TestFunctionQuery, AddBlockUpdateTest] [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=AddBlockUpdateTest -Dtests.seed=B97DDB37E5236F52 -Dtests.slow=true -Dtests.locale=is -Dtests.timezone=Africa/Luanda -Dtests.asserts=true -Dtests.file.encoding=US-ASCII [junit4] ERROR 0.00s J0 | AddBlockUpdateTest (suite) <<< [junit4] > Throwable #1: java.lang.Exception: Suite timeout exceeded (>= 7200000 msec). [junit4] > at __randomizedtesting.SeedInfo.seed([B97DDB37E5236F52]:0) [junit4] Completed [379/494] on J0 in 7321.64s, 1 test, 2 errors <<< FAILURES! [...truncated 362 lines...] BUILD FAILED C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:536: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:484: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:61: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\extra-targets.xml:39: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build.xml:229: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\common-build.xml:511: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:1433: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:991: There were test failures: 494 suites, 1964 tests, 1 suite-level error, 1 error, 473 ignored (29 assumptions) Total time: 141 minutes 56 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