You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2012/06/08 11:53:45 UTC
[JENKINS] Solr-trunk - Build # 1879 - Failure
Build: https://builds.apache.org/job/Solr-trunk/1879/
3 tests failed.
REGRESSION: org.apache.solr.cloud.FullSolrCloudTest.testDistribSearch
Error Message:
Timeout occured while waiting response from server at: http://localhost:13109/solr/collection1
Stack Trace:
org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://localhost:13109/solr/collection1
at __randomizedtesting.SeedInfo.seed([CCF7D390CC98B64:8D29F3217B96EB58]:0)
at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:405)
at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:182)
at org.apache.solr.client.solrj.request.AbstractUpdateRequest.process(AbstractUpdateRequest.java:117)
at org.apache.solr.cloud.FullSolrCloudTest.index_specific(FullSolrCloudTest.java:498)
at org.apache.solr.cloud.FullSolrCloudTest.brindDownShardIndexSomeDocsAndRecover(FullSolrCloudTest.java:713)
at org.apache.solr.cloud.FullSolrCloudTest.doTest(FullSolrCloudTest.java:550)
at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:680)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:616)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1969)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$1100(RandomizedRunner.java:132)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:814)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:875)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:889)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:32)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleReportUncaughtExceptions$1.evaluate(TestRuleReportUncaughtExceptions.java:68)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:821)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$700(RandomizedRunner.java:132)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3$1.run(RandomizedRunner.java:669)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:695)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:734)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:745)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleReportUncaughtExceptions$1.evaluate(TestRuleReportUncaughtExceptions.java:68)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
at org.apache.lucene.util.TestRuleIcuHack$1.evaluate(TestRuleIcuHack.java:51)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleNoInstanceHooksOverrides$1.evaluate(TestRuleNoInstanceHooksOverrides.java:53)
at org.apache.lucene.util.TestRuleNoStaticHooksShadowing$1.evaluate(TestRuleNoStaticHooksShadowing.java:52)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:36)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:56)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSuite(RandomizedRunner.java:605)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$400(RandomizedRunner.java:132)
at com.carrotsearch.randomizedtesting.RandomizedRunner$2.run(RandomizedRunner.java:551)
Caused by: java.net.SocketTimeoutException: Read timed out
at java.net.SocketInputStream.socketRead0(Native Method)
at java.net.SocketInputStream.read(SocketInputStream.java:146)
at org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:149)
at org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:111)
at org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:264)
at org.apache.http.impl.conn.DefaultResponseParser.parseHead(DefaultResponseParser.java:98)
at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:252)
at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:282)
at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:247)
at org.apache.http.impl.conn.AbstractClientConnAdapter.receiveResponseHeader(AbstractClientConnAdapter.java:216)
at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:298)
at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:125)
at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:647)
at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:464)
at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:820)
at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:754)
at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:732)
at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:351)
... 43 more
FAILED: junit.framework.TestSuite.org.apache.solr.handler.TestReplicationHandler
Error Message:
ERROR: SolrIndexSearcher opens=74 closes=73
Stack Trace:
java.lang.AssertionError: ERROR: SolrIndexSearcher opens=74 closes=73
at __randomizedtesting.SeedInfo.seed([CCF7D390CC98B64]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.apache.solr.SolrTestCaseJ4.endTrackingSearchers(SolrTestCaseJ4.java:190)
at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:82)
at sun.reflect.GeneratedMethodAccessor16.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:616)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1969)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$1100(RandomizedRunner.java:132)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:752)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleReportUncaughtExceptions$1.evaluate(TestRuleReportUncaughtExceptions.java:68)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
at org.apache.lucene.util.TestRuleIcuHack$1.evaluate(TestRuleIcuHack.java:51)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleNoInstanceHooksOverrides$1.evaluate(TestRuleNoInstanceHooksOverrides.java:53)
at org.apache.lucene.util.TestRuleNoStaticHooksShadowing$1.evaluate(TestRuleNoStaticHooksShadowing.java:52)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:36)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:56)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSuite(RandomizedRunner.java:605)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$400(RandomizedRunner.java:132)
at com.carrotsearch.randomizedtesting.RandomizedRunner$2.run(RandomizedRunner.java:551)
REGRESSION: org.apache.solr.update.SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete
Error Message:
searcher529 wasn't soon enough after soft529: 1339149103463 !< 1339149103239 + 100 (fudge)
Stack Trace:
java.lang.AssertionError: searcher529 wasn't soon enough after soft529: 1339149103463 !< 1339149103239 + 100 (fudge)
at __randomizedtesting.SeedInfo.seed([CCF7D390CC98B64:CB83C5A4176146D4]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.apache.solr.update.SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete(SoftAutoCommitTest.java:254)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:616)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1969)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$1100(RandomizedRunner.java:132)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:814)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:875)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:889)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:32)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleReportUncaughtExceptions$1.evaluate(TestRuleReportUncaughtExceptions.java:68)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:821)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$700(RandomizedRunner.java:132)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3$1.run(RandomizedRunner.java:669)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:695)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:734)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:745)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleReportUncaughtExceptions$1.evaluate(TestRuleReportUncaughtExceptions.java:68)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
at org.apache.lucene.util.TestRuleIcuHack$1.evaluate(TestRuleIcuHack.java:51)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleNoInstanceHooksOverrides$1.evaluate(TestRuleNoInstanceHooksOverrides.java:53)
at org.apache.lucene.util.TestRuleNoStaticHooksShadowing$1.evaluate(TestRuleNoStaticHooksShadowing.java:52)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:36)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:56)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSuite(RandomizedRunner.java:605)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$400(RandomizedRunner.java:132)
at com.carrotsearch.randomizedtesting.RandomizedRunner$2.run(RandomizedRunner.java:551)
Build Log:
[...truncated 11121 lines...]
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1337)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:484)
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:231)
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119)
[junit4] 2> at org.eclipse.jetty.server.handler.GzipHandler.handle(GzipHandler.java:267)
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1067)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:413)
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:192)
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:999)
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117)
[junit4] 2> at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111)
[junit4] 2> at org.eclipse.jetty.server.Server.handle(Server.java:351)
[junit4] 2> at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:454)
[junit4] 2> at org.eclipse.jetty.server.BlockingHttpConnection.handleRequest(BlockingHttpConnection.java:47)
[junit4] 2> at org.eclipse.jetty.server.AbstractHttpConnection.content(AbstractHttpConnection.java:900)
[junit4] 2> at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.content(AbstractHttpConnection.java:954)
[junit4] 2> at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:952)
[junit4] 2> at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:235)
[junit4] 2> at org.eclipse.jetty.server.BlockingHttpConnection.handle(BlockingHttpConnection.java:66)
[junit4] 2> at org.eclipse.jetty.server.bio.SocketConnector$ConnectorEndPoint.run(SocketConnector.java:254)
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
[junit4] 2> at java.lang.Thread.run(Thread.java:679)
[junit4] 2>
[junit4] 2> 71706 T968 C61 P13109 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@34085c10
[junit4] 2> 71708 T968 C61 P13109 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 71709 T968 C61 P13109 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=6,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=36,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 71710 T968 C61 P13109 oasc.RecoveryStrategy.close WARNING Stopping recovery for core collection1 zkNodeName=127.0.0.1:13109_solr_collection1
[junit4] 2> 71756 T900 oas.SolrTestCaseJ4.tearDown ###Ending testDistribSearch
[junit4] 1> /solr/collections/control_collection/leader_elect/control_shard/election (1)
[junit4] 1> /solr/collections/control_collection/leader_elect/control_shard/election/87762445828030466-127.0.0.1:13097_solr_collection1-n_0000000000 (0)
[junit4] 1> /solr/collections/control_collection/leaders (1)
[junit4] 1> /solr/collections/control_collection/leaders/control_shard (0)
[junit4] 1> DATA:
[junit4] 1> {
[junit4] 1> "core":"collection1",
[junit4] 1> "node_name":"127.0.0.1:13097_solr",
[junit4] 1> "base_url":"http://127.0.0.1:13097/solr"}
[junit4] 1> /solr/clusterstate.json (0)
[junit4] 1> DATA:
[junit4] 1> {
[junit4] 1> "collection1":{
[junit4] 1> "shard1":{
[junit4] 1> "127.0.0.1:13100_solr_collection1":{
[junit4] 1> "shard":"shard1",
[junit4] 1> "leader":"true",
[junit4] 1> "roles":null,
[junit4] 1> "state":"active",
[junit4] 1> "core":"collection1",
[junit4] 1> "collection":"collection1",
[junit4] 1> "node_name":"127.0.0.1:13100_solr",
[junit4] 1> "base_url":"http://127.0.0.1:13100/solr"},
[junit4] 1> "127.0.0.1:13106_solr_collection1":{
[junit4] 1> "shard":"shard1",
[junit4] 1> "roles":null,
[junit4] 1> "state":"active",
[junit4] 1> "core":"collection1",
[junit4] 1> "collection":"collection1",
[junit4] 1> "node_name":"127.0.0.1:13106_solr",
[junit4] 1> "base_url":"http://127.0.0.1:13106/solr"}},
[junit4] 1> "shard2":{
[junit4] 1> "127.0.0.1:13102_solr_collection1":{
[junit4] 1> "shard":"shard2",
[junit4] 1> "roles":null,
[junit4] 1> "state":"active",
[junit4] 1> "core":"collection1",
[junit4] 1> "collection":"collection1",
[junit4] 1> "node_name":"127.0.0.1:13102_solr",
[junit4] 1> "base_url":"http://127.0.0.1:13102/solr"},
[junit4] 1> "127.0.0.1:13109_solr_collection1":{
[junit4] 1> "shard":"shard2",
[junit4] 1> "leader":"true",
[junit4] 1> "roles":null,
[junit4] 1> "state":"active",
[junit4] 1> "core":"collection1",
[junit4] 1> "collection":"collection1",
[junit4] 1> "node_name":"127.0.0.1:13109_solr",
[junit4] 1> "base_url":"http://127.0.0.1:13109/solr"}}},
[junit4] 1> "control_collection":{"control_shard":{"127.0.0.1:13097_solr_collection1":{
[junit4] 1> "shard":"control_shard",
[junit4] 1> "leader":"true",
[junit4] 1> "roles":null,
[junit4] 1> "state":"active",
[junit4] 1> "core":"collection1",
[junit4] 1> "collection":"control_collection",
[junit4] 1> "node_name":"127.0.0.1:13097_solr",
[junit4] 1> "base_url":"http://127.0.0.1:13097/solr"}}}}
[junit4] 1> /zookeeper (1)
[junit4] 1> DATA:
[junit4] 1>
[junit4] 1>
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=FullSolrCloudTest -Dtests.method=testDistribSearch -Dtests.seed=CCF7D390CC98B64 -Dtests.nightly=true -Dtests.locale=fr -Dtests.timezone=America/Porto_Acre -Dargs="-Dfile.encoding=ISO8859-1"
[junit4] 1>
[junit4] 2>
[junit4] > (@AfterClass output)
[junit4] 2> 71794 T900 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: test params are: codec=Appending, sim=RandomSimilarityProvider(queryNorm=false,coord=false): {}, locale=fr, timezone=America/Porto_Acre
[junit4] 2> NOTE: FreeBSD 9.0-RELEASE amd64/Sun Microsystems Inc. 1.6.0_32 (64-bit)/cpus=16,threads=2,free=74710488,total=200409088
[junit4] 2> NOTE: All tests run in this JVM: [IndexSchemaRuntimeFieldTest, BadComponentTest, ConvertedLegacyTest, SolrIndexConfigTest, SignatureUpdateProcessorFactoryTest, PrimUtilsTest, TestReverseStringFilterFactory, ZkControllerTest, CommonGramsQueryFilterFactoryTest, TestCJKBigramFilterFactory, EchoParamsTest, TestKeywordMarkerFilterFactory, SystemInfoHandlerTest, TestPersianNormalizationFilterFactory, TestPatternReplaceCharFilterFactory, HighlighterConfigTest, SpellingQueryConverterTest, TestSolrDeletionPolicy2, TestBadConfig, TestNorwegianLightStemFilterFactory, TestSolrCoreProperties, TestIrishLowerCaseFilterFactory, TestMergePolicyConfig, CSVRequestHandlerTest, DOMUtilTest, TestPropInject, TimeZoneUtilsTest, TestConfig, TestTrie, RequestHandlersTest, CacheHeaderTest, DisMaxRequestHandlerTest, SolrRequestParserTest, TestRemoveDuplicatesTokenFilterFactory, SortByFunctionTest, TestXIncludeConfig, DistributedQueryElevationComponentTest, TestStopFilterFactory, TestPortugueseLightStemFilterFactory, TestRangeQuery, TestExtendedDismaxParser, TestLRUCache, LengthFilterTest, TestJapanesePartOfSpeechStopFilterFactory, TestIndonesianStemFilterFactory, TestQuerySenderNoQuery, TestIBSimilarityFactory, SolrCmdDistributorTest, TestUAX29URLEmailTokenizerFactory, FullSolrCloudDistribCmdsTest, OpenExchangeRatesOrgProviderTest, TestCapitalizationFilterFactory, StatsComponentTest, TestThaiWordFilterFactory, TestCSVResponseWriter, TestItalianLightStemFilterFactory, TestCSVLoader, JsonLoaderTest, BasicZkTest, TestPhraseSuggestions, DistributedSpellCheckComponentTest, DefaultValueUpdateProcessorTest, IndexSchemaTest, TestDictionaryCompoundWordTokenFilterFactory, XmlUpdateRequestHandlerTest, TestFrenchLightStemFilterFactory, TestTurkishLowerCaseFilterFactory, LoggingHandlerTest, TestPatternReplaceFilterFactory, TestCollationField, BinaryUpdateRequestHandlerTest, PolyFieldTest, TestBinaryResponseWriter, TestSystemIdResolver, DistanceFunctionTest, DateMathParserTest, TestRemoteStreaming, ZkNodePropsTest, FullSolrCloudTest]
[junit4] 2>
[junit4] Completed on J0 in 71.80s, 1 test, 1 error <<< FAILURES!
[...truncated 196 lines...]
[junit4] 2> 14524 T1881 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Solr-trunk/checkout/solr/build/solr-core/test-files/solr/lib/classes/' to classloader
[junit4] 2> 14524 T1881 oasc.CoreContainer.<init> New CoreContainer 476290009
[junit4] 2> 14525 T1881 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/hudson/hudson-slave/workspace/Solr-trunk/checkout/solr/build/solr-core/test-files/solr/, dataDir=/usr/home/hudson/hudson-slave/workspace/Solr-trunk/checkout/solr/build/solr-core/test/J0/./org.apache.solr.update.SoftAutoCommitTest-1339149102098/
[junit4] 2> 14525 T1881 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@256eb6bc
[junit4] 2> 14526 T1881 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory '/usr/home/hudson/hudson-slave/workspace/Solr-trunk/checkout/solr/build/solr-core/test/J0/./org.apache.solr.update.SoftAutoCommitTest-1339149102098/index' doesn't exist. Creating new index...
[junit4] 2> 14527 T1881 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@2636d85f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3b1807c5),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4] 2> 14527 T1881 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4] 2> 14528 T1881 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4] 2> 14529 T1881 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 14529 T1881 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 14530 T1881 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 14530 T1881 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 14530 T1881 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 14531 T1881 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 14531 T1881 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 14531 T1881 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 14531 T1881 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 14532 T1881 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4] 2> 14532 T1881 oasc.RequestHandlers.initHandlersFromConfig created dismaxNoDefaults: solr.SearchHandler
[junit4] 2> 14532 T1881 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 14533 T1881 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 14533 T1881 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 14533 T1881 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 14534 T1881 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 14534 T1881 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 14534 T1881 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 14534 T1881 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 14535 T1881 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 14535 T1881 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 14535 T1881 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 14536 T1881 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 14536 T1881 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 14536 T1881 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 14537 T1881 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 14537 T1881 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 14539 T1881 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 14540 T1881 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [SOLRCONFIG-HIGHLIGHT.XML, SCHEMA-REQUIRED-FIELDS.XML, SCHEMA-REPLICATION2.XML, BAD-SCHEMA-DUP-DYNAMICFIELD.XML, SCHEMA-MINIMAL.XML, SOLRCONFIG-CACHING.XML, SOLRCONFIG-REPEATER.XML, SOLRCONFIG-MERGEPOLICY.XML, BAD-SCHEMA-NONTEXT-ANALYZER.XML, CURRENCY.XML, SOLRCONFIG-TLOG.XML, SOLRCONFIG-MASTER.XML, SCHEMA11.XML, SOLRCONFIG-BASIC.XML, DA_COMPOUNDDICTIONARY.TXT, SCHEMA-COPYFIELD-TEST.XML, SOLRCONFIG-SLAVE.XML, ELEVATE.XML, SOLRCONFIG-PROPINJECT-INDEXDEFAULT.XML, SCHEMA-IB.XML, SOLRCONFIG-QUERYSENDER.XML, SCHEMA-REPLICATION1.XML, DA_UTF8.XML, HYPHENATION.DTD, SOLRCONFIG-ENABLEPLUGIN.XML, SCHEMA-PHRASESUGGEST.XML, STEMDICT.TXT, HUNSPELL-TEST.AFF, STOPTYPES-1.TXT, STOPWORDSWRONGENCODING.TXT, SCHEMA-NUMERIC.XML, SOLRCONFIG-TRANSFORMERS.XML, SOLRCONFIG-PROPINJECT.XML, BAD-SCHEMA-NOT-INDEXED-BUT-TF.XML, SOLRCONFIG-SIMPLELOCK.XML, WDFTYPES.TXT, STOPTYPES-2.TXT, SCHEMA-REVERSED.XML, SOLRCONFIG-SPELLCHECKCOMPONENT.XML, SCHEMA-DFR.XML, SOLRCONFIG-PHRASESUGGEST.XML, BAD-SCHEMA-NOT-INDEXED-BUT-POS.XML, KEEP-1.TXT, OPEN-EXCHANGE-RATES.JSON, STOPWITHBOM.TXT, SCHEMA-BINARYFIELD.XML, SOLRCONFIG-SPELLCHECKER.XML, SOLRCONFIG-UPDATE-PROCESSOR-CHAINS.XML, BAD-SCHEMA-OMIT-TF-BUT-NOT-POS.XML, BAD-SCHEMA-DUP-FIELDTYPE.XML, SOLRCONFIG-MASTER1.XML, SYNONYMS.TXT, SCHEMA_CODEC.XML, SCHEMA.XML, SOLRCONFIG-SOLR-749.XML, SOLRCONFIG-MASTER1-KEEPONEBACKUP.XML, STOP-2.TXT, SOLRCONFIG-FUNCTIONQUERY.XML, SOLRCONFIG-TERMINDEX.XML, SCHEMA-LMDIRICHLET.XML, SOLRCONFIG-ELEVATE.XML, STOPWORDS.TXT, SCHEMA-FOLDING.XML, SCHEMA-STOP-KEEP.XML, BAD-SCHEMA-NOT-INDEXED-BUT-NORMS.XML, SOLRCONFIG-SOLCOREPROPERTIES.XML, STOP-1.TXT, SOLRCONFIG-MASTER2.XML, SCHEMA-SPELLCHECKER.XML, SOLRCONFIG-LAZYWRITER.XML, SCHEMA-LUCENEMATCHVERSION.XML, BAD-MP-SOLRCONFIG.XML, FRENCHARTICLES.TXT, SCHEMA15.XML, SOLRCONFIG-REQHANDLER.INCL, SCHEMASURROUND.XML, SOLRCONFIG-MASTER3.XML, HUNSPELL-TEST.DIC, SOLRCONFIG-XINCLUDE.XML, SOLRCONFIG-SLAVE1.XML, SOLRCONFIG-DELPOLICY1.XML, SCHEMA-SIM.XML, SCHEMA-COLLATE.XML, STOP-SNOWBALL.TXT, PROTWORDS.TXT, SCHEMA-TRIE.XML, SOLRCONFIG_CODEC.XML, SCHEMA-TFIDF.XML, SCHEMA-LMJELINEKMERCER.XML, PHRASESUGGEST.TXT, BAD-SCHEMA-UNIQUEKEY-USES-DEFAULT.XML, OLD_SYNONYMS.TXT, SOLRCONFIG-DELPOLICY2.XML, SOLRCONFIG-NATIVELOCK.XML, XSLT, BAD-SCHEMA-DUP-FIELD.XML, SOLRCONFIG-NOCACHE.XML, SCHEMA-BM25.XML, SOLRCONFIG-ALTDIRECTORY.XML, SOLRCONFIG-QUERYSENDER-NOQUERY.XML, COMPOUNDDICTIONARY.TXT, SOLRCONFIG_PERF.XML, SCHEMA-NOT-REQUIRED-UNIQUE-KEY.XML, KEEP-2.TXT, BAD-SCHEMA-UNIQUEKEY-IS-COPYFIELD-DEST.XML, SCHEMA12.XML, MAPPING-ISOLATIN1ACCENT.TXT, BAD_SOLRCONFIG.XML, BAD-SCHEMA-EXTERNAL-FILEFIELD.XML]
[junit4] 2> 14542 T1881 oass.SolrIndexSearcher.<init> Opening Searcher@549ba954 main
[junit4] 2> 14542 T1881 oass.SolrIndexSearcher.<init> WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4] 2> 14543 T1881 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 14543 T1881 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 14543 T1881 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4] 2> 14548 T1881 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 14594 T1881 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 14594 T1881 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 14595 T1881 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 14595 T1881 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 14595 T1881 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 14595 T1881 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 14595 T1881 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 14596 T1881 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 14596 T1881 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 14596 T1881 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 14607 T1888 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@549ba954 main{StandardDirectoryReader(segments_1:1)}
[junit4] 2> 14608 T1881 oasc.CoreContainer.register registering core: collection1
[junit4] 2> 14609 T1881 oasu.AbstractSolrTestCase.setUp ####SETUP_END testSoftAndHardCommitMaxTimeDelete
[junit4] 2> ASYNC NEW_CORE C105 name=collection1 org.apache.solr.core.SolrCore@4f8cd21e
[junit4] 2> 14613 T1881 C105 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@2636d85f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3b1807c5),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4] 2> 14614 T1881 C105 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4] 2> 14615 T1881 C105 UPDATE [collection1] webapp=null path=null params={} {add=[529]} 0 3
[junit4] 2> 14622 T1881 C105 oasu.DirectUpdateHandler2.commit start commit{flags=0,version=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4] 2> 14633 T1881 C105 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@2636d85f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3b1807c5),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@2636d85f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3b1807c5),segFN=segments_2,generation=2,filenames=[_0_Lucene40_0.tim, _0.fnm, _0_Lucene40_0.frq, _0_nrm.cfe, segments_2, _0.fdx, _0_nrm.cfs, _0.si, _0_Lucene40_0.prx, _0.fdt, _0_Lucene40_0.tip]
[junit4] 2> 14633 T1881 C105 oasc.SolrDeletionPolicy.updateCommits newest commit = 2
[junit4] 2> 14635 T1881 C105 oass.SolrIndexSearcher.<init> Opening Searcher@343c80ba main
[junit4] 2> 14635 T1881 C105 oass.SolrIndexSearcher.<init> WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4] 2> 14635 T1881 C105 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 14636 T1888 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@343c80ba main{StandardDirectoryReader(segments_2:3 _0(5.0):C1)}
[junit4] 2> 14637 T1881 C105 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 16
[junit4] 2> 14642 T1881 C105 UPDATE [collection1] webapp=null path=null params={} {delete=[529]} 0 1
[junit4] 2> 15143 T1890 oasu.DirectUpdateHandler2.commit start commit{flags=0,version=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true}
[junit4] 2> 15366 T1890 oass.SolrIndexSearcher.<init> Opening Searcher@641754bc main
[junit4] 2> 15366 T1890 oass.SolrIndexSearcher.<init> WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4] 2> 15366 T1890 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 15367 T1888 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@641754bc main{StandardDirectoryReader(segments_2:5:nrt)}
[junit4] 2> 15371 T1881 C105 UPDATE [collection1] webapp=null path=null params={} {add=[550]} 0 1
[junit4] 2> 15843 T1889 oasu.DirectUpdateHandler2.commit start commit{flags=0,version=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4] 2> 15845 T1889 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@2636d85f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3b1807c5),segFN=segments_2,generation=2,filenames=[_0_Lucene40_0.tim, _0.fnm, _0_Lucene40_0.frq, _0_nrm.cfe, segments_2, _0.fdx, _0_nrm.cfs, _0.si, _0_Lucene40_0.prx, _0.fdt, _0_Lucene40_0.tip]
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@2636d85f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3b1807c5),segFN=segments_3,generation=3,filenames=[_1_Lucene40_0.tim, _1.fdx, _1_nrm.cfs, _1.fdt, _1.si, _1_Lucene40_0.frq, _1.fnm, segments_3, _1_Lucene40_0.prx, _1_Lucene40_0.tip, _1_nrm.cfe]
[junit4] 2> 15845 T1889 oasc.SolrDeletionPolicy.updateCommits newest commit = 3
[junit4] 2> 15846 T1881 oasu.AbstractSolrTestCase.tearDown ####TEARDOWN_START testSoftAndHardCommitMaxTimeDelete
[junit4] 2> 15846 T1881 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=476290009
[junit4] 2> 15846 T1889 oass.SolrIndexSearcher.<init> Opening Searcher@4c577186 main
[junit4] 2> 15846 T1881 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@4f8cd21e
[junit4] 2> 15846 T1889 oass.SolrIndexSearcher.<init> WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4] 2> 15847 T1889 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 15847 T1888 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4c577186 main{StandardDirectoryReader(segments_3:7:nrt _1(5.0):C1)}
[junit4] 2> 15849 T1881 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 15849 T1881 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=3,autocommit maxTime=1200ms,autocommits=1,soft autocommit maxTime=500ms,soft autocommits=1,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=2,cumulative_deletesById=1,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SoftAutoCommitTest -Dtests.method=testSoftAndHardCommitMaxTimeDelete -Dtests.seed=CCF7D390CC98B64 -Dtests.nightly=true -Dtests.locale=ar_QA -Dtests.timezone=Asia/Pyongyang -Dargs="-Dfile.encoding=ISO8859-1"
[junit4] 2>
[junit4] > (@AfterClass output)
[junit4] 2> NOTE: test params are: codec=Lucene40: {}, sim=DefaultSimilarity, locale=ar_QA, timezone=Asia/Pyongyang
[junit4] 2> NOTE: FreeBSD 9.0-RELEASE amd64/Sun Microsystems Inc. 1.6.0_32 (64-bit)/cpus=16,threads=1,free=81159024,total=243728384
[junit4] 2> NOTE: All tests run in this JVM: [IndexSchemaRuntimeFieldTest, BadComponentTest, ConvertedLegacyTest, SolrIndexConfigTest, SignatureUpdateProcessorFactoryTest, PrimUtilsTest, TestReverseStringFilterFactory, ZkControllerTest, CommonGramsQueryFilterFactoryTest, TestCJKBigramFilterFactory, EchoParamsTest, TestKeywordMarkerFilterFactory, SystemInfoHandlerTest, TestPersianNormalizationFilterFactory, TestPatternReplaceCharFilterFactory, HighlighterConfigTest, SpellingQueryConverterTest, TestSolrDeletionPolicy2, TestBadConfig, TestNorwegianLightStemFilterFactory, TestSolrCoreProperties, TestIrishLowerCaseFilterFactory, TestMergePolicyConfig, CSVRequestHandlerTest, DOMUtilTest, TestPropInject, TimeZoneUtilsTest, TestConfig, TestTrie, RequestHandlersTest, CacheHeaderTest, DisMaxRequestHandlerTest, SolrRequestParserTest, TestRemoveDuplicatesTokenFilterFactory, SortByFunctionTest, TestXIncludeConfig, DistributedQueryElevationComponentTest, TestStopFilterFactory, TestPortugueseLightStemFilterFactory, TestRangeQuery, TestExtendedDismaxParser, TestLRUCache, LengthFilterTest, TestJapanesePartOfSpeechStopFilterFactory, TestIndonesianStemFilterFactory, TestQuerySenderNoQuery, TestIBSimilarityFactory, SolrCmdDistributorTest, TestUAX29URLEmailTokenizerFactory, FullSolrCloudDistribCmdsTest, OpenExchangeRatesOrgProviderTest, TestCapitalizationFilterFactory, StatsComponentTest, TestThaiWordFilterFactory, TestCSVResponseWriter, TestItalianLightStemFilterFactory, TestCSVLoader, JsonLoaderTest, BasicZkTest, TestPhraseSuggestions, DistributedSpellCheckComponentTest, DefaultValueUpdateProcessorTest, IndexSchemaTest, TestDictionaryCompoundWordTokenFilterFactory, XmlUpdateRequestHandlerTest, TestFrenchLightStemFilterFactory, TestTurkishLowerCaseFilterFactory, LoggingHandlerTest, TestPatternReplaceFilterFactory, TestCollationField, BinaryUpdateRequestHandlerTest, PolyFieldTest, TestBinaryResponseWriter, TestSystemIdResolver, DistanceFunctionTest, DateMathParserTest, TestRemoteStreaming, ZkNodePropsTest, FullSolrCloudTest, SearchHandlerTest, TestStemmerOverrideFilterFactory, DebugComponentTest, TestHashPartitioner, SuggesterTest, TestSort, TestSolrXMLSerializer, TestBinaryField, TestCzechStemFilterFactory, QueryParsingTest, TestValueSourceCache, TestSurroundQueryParser, TestCodecSupport, TestDistributedGrouping, LeaderElectionIntegrationTest, CloudStateTest, MBeansHandlerTest, MultiTermTest, QueryElevationComponentTest, TestLMJelinekMercerSimilarityFactory, TestTypeTokenFilterFactory, OutputWriterTest, TestGermanMinimalStemFilterFactory, TestRealTimeGet, ZkSolrClientTest, CloudStateUpdateTest, TestRecovery, SoftAutoCommitTest]
[junit4] 2>
[junit4] Completed on J0 in 7.38s, 3 tests, 1 failure <<< FAILURES!
[...truncated 156 lines...]
[junit4] 2> 195 T2817 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 196 T2817 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 196 T2817 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 196 T2817 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 197 T2817 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 197 T2817 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 211 T2817 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1339149003991/slave/.
[junit4] 2> 211 T2817 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1339149003991/slave/./'
[junit4] 2> 233 T2817 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4] 2> 271 T2817 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 272 T2817 oass.IndexSchema.readSchema Reading Solr Schema
[junit4] 2> 279 T2817 oass.IndexSchema.readSchema Schema name=test
[junit4] 2> 290 T2817 oass.IndexSchema.readSchema WARNING no default search field specified in schema.
[junit4] 2> 292 T2817 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 293 T2817 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1339149003991/slave/./, dataDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1339149003991/slave/data/
[junit4] 2> 293 T2817 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 294 T2817 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1339149003991/slave/data/index' doesn't exist. Creating new index...
[junit4] 2> 298 T2817 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4] 2> commit{dir=/usr/home/hudson/hudson-slave/workspace/Solr-trunk/checkout/solr/build/solr-core/test/J1/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1339149003991/slave/data/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4] 2> 299 T2817 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4] 2> 299 T2817 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 300 T2817 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 300 T2817 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 300 T2817 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 301 T2817 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 301 T2817 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 302 T2817 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 304 T2817 oass.SolrIndexSearcher.<init> Opening Searcher@d3a9fed main
[junit4] 2> 305 T2817 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 305 T2817 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 306 T2817 oash.SnapPuller.startExecutorService Poll Scheduled at an interval of 1000ms
[junit4] 2> 306 T2837 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@d3a9fed main{StandardDirectoryReader(segments_1:1)}
[junit4] 2> 306 T2817 oasc.CoreContainer.register registering core: collection1
[junit4] 2> 307 T2817 oass.SolrDispatchFilter.init user.dir=/usr/home/hudson/hudson-slave/workspace/Solr-trunk/checkout/solr/build/solr-core/test/J1
[junit4] 2> 307 T2817 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 307 T2817 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2>
[junit4] > (@AfterClass output)
[junit4] 2> 27093 T2817 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1690398419
[junit4] 2> 27093 T2817 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1fe6448f
[junit4] 2> 27093 T2817 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 27094 T2817 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=493,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0}
[junit4] 2> 27095 T2817 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 27147 T2817 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=744155288
[junit4] 2> 27147 T2817 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@252bb95b
[junit4] 2> 27147 T2817 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 27148 T2817 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=2,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> 27148 T2817 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 27204 T2817 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 30173 T3019 oash.SnapPuller.fetchLatestIndex SEVERE Master at: http://localhost:47141/solr/replication is not available. Index fetch failed. Exception: Connect to localhost:47141 timed out
[junit4] 2> 30174 T3019 oash.SnapPuller.logReplicationTimeAndConfFiles WARNING Exception while updating statistics java.io.FileNotFoundException: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1339149003991/slave/data/replication.properties (No such file or directory)
[junit4] 2> at java.io.FileOutputStream.open(Native Method)
[junit4] 2> at java.io.FileOutputStream.<init>(FileOutputStream.java:209)
[junit4] 2> at java.io.FileOutputStream.<init>(FileOutputStream.java:160)
[junit4] 2> at org.apache.solr.handler.SnapPuller.logReplicationTimeAndConfFiles(SnapPuller.java:469)
[junit4] 2> at org.apache.solr.handler.SnapPuller.fetchLatestIndex(SnapPuller.java:395)
[junit4] 2> at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:298)
[junit4] 2> at org.apache.solr.handler.SnapPuller$1.run(SnapPuller.java:169)
[junit4] 2> at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
[junit4] 2> at java.util.concurrent.FutureTask$Sync.innerRunAndReset(FutureTask.java:351)
[junit4] 2> at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:178)
[junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:165)
[junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:267)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603)
[junit4] 2> at java.lang.Thread.run(Thread.java:679)
[junit4] 2>
[junit4] 2> 148325 T2817 oas.SolrTestCaseJ4.endTrackingSearchers SEVERE ERROR: SolrIndexSearcher opens=74 closes=73
[junit4] 2> NOTE: test params are: codec=Lucene40: {}, sim=RandomSimilarityProvider(queryNorm=false,coord=true): {}, locale=ar_IQ, timezone=America/Bahia_Banderas
[junit4] 2> NOTE: FreeBSD 9.0-RELEASE amd64/Sun Microsystems Inc. 1.6.0_32 (64-bit)/cpus=16,threads=1,free=46260040,total=223543296
[junit4] 2> NOTE: All tests run in this JVM: [DocumentAnalysisRequestHandlerTest, SimpleFacetsTest, SpellCheckCollatorTest, IndexReaderFactoryTest, PrimitiveFieldTypeTest, CurrencyFieldTest, RAMDirectoryFactoryTest, TestFastLRUCache, TestJapaneseBaseFormFilterFactory, SuggesterFSTTest, TestSpanishLightStemFilterFactory, DoubleMetaphoneFilterFactoryTest, SolrPluginUtilsTest, TestGermanStemFilterFactory, TestDelimitedPayloadTokenFilterFactory, TestJmxIntegration, LukeRequestHandlerTest, TestCJKWidthFilterFactory, TestCoreContainer, TestMappingCharFilterFactory, TestHTMLStripCharFilterFactory, TestArbitraryIndexDir, ResourceLoaderTest, AlternateDirectoryTest, FileUtilsTest, TestPorterStemFilterFactory, PingRequestHandlerTest, TestRussianLightStemFilterFactory, TestEnglishMinimalStemFilterFactory, SnowballPorterFilterFactoryTest, NoCacheHeaderTest, TestHyphenationCompoundWordTokenFilterFactory, TestGermanLightStemFilterFactory, DirectUpdateHandlerTest, HighlighterTest, UpdateParamsTest, URLClassifyProcessorTest, MinimalSchemaTest, IndexBasedSpellCheckerTest, TestBulgarianStemFilterFactory, SpellCheckComponentTest, FieldAnalysisRequestHandlerTest, SuggesterWFSTTest, TestPatternTokenizerFactory, SampleTest, TestTrimFilterFactory, TestGreekLowerCaseFilterFactory, TestPropInjectDefaults, BadIndexSchemaTest, FileBasedSpellCheckerTest, NumericFieldsTest, TestReversedWildcardFilterFactory, AutoCommitTest, JSONWriterTest, TestBrazilianStemFilterFactory, OverseerTest, TestHungarianLightStemFilterFactory, RequiredFieldsTest, TestNGramFilters, TestSuggestSpellingConverter, TestPortugueseMinimalStemFilterFactory, TestNumberUtils, SpatialFilterTest, TestPHPSerializedResponseWriter, TestFaceting, SolrCoreTest, SOLR749Test, TestKStemFilterFactory, UniqFieldsUpdateProcessorFactoryTest, TestDFRSimilarityFactory, TestUpdate, SuggesterTSTTest, RecoveryZkTest, TestGroupingSearch, DirectSolrSpellCheckerTest, TestGalicianMinimalStemFilterFactory, SolrInfoMBeanTest, TestGalicianStemFilterFactory, TestFrenchMinimalStemFilterFactory, TestPseudoReturnFields, TestElisionFilterFactory, TestWikipediaTokenizerFactory, TestMultiWordSynonyms, LegacyHTMLStripCharFilterTest, TestDistributedSearch, TestSolrDeletionPolicy1, SpellPossibilityIteratorTest, TestArabicFilters, TestPhoneticFilterFactory, UpdateRequestProcessorFactoryTest, TestGreekStemFilterFactory, FieldMutatingUpdateProcessorTest, TestUtils, TestPerFieldSimilarity, TestLuceneMatchVersion, TestSolrQueryParser, TestPluginEnable, LeaderElectionTest, BasicDistributedZkTest, TestReplicationHandler]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestReplicationHandler -Dtests.seed=CCF7D390CC98B64 -Dtests.nightly=true -Dtests.locale=ar_IQ -Dtests.timezone=America/Bahia_Banderas -Dargs="-Dfile.encoding=ISO8859-1"
[junit4] 2>
[junit4] ERROR 0.00s J1 | TestReplicationHandler (suite)
[junit4] > Throwable #1: java.lang.AssertionError: ERROR: SolrIndexSearcher opens=74 closes=73
[junit4] > at __randomizedtesting.SeedInfo.seed([CCF7D390CC98B64]:0)
[junit4] > at org.junit.Assert.fail(Assert.java:93)
[junit4] > at org.apache.solr.SolrTestCaseJ4.endTrackingSearchers(SolrTestCaseJ4.java:190)
[junit4] > at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:82)
[junit4] > at sun.reflect.GeneratedMethodAccessor16.invoke(Unknown Source)
[junit4] > at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] > at java.lang.reflect.Method.invoke(Method.java:616)
[junit4] > at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1969)
[junit4] > at com.carrotsearch.randomizedtesting.RandomizedRunner.access$1100(RandomizedRunner.java:132)
[junit4] > at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:752)
[junit4] > at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4] > at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] > at org.apache.lucene.util.TestRuleReportUncaughtExceptions$1.evaluate(TestRuleReportUncaughtExceptions.java:68)
[junit4] > at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
[junit4] > at org.apache.lucene.util.TestRuleIcuHack$1.evaluate(TestRuleIcuHack.java:51)
[junit4] > at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4] > at org.apache.lucene.util.TestRuleNoInstanceHooksOverrides$1.evaluate(TestRuleNoInstanceHooksOverrides.java:53)
[junit4] > at org.apache.lucene.util.TestRuleNoStaticHooksShadowing$1.evaluate(TestRuleNoStaticHooksShadowing.java:52)
[junit4] > at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:36)
[junit4] > at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4] > at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:56)
[junit4] > at com.carrotsearch.randomizedtesting.RandomizedRunner.runSuite(RandomizedRunner.java:605)
[junit4] > at com.carrotsearch.randomizedtesting.RandomizedRunner.access$400(RandomizedRunner.java:132)
[junit4] > at com.carrotsearch.randomizedtesting.RandomizedRunner$2.run(RandomizedRunner.java:551)
[junit4] >
[junit4] Completed on J1 in 148.37s, 1 test, 1 failure <<< FAILURES!
[...truncated 132 lines...]
[...truncated 11908 lines...]
[...truncated 11908 lines...]
[...truncated 11908 lines...]
[...truncated 11908 lines...]
[...truncated 11908 lines...]