Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/3633/ Java: 64bit/jdk1.7.0_45 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC
1 tests failed. FAILED: junit.framework.TestSuite.org.apache.solr.core.TestSolrDeletionPolicy2 Error Message: Suite timeout exceeded (>= 7200000 msec). Stack Trace: java.lang.Exception: Suite timeout exceeded (>= 7200000 msec). at __randomizedtesting.SeedInfo.seed([912397CD528AFEA9]:0) Build Log: [...truncated 10415 lines...] [junit4] Suite: org.apache.solr.core.TestSolrDeletionPolicy2 [junit4] 2> 1144295 T4005 oas.SolrTestCaseJ4.initCore ####initCore [junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestSolrDeletionPolicy2-1388700732563 [junit4] 2> 1144299 T4005 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\' [junit4] 2> 1144299 T4005 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 1144299 T4005 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 1144402 T4005 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50 [junit4] 2> 1144472 T4005 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-delpolicy2.xml [junit4] 2> 1144473 T4005 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml [junit4] 2> 1144483 T4005 oass.IndexSchema.readSchema [null] Schema name=test [junit4] 2> 1145195 T4005 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 1145205 T4005 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 1145209 T4005 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 1145217 T4005 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 1145224 T4005 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 1145228 T4005 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1145228 T4005 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 1145231 T4005 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 1145231 T4005 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1145232 T4005 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 1145233 T4005 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 1145233 T4005 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 1145233 T4005 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr [junit4] 2> 1145234 T4005 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\' [junit4] 2> 1145258 T4005 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 1145258 T4005 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr [junit4] 2> 1145259 T4005 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\' [junit4] 2> 1145360 T4005 oasc.CoreContainer.<init> New CoreContainer 1441072813 [junit4] 2> 1145362 T4005 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\] [junit4] 2> 1145363 T4005 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0 [junit4] 2> 1145363 T4005 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http:// [junit4] 2> 1145363 T4005 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0 [junit4] 2> 1145363 T4005 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 1145363 T4005 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 1145364 T4005 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 1145364 T4005 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 1145364 T4005 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 1145364 T4005 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 1145373 T4005 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 1145374 T4005 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 1145374 T4005 oasc.CoreContainer.load Host Name: [junit4] 2> 1145381 T4006 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1 [junit4] 2> 1145382 T4006 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\' [junit4] 2> 1145383 T4006 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 1145383 T4006 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 1145462 T4006 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50 [junit4] 2> 1145522 T4006 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-delpolicy2.xml [junit4] 2> 1145522 T4006 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml [junit4] 2> 1145532 T4006 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 1146271 T4006 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 1146277 T4006 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 1146283 T4006 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 1146293 T4006 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 1146299 T4006 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 1146304 T4006 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1146304 T4006 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 1146304 T4006 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 1146305 T4006 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1146306 T4006 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 1146306 T4006 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 1146306 T4006 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 1146308 T4006 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestSolrDeletionPolicy2-1388700732563\ [junit4] 2> 1146308 T4006 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1 [junit4] 2> 1146311 T4006 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestSolrDeletionPolicy2-1388700732563\ [junit4] 2> 1146311 T4006 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestSolrDeletionPolicy2-1388700732563\index/ [junit4] 2> 1146311 T4006 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestSolrDeletionPolicy2-1388700732563\index' doesn't exist. Creating new index... [junit4] 2> 1146312 T4006 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestSolrDeletionPolicy2-1388700732563\index [junit4] 2> 1146313 T4006 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=25, maxMergeAtOnceExplicit=40, maxMergedSegmentMB=75.6865234375, floorSegmentMB=1.4873046875, forceMergeDeletesPctAllowed=16.021623746848856, segmentsPerTier=39.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0 [junit4] 2> 1146316 T4006 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 1146317 T4006 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4] 2> 1146322 T4006 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 1146323 T4006 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 1146323 T4006 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=47, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 1146324 T4006 oass.SolrIndexSearcher.<init> Opening Searcher@30180ca9 main [junit4] 2> 1146325 T4006 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 1146325 T4007 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@30180ca9 main{StandardDirectoryReader(segments_1:1:nrt)} [junit4] 2> 1146340 T4005 oas.SolrTestCaseJ4.initCore ####initCore end [junit4] 2> 1146347 T4005 oas.SolrTestCaseJ4.setUp ###Starting testFakeDeletionPolicyClass [junit4] 2> ASYNC NEW_CORE C2852 name=collection1 org.apache.solr.core.SolrCore@4a21b7f7 [junit4] 2> 1146358 T4005 C2852 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[1]} 0 3 [junit4] 2> 1146369 T4005 C2852 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1146374 T4005 C2852 oass.SolrIndexSearcher.<init> Opening Searcher@7f840752 main [junit4] 2> 1146374 T4005 C2852 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 1146375 T4007 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7f840752 main{StandardDirectoryReader(segments_2:3:nrt _0(5.0):c1)} [junit4] 2> 1146375 T4005 C2852 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 6 [junit4] 2> 1146378 T4005 C2852 oasc.SolrCore.execute [collection1] webapp=null path=null params={rows=20&version=2.2&q=id:[0+TO+1]&qt=standard&start=0} hits=1 status=0 QTime=1 [junit4] 2> 1146380 T4005 oas.SolrTestCaseJ4.tearDown ###Ending testFakeDeletionPolicyClass [junit4] 2> 1146380 T4005 oas.SolrTestCaseJ4.deleteCore ###deleteCore [junit4] 2> 1146382 T4005 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1441072813 [junit4] 2> 7235041 T4004 ccr.ThreadLeakControl$2.evaluate WARNING Suite execution timed out: org.apache.solr.core.TestSolrDeletionPolicy2 [junit4] 2> ==== jstack at approximately timeout time ==== [junit4] 2> "Thread-1740" ID=4008 WAITING on java.lang.Object@6a7cb05f [junit4] 2> at java.lang.Object.wait(Native Method) [junit4] 2> - waiting on java.lang.Object@6a7cb05f [junit4] 2> at java.lang.Object.wait(Object.java:503) [junit4] 2> at org.apache.solr.core.CloserThread.run(CoreContainer.java:1011) [junit4] 2> [junit4] 2> "searcherExecutor-2389-thread-1" ID=4007 WAITING on java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@74cad5d8 [junit4] 2> at sun.misc.Unsafe.park(Native Method) [junit4] 2> - waiting on java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@74cad5d8 [junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186) [junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043) [junit4] 2> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [junit4] 2> at java.lang.Thread.run(Thread.java:744) [junit4] 2> [junit4] 2> "SUITE-TestSolrDeletionPolicy2-seed#[912397CD528AFEA9]-worker" ID=4005 WAITING on org.apache.solr.core.CloserThread@5056780 [junit4] 2> at java.lang.Object.wait(Native Method) [junit4] 2> - waiting on org.apache.solr.core.CloserThread@5056780 [junit4] 2> at java.lang.Thread.join(Thread.java:1280) [junit4] 2> at java.lang.Thread.join(Thread.java:1354) [junit4] 2> at org.apache.solr.core.CoreContainer.shutdown(CoreContainer.java:374) [junit4] 2> at org.apache.solr.util.TestHarness.close(TestHarness.java:337) [junit4] 2> at org.apache.solr.SolrTestCaseJ4.deleteCore(SolrTestCaseJ4.java:544) [junit4] 2> at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:137) [junit4] 2> at sun.reflect.GeneratedMethodAccessor26.invoke(Unknown Source) [junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] 2> at java.lang.reflect.Method.invoke(Method.java:606) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:700) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) [junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) [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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43) [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:70) [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:358) [junit4] 2> at java.lang.Thread.run(Thread.java:744) [junit4] 2> [junit4] 2> "SUITE-TestSolrDeletionPolicy2-seed#[912397CD528AFEA9]" ID=4004 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:655) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.access$800(ThreadLeakControl.java:60) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$2.evaluate(ThreadLeakControl.java:396) [junit4] 2> - locked java.lang.Object@309d93cf [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSuite(RandomizedRunner.java:556) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.access$200(RandomizedRunner.java:79) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$1.run(RandomizedRunner.java:492) [junit4] 2> [junit4] 2> "RMI TCP Accept-0" ID=3441 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:398) [junit4] 2> at java.net.PlainSocketImpl.accept(PlainSocketImpl.java:198) [junit4] 2> - locked java.net.SocksSocketImpl@395313f8 [junit4] 2> at java.net.ServerSocket.implAccept(ServerSocket.java:530) [junit4] 2> at java.net.ServerSocket.accept(ServerSocket.java:498) [junit4] 2> at sun.rmi.transport.tcp.TCPTransport$AcceptLoop.executeAcceptLoop(TCPTransport.java:388) [junit4] 2> at sun.rmi.transport.tcp.TCPTransport$AcceptLoop.run(TCPTransport.java:360) [junit4] 2> at java.lang.Thread.run(Thread.java:744) [junit4] 2> [junit4] 2> "RMI RenewClean-[127.0.0.1:63700]" ID=3437 TIMED_WAITING on java.lang.ref.ReferenceQueue$Lock@e90a6df [junit4] 2> at java.lang.Object.wait(Native Method) [junit4] 2> - timed waiting on java.lang.ref.ReferenceQueue$Lock@e90a6df [junit4] 2> at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:135) [junit4] 2> at sun.rmi.transport.DGCClient$EndpointEntry$RenewCleanThread.run(DGCClient.java:535) [junit4] 2> at java.lang.Thread.run(Thread.java:744) [junit4] 2> [junit4] 2> "RMI Scheduler(0)" ID=3436 TIMED_WAITING on java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@3abb81f1 [junit4] 2> at sun.misc.Unsafe.park(Native Method) [junit4] 2> - timed waiting on java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@3abb81f1 [junit4] 2> at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226) [junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2082) [junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1090) [junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:807) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [junit4] 2> at java.lang.Thread.run(Thread.java:744) [junit4] 2> [junit4] 2> "GC Daemon" ID=3434 TIMED_WAITING on sun.misc.GC$LatencyLock@6c501356 [junit4] 2> at java.lang.Object.wait(Native Method) [junit4] 2> - timed waiting on sun.misc.GC$LatencyLock@6c501356 [junit4] 2> at sun.misc.GC$Daemon.run(GC.java:117) [junit4] 2> [junit4] 2> "RMI Reaper" ID=3433 WAITING on java.lang.ref.ReferenceQueue$Lock@7d25aaa7 [junit4] 2> at java.lang.Object.wait(Native Method) [junit4] 2> - waiting on java.lang.ref.ReferenceQueue$Lock@7d25aaa7 [junit4] 2> at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:135) [junit4] 2> at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:151) [junit4] 2> at sun.rmi.transport.ObjectTable$Reaper.run(ObjectTable.java:351) [junit4] 2> at java.lang.Thread.run(Thread.java:744) [junit4] 2> [junit4] 2> "RMI TCP Accept-0" ID=3432 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:398) [junit4] 2> at java.net.PlainSocketImpl.accept(PlainSocketImpl.java:198) [junit4] 2> - locked java.net.SocksSocketImpl@7d441c2e [junit4] 2> at java.net.ServerSocket.implAccept(ServerSocket.java:530) [junit4] 2> at java.net.ServerSocket.accept(ServerSocket.java:498) [junit4] 2> at sun.rmi.transport.tcp.TCPTransport$AcceptLoop.executeAcceptLoop(TCPTransport.java:388) [junit4] 2> at sun.rmi.transport.tcp.TCPTransport$AcceptLoop.run(TCPTransport.java:360) [junit4] 2> at java.lang.Thread.run(Thread.java:744) [junit4] 2> [junit4] 2> "RMI TCP Accept-0" ID=3431 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:398) [junit4] 2> at java.net.PlainSocketImpl.accept(PlainSocketImpl.java:198) [junit4] 2> - locked java.net.SocksSocketImpl@2965042 [junit4] 2> at java.net.ServerSocket.implAccept(ServerSocket.java:530) [junit4] 2> at java.net.ServerSocket.accept(ServerSocket.java:498) [junit4] 2> at sun.rmi.transport.tcp.TCPTransport$AcceptLoop.executeAcceptLoop(TCPTransport.java:388) [junit4] 2> at sun.rmi.transport.tcp.TCPTransport$AcceptLoop.run(TCPTransport.java:360) [junit4] 2> at java.lang.Thread.run(Thread.java:744) [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@33e6fa21 [junit4] 2> at java.lang.Object.wait(Native Method) [junit4] 2> - waiting on java.lang.ref.ReferenceQueue$Lock@33e6fa21 [junit4] 2> at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:135) [junit4] 2> at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:151) [junit4] 2> at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:189) [junit4] 2> [junit4] 2> "Reference Handler" ID=2 WAITING on java.lang.ref.Reference$Lock@12fa726 [junit4] 2> at java.lang.Object.wait(Native Method) [junit4] 2> - waiting on java.lang.ref.Reference$Lock@12fa726 [junit4] 2> at java.lang.Object.wait(Object.java:503) [junit4] 2> at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:133) [junit4] 2> [junit4] 2> "main" ID=1 WAITING on com.carrotsearch.randomizedtesting.RandomizedRunner$1@2e8faa89 [junit4] 2> at java.lang.Object.wait(Native Method) [junit4] 2> - waiting on com.carrotsearch.randomizedtesting.RandomizedRunner$1@2e8faa89 [junit4] 2> at java.lang.Thread.join(Thread.java:1280) [junit4] 2> at java.lang.Thread.join(Thread.java:1354) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSuite(RandomizedRunner.java:502) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.run(RandomizedRunner.java:399) [junit4] 2> at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:180) [junit4] 2> at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:275) [junit4] 2> at com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:12) [junit4] 2> [junit4] 2> ^^============================================== [junit4] 2> [junit4] 2> 7235045 T4004 ccr.ThreadLeakControl.checkThreadLeaks WARNING Will linger awaiting termination of 3 leaked thread(s). [junit4] 2> 7255170 T4004 ccr.ThreadLeakControl.checkThreadLeaks SEVERE 3 threads leaked from SUITE scope at org.apache.solr.core.TestSolrDeletionPolicy2: [junit4] 2> 1) Thread[id=4005, name=SUITE-TestSolrDeletionPolicy2-seed#[912397CD528AFEA9]-worker, state=WAITING, group=TGRP-TestSolrDeletionPolicy2] [junit4] 2> at java.lang.Object.wait(Native Method) [junit4] 2> at java.lang.Thread.join(Thread.java:1280) [junit4] 2> at java.lang.Thread.join(Thread.java:1354) [junit4] 2> at org.apache.solr.core.CoreContainer.shutdown(CoreContainer.java:374) [junit4] 2> at org.apache.solr.util.TestHarness.close(TestHarness.java:337) [junit4] 2> at org.apache.solr.SolrTestCaseJ4.deleteCore(SolrTestCaseJ4.java:544) [junit4] 2> at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:137) [junit4] 2> at sun.reflect.GeneratedMethodAccessor26.invoke(Unknown Source) [junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] 2> at java.lang.reflect.Method.invoke(Method.java:606) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:700) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) [junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) [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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43) [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:70) [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:358) [junit4] 2> at java.lang.Thread.run(Thread.java:744) [junit4] 2> 2) Thread[id=4008, name=Thread-1740, state=WAITING, group=TGRP-TestSolrDeletionPolicy2] [junit4] 2> at java.lang.Object.wait(Native Method) [junit4] 2> at java.lang.Object.wait(Object.java:503) [junit4] 2> at org.apache.solr.core.CloserThread.run(CoreContainer.java:1011) [junit4] 2> 3) Thread[id=4007, name=searcherExecutor-2389-thread-1, state=WAITING, group=TGRP-TestSolrDeletionPolicy2] [junit4] 2> at sun.misc.Unsafe.park(Native Method) [junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186) [junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043) [junit4] 2> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [junit4] 2> at java.lang.Thread.run(Thread.java:744) [junit4] 2> 7255172 T4004 ccr.ThreadLeakControl.tryToInterruptAll Starting to interrupt leaked threads: [junit4] 2> 1) Thread[id=4005, name=SUITE-TestSolrDeletionPolicy2-seed#[912397CD528AFEA9]-worker, state=WAITING, group=TGRP-TestSolrDeletionPolicy2] [junit4] 2> 2) Thread[id=4008, name=Thread-1740, state=WAITING, group=TGRP-TestSolrDeletionPolicy2] [junit4] 2> 3) Thread[id=4007, name=searcherExecutor-2389-thread-1, state=WAITING, group=TGRP-TestSolrDeletionPolicy2] [junit4] 2> 8399473 T4005 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@4a21b7f7 [junit4] 2> 8399473 T4005 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=1,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0} [junit4] 2> 8399473 T4005 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState [junit4] 2> 8399474 T4005 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter [junit4] 2> 8399474 T4005 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser [junit4] 2> 8399476 T4005 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request. [junit4] 2> 8399476 T4005 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked [junit4] 2> 8399476 T4005 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestSolrDeletionPolicy2-1388700732563\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestSolrDeletionPolicy2-1388700732563\;done=false>>] [junit4] 2> 8399476 T4005 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestSolrDeletionPolicy2-1388700732563\ [junit4] 2> 8399476 T4005 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestSolrDeletionPolicy2-1388700732563\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestSolrDeletionPolicy2-1388700732563\index;done=false>>] [junit4] 2> 8399478 T4005 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestSolrDeletionPolicy2-1388700732563\index [junit4] 2> 7255201 T4004 ccr.ThreadLeakControl.tryToInterruptAll All leaked threads terminated. [junit4] 2> NOTE: test params are: codec=Lucene40, sim=DefaultSimilarity, locale=es_BO, timezone=Europe/Madrid [junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.7.0_45 (64-bit)/cpus=2,threads=1,free=355167088,total=411566080 [junit4] 2> NOTE: All tests run in this JVM: [DistributedQueryComponentCustomSortTest, IndexSchemaTest, AliasIntegrationTest, SolrInfoMBeanTest, SimpleFacetsTest, TestLMJelinekMercerSimilarityFactory, SoftAutoCommitTest, AssignTest, TestSolr4Spatial, SuggestComponentTest, RangeFacetTest, TestIndexingPerformance, AnalysisAfterCoreReloadTest, OverseerTest, AlternateDirectoryTest, TestDocumentBuilder, JSONWriterTest, DateMathParserTest, TestPostingsSolrHighlighter, FileUtilsTest, CopyFieldTest, ReturnFieldsTest, TestPerFieldSimilarity, TestHighFrequencyDictionaryFactory, SolrCoreTest, MBeansHandlerTest, WordBreakSolrSpellCheckerTest, BasicFunctionalityTest, TestDistributedMissingSort, ClusterStateTest, BadComponentTest, ClusterStateUpdateTest, AutoCommitTest, TestStressReorder, SearchHandlerTest, SuggesterTSTTest, TestCSVLoader, TermVectorComponentTest, TestIndexSearcher, TestXIncludeConfig, DistributedSpellCheckComponentTest, TestUtils, TestSolrQueryParserDefaultOperatorResource, OpenExchangeRatesOrgProviderTest, OverseerCollectionProcessorTest, TestBM25SimilarityFactory, PreAnalyzedFieldTest, QueryElevationComponentTest, BasicDistributedZkTest, ChangedSchemaMergeTest, TestSolrCoreProperties, TestFaceting, NumericFieldsTest, FieldFacetExtrasTest, MoreLikeThisHandlerTest, TestArbitraryIndexDir, StressHdfsTest, HighlighterConfigTest, PolyFieldTest, CoreAdminHandlerTest, DistanceFunctionTest, TestIBSimilarityFactory, TestAddFieldRealTimeGet, TestShardHandlerFactory, CSVRequestHandlerTest, ChaosMonkeySafeLeaderTest, TestNRTOpen, EnumFieldTest, NotRequiredUniqueKeyTest, TestClassNameShortening, BadCopyFieldTest, TestRealTimeGet, DocValuesTest, BasicZkTest, TestZkChroot, FunctionTest, TestUpdate, DisMaxRequestHandlerTest, TestSolrXMLSerializer, TestLazyCores, TestSolrDeletionPolicy1, TestSolrQueryParserResource, TestCharFilters, TestFoldingMultitermQuery, DeleteReplicaTest, ResponseLogComponentTest, HdfsLockFactoryTest, TestTrie, SolrXmlInZkTest, TestNumberUtils, ZkNodePropsTest, TestAnalyzedSuggestions, ShardRoutingTest, RequestHandlersTest, DirectSolrConnectionTest, SystemInfoHandlerTest, RAMDirectoryFactoryTest, MigrateRouteKeyTest, TestReloadAndDeleteDocs, TestSuggestSpellingConverter, BlockCacheTest, TestSolrIndexConfig, TestJmxMonitoredMap, ScriptEngineTest, DirectUpdateHandlerOptimizeTest, DOMUtilTest, TestPhraseSuggestions, HdfsBasicDistributedZk2Test, BlockDirectoryTest, SolrIndexSplitterTest, TestSolrXmlPersistence, HardAutoCommitTest, TestLRUCache, SpellPossibilityIteratorTest, DistributedTermsComponentTest, MinimalSchemaTest, TestFileDictionaryLookup, OutputWriterTest, TestNoOpRegenerator, BinaryUpdateRequestHandlerTest, MultiTermTest, TestValueSourceCache, TestFastOutputStream, TestSystemIdResolver, SolrPluginUtilsTest, TestSurroundQueryParser, TestBinaryField, TestAtomicUpdateErrorCases, TestQueryUtils, TestDynamicFieldCollectionResource, TestRTGBase, TestJoin, TestDocSet, TestStressUserVersions, TestRangeQuery, UnloadDistributedZkTest, ConnectionManagerTest, TestDefaultSimilarityFactory, TestSolrDeletionPolicy2] [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestSolrDeletionPolicy2 -Dtests.seed=912397CD528AFEA9 -Dtests.slow=true -Dtests.locale=es_BO -Dtests.timezone=Europe/Madrid -Dtests.file.encoding=UTF-8 [junit4] ERROR 0.00s | TestSolrDeletionPolicy2 (suite) <<< [junit4] > Throwable #1: java.lang.Exception: Suite timeout exceeded (>= 7200000 msec). [junit4] > at __randomizedtesting.SeedInfo.seed([912397CD528AFEA9]:0) [junit4] Completed in 7255.26s, 1 test, 1 error <<< FAILURES! [...truncated 661 lines...] BUILD FAILED C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:453: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:433: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:39: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\extra-targets.xml:37: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:189: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:491: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1304: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:937: There were test failures: 358 suites, 1577 tests, 1 suite-level error, 40 ignored (11 assumptions) Total time: 201 minutes 27 seconds Build step 'Invoke Ant' marked build as failure Description set: Java: 64bit/jdk1.7.0_45 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC Archiving artifacts Recording test results Email was triggered for: Failure Sending email for trigger: Failure
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org