You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2015/01/12 06:30:56 UTC
[JENKINS] Lucene-Solr-5.x-Linux (64bit/jdk1.8.0_40-ea-b20) - Build
# 11417 - Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Linux/11417/
Java: 64bit/jdk1.8.0_40-ea-b20 -XX:-UseCompressedOops -XX:+UseParallelGC
1 tests failed.
FAILED: org.apache.solr.util.SimplePostToolTest.testTypeSupported
Error Message:
Stack Trace:
java.lang.AssertionError
at __randomizedtesting.SeedInfo.seed([44D9DA56562D6BDC:D06DECB54112CAB3]:0)
at org.junit.Assert.fail(Assert.java:92)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertTrue(Assert.java:54)
at org.apache.solr.util.SimplePostToolTest.testTypeSupported(SimplePostToolTest.java:116)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:497)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
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.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 9606 lines...]
[junit4] Suite: org.apache.solr.util.SimplePostToolTest
[junit4] 2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.SimplePostToolTest 44D9DA56562D6BDC-001/init-core-data-001
[junit4] 2> 749339 T3571 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (false) and clientAuth (true)
[junit4] 2> 749341 T3571 oas.SolrTestCaseJ4.setUp ###Starting testAppendUrlPath
[junit4] 2> 749353 T3571 oas.SolrTestCaseJ4.tearDown ###Ending testAppendUrlPath
[junit4] 2> 749357 T3571 oas.SolrTestCaseJ4.setUp ###Starting testGuessType
[junit4] 2> 749359 T3571 oas.SolrTestCaseJ4.tearDown ###Ending testGuessType
[junit4] 2> 749364 T3571 oas.SolrTestCaseJ4.setUp ###Starting testNormalizeUrlEnding
[junit4] 2> 749365 T3571 oas.SolrTestCaseJ4.tearDown ###Ending testNormalizeUrlEnding
[junit4] 2> 749370 T3571 oas.SolrTestCaseJ4.setUp ###Starting testAppendParam
[junit4] 2> 749371 T3571 oas.SolrTestCaseJ4.tearDown ###Ending testAppendParam
[junit4] 2> 749375 T3571 oas.SolrTestCaseJ4.setUp ###Starting testComputeFullUrl
[junit4] 2> 749377 T3571 oas.SolrTestCaseJ4.tearDown ###Ending testComputeFullUrl
[junit4] 2> 749381 T3571 oas.SolrTestCaseJ4.setUp ###Starting testDoFilesMode
[junit4] 1> Indexing directory /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/exampledocs (2 files, depth=0)
[junit4] 1> POSTing file example.html (text/html) to [base]/extract
[junit4] 1> POSTing file example.txt (text/plain) to [base]/extract
[junit4] 2> 749385 T3571 oas.SolrTestCaseJ4.tearDown ###Ending testDoFilesMode
[junit4] 2> 749389 T3571 oas.SolrTestCaseJ4.setUp ###Starting testRobotsExclusion
[junit4] 2> 749391 T3571 oas.SolrTestCaseJ4.tearDown ###Ending testRobotsExclusion
[junit4] 2> 749395 T3571 oas.SolrTestCaseJ4.setUp ###Starting testIsOn
[junit4] 2> 749397 T3571 oas.SolrTestCaseJ4.tearDown ###Ending testIsOn
[junit4] 2> 749400 T3571 oas.SolrTestCaseJ4.setUp ###Starting testTypeSupported
[junit4] 2> 749402 T3571 oas.SolrTestCaseJ4.tearDown ###Ending testTypeSupported
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SimplePostToolTest -Dtests.method=testTypeSupported -Dtests.seed=44D9DA56562D6BDC -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ar_DZ -Dtests.timezone=America/Kentucky/Louisville -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] FAILURE 0.01s J1 | SimplePostToolTest.testTypeSupported <<<
[junit4] > Throwable #1: java.lang.AssertionError
[junit4] > at __randomizedtesting.SeedInfo.seed([44D9DA56562D6BDC:D06DECB54112CAB3]:0)
[junit4] > at org.apache.solr.util.SimplePostToolTest.testTypeSupported(SimplePostToolTest.java:116)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 749413 T3571 oas.SolrTestCaseJ4.setUp ###Starting testParseArgsAndInit
[junit4] 2> 749415 T3571 oas.SolrTestCaseJ4.tearDown ###Ending testParseArgsAndInit
[junit4] 2> 749419 T3571 oas.SolrTestCaseJ4.setUp ###Starting testDoWebMode
[junit4] 1> Entering crawl at level 0 (1 links total, 1 new)
[junit4] 1> POSTed web resource http://[ff01::114] (depth: 0)
[junit4] 1> Entering crawl at level 1 (2 links total, 2 new)
[junit4] 1> POSTed web resource http://[ff01::114]/page1 (depth: 1)
[junit4] 1> POSTed web resource http://[ff01::114]/page2 (depth: 1)
[junit4] 1> Entering crawl at level 2 (2 links total, 2 new)
[junit4] 1> POSTed web resource http://[ff01::114]/page1/foo (depth: 2)
[junit4] 2> SimplePostTool: WARNING: The URL http://[ff01::114]/disallowed returned a HTTP result status of 403
[junit4] 1> Entering crawl at level 3 (1 links total, 1 new)
[junit4] 1> POSTed web resource http://[ff01::114]/page1/foo/bar (depth: 3)
[junit4] 1> Entering crawl at level 0 (1 links total, 1 new)
[junit4] 1> POSTed web resource http://[ff01::114] (depth: 0)
[junit4] 1> Entering crawl at level 1 (2 links total, 2 new)
[junit4] 1> POSTed web resource http://[ff01::114]/page1 (depth: 1)
[junit4] 1> POSTed web resource http://[ff01::114]/page2 (depth: 1)
[junit4] 1> Entering crawl at level 0 (1 links total, 1 new)
[junit4] 1> POSTed web resource http://[ff01::114] (depth: 0)
[junit4] 1> Entering crawl at level 1 (2 links total, 2 new)
[junit4] 1> POSTed web resource http://[ff01::114]/page1 (depth: 1)
[junit4] 1> POSTed web resource http://[ff01::114]/page2 (depth: 1)
[junit4] 1> Entering crawl at level 2 (2 links total, 2 new)
[junit4] 1> POSTed web resource http://[ff01::114]/page1/foo (depth: 2)
[junit4] 1> POSTed web resource http://[ff01::114]/disallowed (depth: 2)
[junit4] 1> Entering crawl at level 3 (1 links total, 1 new)
[junit4] 1> POSTed web resource http://[ff01::114]/page1/foo/bar (depth: 3)
[junit4] 2> 749430 T3571 oas.SolrTestCaseJ4.tearDown ###Ending testDoWebMode
[junit4] 2> 749432 T3571 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.SimplePostToolTest 44D9DA56562D6BDC-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene50): {}, docValues:{}, sim=DefaultSimilarity, locale=ar_DZ, timezone=America/Kentucky/Louisville
[junit4] 2> NOTE: Linux 3.13.0-43-generic amd64/Oracle Corporation 1.8.0_40-ea (64-bit)/cpus=8,threads=1,free=135598952,total=381681664
[junit4] 2> NOTE: All tests run in this JVM: [TestSolrQueryParserResource, TestConfigReload, SignatureUpdateProcessorFactoryTest, TestMissingGroups, CurrencyFieldXmlFileTest, TestSchemaManager, FileBasedSpellCheckerTest, ExternalCollectionsTest, TestConfigSets, PreAnalyzedUpdateProcessorTest, FacetPivotSmallTest, TestPostingsSolrHighlighter, TestDefaultSearchFieldResource, CoreAdminCreateDiscoverTest, CursorPagingTest, CollectionsAPIDistributedZkTest, TestFoldingMultitermQuery, LeaderElectionIntegrationTest, TestSchemaSimilarityResource, TestComplexPhraseQParserPlugin, TestClassNameShortening, DistributedFacetPivotLongTailTest, TestExactSharedStatsCache, TestSolr4Spatial, DistributedExpandComponentTest, VMParamsZkACLAndCredentialsProvidersTest, QueryParsingTest, SpellCheckComponentTest, ResponseLogComponentTest, HdfsLockFactoryTest, TestJoin, TestTrie, TestPHPSerializedResponseWriter, ChaosMonkeySafeLeaderTest, TestReRankQParserPlugin, TestLRUStatsCache, TestSolrConfigHandlerCloud, TestLeaderElectionZkExpiry, SampleTest, DisMaxRequestHandlerTest, TestJmxMonitoredMap, TestObjectReleaseTracker, DistributedIntervalFacetingTest, ChaosMonkeyNothingIsSafeTest, HdfsRecoveryZkTest, ShardSplitTest, TestCollectionAPI, TestFieldTypeCollectionResource, TestRequestStatusCollectionAPI, IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestDefaultStatsCache, BadCopyFieldTest, TimeZoneUtilsTest, TestRemoteStreaming, TestElisionMultitermQuery, TestPerFieldSimilarity, TestDynamicFieldResource, StandardRequestHandlerTest, BinaryUpdateRequestHandlerTest, SimplePostToolTest]
[junit4] Completed on J1 in 0.11s, 11 tests, 1 failure <<< FAILURES!
[...truncated 906 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:529: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:477: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:61: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/extra-targets.xml:39: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build.xml:190: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/common-build.xml:508: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:1363: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:970: There were test failures: 460 suites, 1871 tests, 1 failure, 47 ignored (22 assumptions)
Total time: 67 minutes 17 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 64bit/jdk1.8.0_40-ea-b20 -XX:-UseCompressedOops -XX:+UseParallelGC
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
[JENKINS] Lucene-Solr-5.x-Linux (32bit/jdk1.8.0_40-ea-b20) - Build
# 11419 - Still Failing!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Linux/11419/
Java: 32bit/jdk1.8.0_40-ea-b20 -client -XX:+UseSerialGC
1 tests failed.
FAILED: org.apache.solr.util.SimplePostToolTest.testTypeSupported
Error Message:
Stack Trace:
java.lang.AssertionError
at __randomizedtesting.SeedInfo.seed([10BB7BA74A19479C:840F4D445D26E6F3]:0)
at org.junit.Assert.fail(Assert.java:92)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertTrue(Assert.java:54)
at org.apache.solr.util.SimplePostToolTest.testTypeSupported(SimplePostToolTest.java:116)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:497)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
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.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 9182 lines...]
[junit4] Suite: org.apache.solr.util.SimplePostToolTest
[junit4] 2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.SimplePostToolTest 10BB7BA74A19479C-001/init-core-data-001
[junit4] 2> 476447 T620 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (false) and clientAuth (false)
[junit4] 2> 476450 T620 oas.SolrTestCaseJ4.setUp ###Starting testParseArgsAndInit
[junit4] 2> 476460 T620 oas.SolrTestCaseJ4.tearDown ###Ending testParseArgsAndInit
[junit4] 2> 476464 T620 oas.SolrTestCaseJ4.setUp ###Starting testComputeFullUrl
[junit4] 2> 476466 T620 oas.SolrTestCaseJ4.tearDown ###Ending testComputeFullUrl
[junit4] 2> 476471 T620 oas.SolrTestCaseJ4.setUp ###Starting testGuessType
[junit4] 2> 476473 T620 oas.SolrTestCaseJ4.tearDown ###Ending testGuessType
[junit4] 2> 476477 T620 oas.SolrTestCaseJ4.setUp ###Starting testRobotsExclusion
[junit4] 2> 476478 T620 oas.SolrTestCaseJ4.tearDown ###Ending testRobotsExclusion
[junit4] 2> 476483 T620 oas.SolrTestCaseJ4.setUp ###Starting testAppendParam
[junit4] 2> 476485 T620 oas.SolrTestCaseJ4.tearDown ###Ending testAppendParam
[junit4] 2> 476489 T620 oas.SolrTestCaseJ4.setUp ###Starting testNormalizeUrlEnding
[junit4] 2> 476490 T620 oas.SolrTestCaseJ4.tearDown ###Ending testNormalizeUrlEnding
[junit4] 2> 476494 T620 oas.SolrTestCaseJ4.setUp ###Starting testDoFilesMode
[junit4] 1> Indexing directory /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/exampledocs (2 files, depth=0)
[junit4] 1> POSTing file example.html (text/html) to [base]/extract
[junit4] 1> POSTing file example.txt (text/plain) to [base]/extract
[junit4] 2> 476499 T620 oas.SolrTestCaseJ4.tearDown ###Ending testDoFilesMode
[junit4] 2> 476503 T620 oas.SolrTestCaseJ4.setUp ###Starting testAppendUrlPath
[junit4] 2> 476506 T620 oas.SolrTestCaseJ4.tearDown ###Ending testAppendUrlPath
[junit4] 2> 476510 T620 oas.SolrTestCaseJ4.setUp ###Starting testTypeSupported
[junit4] 2> 476512 T620 oas.SolrTestCaseJ4.tearDown ###Ending testTypeSupported
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SimplePostToolTest -Dtests.method=testTypeSupported -Dtests.seed=10BB7BA74A19479C -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=tr -Dtests.timezone=America/Indiana/Marengo -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] FAILURE 0.03s J1 | SimplePostToolTest.testTypeSupported <<<
[junit4] > Throwable #1: java.lang.AssertionError
[junit4] > at __randomizedtesting.SeedInfo.seed([10BB7BA74A19479C:840F4D445D26E6F3]:0)
[junit4] > at org.apache.solr.util.SimplePostToolTest.testTypeSupported(SimplePostToolTest.java:116)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 476543 T620 oas.SolrTestCaseJ4.setUp ###Starting testDoWebMode
[junit4] 1> Entering crawl at level 0 (1 links total, 1 new)
[junit4] 1> POSTed web resource http://[ff01::114] (depth: 0)
[junit4] 1> Entering crawl at level 1 (2 links total, 2 new)
[junit4] 1> POSTed web resource http://[ff01::114]/page1 (depth: 1)
[junit4] 1> POSTed web resource http://[ff01::114]/page2 (depth: 1)
[junit4] 1> Entering crawl at level 2 (2 links total, 2 new)
[junit4] 1> POSTed web resource http://[ff01::114]/page1/foo (depth: 2)
[junit4] 2> SimplePostTool: WARNING: The URL http://[ff01::114]/disallowed returned a HTTP result status of 403
[junit4] 1> Entering crawl at level 3 (1 links total, 1 new)
[junit4] 1> POSTed web resource http://[ff01::114]/page1/foo/bar (depth: 3)
[junit4] 1> Entering crawl at level 0 (1 links total, 1 new)
[junit4] 1> POSTed web resource http://[ff01::114] (depth: 0)
[junit4] 1> Entering crawl at level 1 (2 links total, 2 new)
[junit4] 1> POSTed web resource http://[ff01::114]/page1 (depth: 1)
[junit4] 1> POSTed web resource http://[ff01::114]/page2 (depth: 1)
[junit4] 1> Entering crawl at level 0 (1 links total, 1 new)
[junit4] 1> POSTed web resource http://[ff01::114] (depth: 0)
[junit4] 1> Entering crawl at level 1 (2 links total, 2 new)
[junit4] 1> POSTed web resource http://[ff01::114]/page1 (depth: 1)
[junit4] 1> POSTed web resource http://[ff01::114]/page2 (depth: 1)
[junit4] 1> Entering crawl at level 2 (2 links total, 2 new)
[junit4] 1> POSTed web resource http://[ff01::114]/page1/foo (depth: 2)
[junit4] 1> POSTed web resource http://[ff01::114]/disallowed (depth: 2)
[junit4] 1> Entering crawl at level 3 (1 links total, 1 new)
[junit4] 1> POSTed web resource http://[ff01::114]/page1/foo/bar (depth: 3)
[junit4] 2> 476622 T620 oas.SolrTestCaseJ4.tearDown ###Ending testDoWebMode
[junit4] 2> 476625 T620 oas.SolrTestCaseJ4.setUp ###Starting testIsOn
[junit4] 2> 476627 T620 oas.SolrTestCaseJ4.tearDown ###Ending testIsOn
[junit4] 2> 476629 T620 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.SimplePostToolTest 10BB7BA74A19479C-001
[junit4] 2> NOTE: test params are: codec=Lucene50, sim=DefaultSimilarity, locale=tr, timezone=America/Indiana/Marengo
[junit4] 2> NOTE: Linux 3.13.0-43-generic i386/Oracle Corporation 1.8.0_40-ea (32-bit)/cpus=8,threads=1,free=32015728,total=91226112
[junit4] 2> NOTE: All tests run in this JVM: [DistributedFacetPivotSmallTest, FacetPivotSmallTest, TestFoldingMultitermQuery, TestCollectionAPI, UpdateRequestProcessorFactoryTest, BadComponentTest, TimeZoneUtilsTest, PreAnalyzedUpdateProcessorTest, TestCollapseQParserPlugin, TestUtils, ChaosMonkeyNothingIsSafeTest, DistanceUnitsTest, BadIndexSchemaTest, TestRecovery, RAMDirectoryFactoryTest, CursorPagingTest, SuggestComponentTest, TermVectorComponentTest, TestLMJelinekMercerSimilarityFactory, TestRandomFaceting, TestDynamicFieldResource, TestRawResponseWriter, TestSimpleQParserPlugin, TestValueSourceCache, AutoCommitTest, SimplePostToolTest]
[junit4] Completed on J1 in 0.22s, 11 tests, 1 failure <<< FAILURES!
[...truncated 1176 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:529: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:477: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:61: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/extra-targets.xml:39: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build.xml:190: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/common-build.xml:508: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:1363: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:970: There were test failures: 460 suites, 1871 tests, 1 failure, 47 ignored (22 assumptions)
Total time: 79 minutes 3 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 32bit/jdk1.8.0_40-ea-b20 -client -XX:+UseSerialGC
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
[JENKINS] Lucene-Solr-5.x-Linux (32bit/jdk1.7.0_72) - Build # 11418
- Still Failing!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Linux/11418/
Java: 32bit/jdk1.7.0_72 -server -XX:+UseParallelGC
3 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.DistribCursorPagingTest
Error Message:
Some resources were not closed, shutdown, or released.
Stack Trace:
java.lang.AssertionError: Some resources were not closed, shutdown, or released.
at __randomizedtesting.SeedInfo.seed([5BF726B50F116C88]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:189)
at sun.reflect.GeneratedMethodAccessor28.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:790)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at java.lang.Thread.run(Thread.java:745)
FAILED: org.apache.solr.handler.TestSolrConfigHandlerCloud.testDistribSearch
Error Message:
Could not get expected value P val for path [response, params, y, p] full output { "responseHeader":{ "status":0, "QTime":0}, "response":{ "znodeVersion":0, "params":{"x":{ "a":"A val", "b":"B val", "":{"v":0}}}}}
Stack Trace:
java.lang.AssertionError: Could not get expected value P val for path [response, params, y, p] full output {
"responseHeader":{
"status":0,
"QTime":0},
"response":{
"znodeVersion":0,
"params":{"x":{
"a":"A val",
"b":"B val",
"":{"v":0}}}}}
at __randomizedtesting.SeedInfo.seed([5BF726B50F116C88:DA11A8AD784E0CB4]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.apache.solr.core.TestSolrConfigHandler.testForResponseElement(TestSolrConfigHandler.java:259)
at org.apache.solr.handler.TestSolrConfigHandlerCloud.testReqParams(TestSolrConfigHandlerCloud.java:261)
at org.apache.solr.handler.TestSolrConfigHandlerCloud.doTest(TestSolrConfigHandlerCloud.java:70)
at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:868)
at sun.reflect.GeneratedMethodAccessor39.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
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.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at java.lang.Thread.run(Thread.java:745)
FAILED: org.apache.solr.util.SimplePostToolTest.testTypeSupported
Error Message:
Stack Trace:
java.lang.AssertionError
at __randomizedtesting.SeedInfo.seed([5BF726B50F116C88:CF431056182ECDE7]:0)
at org.junit.Assert.fail(Assert.java:92)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertTrue(Assert.java:54)
at org.apache.solr.util.SimplePostToolTest.testTypeSupported(SimplePostToolTest.java:116)
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:606)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
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.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 9322 lines...]
[junit4] Suite: org.apache.solr.cloud.DistribCursorPagingTest
[junit4] 2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/init-core-data-001
[junit4] 2> 458119 T2708 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (true) and clientAuth (false)
[junit4] 2> 458119 T2708 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /
[junit4] 2> 458122 T2708 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
[junit4] 2> 458123 T2708 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 1> client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 458123 T2709 oasc.ZkTestServer$ZKServerMain.runFromConfig Starting server
[junit4] 2> 458223 T2708 oasc.ZkTestServer.run start zk server on port:38958
[junit4] 2> 458224 T2708 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
[junit4] 2> 458225 T2708 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 458228 T2716 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@582c36 name:ZooKeeperConnection Watcher:127.0.0.1:38958 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 458229 T2708 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 458230 T2708 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
[junit4] 2> 458230 T2708 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 458236 T2708 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
[junit4] 2> 458237 T2708 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 458238 T2719 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1b315fd name:ZooKeeperConnection Watcher:127.0.0.1:38958/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 458239 T2708 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 458240 T2708 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
[junit4] 2> 458240 T2708 oascc.SolrZkClient.makePath makePath: /collections/collection1
[junit4] 2> 458244 T2708 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards
[junit4] 2> 458248 T2708 oascc.SolrZkClient.makePath makePath: /collections/control_collection
[junit4] 2> 458252 T2708 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards
[junit4] 2> 458256 T2708 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig-deeppaging.xml to /configs/conf1/solrconfig.xml
[junit4] 2> 458256 T2708 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4] 2> 458262 T2708 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema-sorts.xml to /configs/conf1/schema.xml
[junit4] 2> 458263 T2708 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml
[junit4] 2> 458267 T2708 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 458267 T2708 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 458271 T2708 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
[junit4] 2> 458272 T2708 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt
[junit4] 2> 458275 T2708 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
[junit4] 2> 458276 T2708 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt
[junit4] 2> 458280 T2708 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
[junit4] 2> 458280 T2708 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml
[junit4] 2> 458284 T2708 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml
[junit4] 2> 458285 T2708 oascc.SolrZkClient.makePath makePath: /configs/conf1/enumsConfig.xml
[junit4] 2> 458289 T2708 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
[junit4] 2> 458289 T2708 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json
[junit4] 2> 458293 T2708 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 458294 T2708 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 458298 T2708 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
[junit4] 2> 458298 T2708 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt
[junit4] 2> 458302 T2708 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
[junit4] 2> 458303 T2708 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt
[junit4] 2> 458309 T2708 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
[junit4] 2> 458310 T2708 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 458312 T2722 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@5cb584 name:ZooKeeperConnection Watcher:127.0.0.1:38958/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 458312 T2708 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 458313 T2708 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
[junit4] 2> 458551 T2708 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 458683 T2708 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2]
[junit4] 2> 458686 T2708 oejs.AbstractConnector.doStart Started SslSelectChannelConnector@127.0.0.1:33115
[junit4] 2> 458688 T2708 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@9ed5d6
[junit4] 2> 458689 T2708 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 458689 T2708 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-002
[junit4] 2> 458689 T2708 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-002/'
[junit4] 2> 458699 T2708 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-002/solr.xml
[junit4] 2> 458734 T2708 oasc.CoreContainer.<init> New CoreContainer 4468161
[junit4] 2> 458735 T2708 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-002/]
[junit4] 2> 458735 T2708 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 458735 T2708 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to:
[junit4] 2> 458736 T2708 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 458736 T2708 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 458736 T2708 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000
[junit4] 2> 458736 T2708 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 458737 T2708 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 458737 T2708 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 458737 T2708 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 458737 T2708 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 458739 T2708 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 458740 T2708 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 458741 T2708 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 458741 T2708 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 458741 T2708 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:38958/solr
[junit4] 2> 458741 T2708 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 458742 T2708 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
[junit4] 2> 458742 T2708 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 458744 T2734 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@31c0ba name:ZooKeeperConnection Watcher:127.0.0.1:38958 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 458744 T2708 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 458745 T2708 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
[junit4] 2> 458747 T2708 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 458748 T2737 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@23bca7 name:ZooKeeperConnection Watcher:127.0.0.1:38958/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 458748 T2708 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 458750 T2708 oascc.SolrZkClient.makePath makePath: /overseer/queue
[junit4] 2> 458755 T2708 oascc.SolrZkClient.makePath makePath: /overseer/collection-queue-work
[junit4] 2> 458758 T2708 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-running
[junit4] 2> 458762 T2708 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-completed
[junit4] 2> 458765 T2708 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-failure
[junit4] 2> 458770 T2708 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4] 2> 458772 T2708 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:33115_
[junit4] 2> 458773 T2708 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:33115_
[junit4] 2> 458777 T2708 oascc.SolrZkClient.makePath makePath: /overseer_elect
[junit4] 2> 458779 T2708 oascc.SolrZkClient.makePath makePath: /overseer_elect/election
[junit4] 2> 458782 T2708 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 458784 T2708 oasc.OverseerElectionContext.runLeaderProcess I am going to be the leader 127.0.0.1:33115_
[junit4] 2> 458785 T2708 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4] 2> 458788 T2708 oasc.Overseer.start Overseer (id=93129743307636740-127.0.0.1:33115_-n_0000000000) starting
[junit4] 2> 458791 T2708 oascc.SolrZkClient.makePath makePath: /overseer/queue-work
[junit4] 2> 458804 T2708 oasc.OverseerAutoReplicaFailoverThread.<init> Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=30000 autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 458805 T2739 oasc.OverseerCollectionProcessor.run Process current queue of collection creations
[junit4] 2> 458806 T2708 oascc.SolrZkClient.makePath makePath: /clusterstate.json
[junit4] 2> 458809 T2708 oascc.SolrZkClient.makePath makePath: /aliases.json
[junit4] 2> 458811 T2708 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 458817 T2738 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4] 2> 458821 T2741 oasc.ZkController.publish publishing core=collection1 state=down collection=control_collection
[junit4] 2> 458821 T2741 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4] 2> 458822 T2737 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 458822 T2741 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 458827 T2738 oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 0, message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "numShards":"1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "shard":null,
[junit4] 2> "node_name":"127.0.0.1:33115_",
[junit4] 2> "base_url":"https://127.0.0.1:33115",
[junit4] 2> "state":"down",
[junit4] 2> "operation":"state",
[junit4] 2> "roles":null} current state version: 0
[junit4] 2> 458829 T2738 oasco.ReplicaMutator.updateState Update state numShards=1 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "numShards":"1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "shard":null,
[junit4] 2> "node_name":"127.0.0.1:33115_",
[junit4] 2> "base_url":"https://127.0.0.1:33115",
[junit4] 2> "state":"down",
[junit4] 2> "operation":"state",
[junit4] 2> "roles":null}
[junit4] 2> 458829 T2738 oasco.ClusterStateMutator.createCollection building a new cName: control_collection
[junit4] 2> 458829 T2738 oasco.ReplicaMutator.updateState Assigning new node to shard shard=shard1
[junit4] 2> 458831 T2737 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 459823 T2741 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1
[junit4] 2> 459824 T2741 oasc.ZkController.createCollectionZkNode Check for collection zkNode:control_collection
[junit4] 2> 459825 T2741 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 459825 T2741 oascc.ZkStateReader.readConfigName Load collection config from:/collections/control_collection
[junit4] 2> 459826 T2741 oascc.ZkStateReader.readConfigName path=/collections/control_collection configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 459827 T2741 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-002/collection1/'
[junit4] 2> 459828 T2741 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest%205BF726B50F116C88-001/tempDir-002/collection1/lib/.svn/' to classloader
[junit4] 2> 459828 T2741 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest%205BF726B50F116C88-001/tempDir-002/collection1/lib/classes/' to classloader
[junit4] 2> 459829 T2741 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest%205BF726B50F116C88-001/tempDir-002/collection1/lib/README' to classloader
[junit4] 2> 459849 T2741 oasc.ZkController.watchZKConfDir watch zkdir /configs/conf1
[junit4] 2> 459851 T2741 oasc.Config.<init> loaded config solrconfig.xml with version 0
[junit4] 2> 459857 T2741 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
[junit4] 2> 459867 T2741 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0
[junit4] 2> 459896 T2741 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 459898 T2741 oass.IndexSchema.readSchema Reading Solr Schema from /configs/conf1/schema.xml
[junit4] 2> 459902 T2741 oass.IndexSchema.readSchema [collection1] Schema name=sortable
[junit4] 2> 460300 T2741 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 460301 T2741 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from collection control_collection
[junit4] 2> 460301 T2741 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 460301 T2741 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-002/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-001/control/data/
[junit4] 2> 460301 T2741 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 460302 T2741 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-001/control/data
[junit4] 2> 460302 T2741 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-001/control/data/index/
[junit4] 2> 460302 T2741 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-001/control/data/index' doesn't exist. Creating new index...
[junit4] 2> 460303 T2741 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-001/control/data/index
[junit4] 2> 460303 T2741 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=48, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5160384261868395]
[junit4] 2> 460304 T2741 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@12882d6 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@a5c4b6),segFN=segments_1,generation=1}
[junit4] 2> 460304 T2741 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 460304 T2741 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 460305 T2741 oasc.RequestHandlers.initHandlersFromConfig created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 460305 T2741 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 460305 T2741 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 460305 T2741 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 460305 T2741 oasc.RequestHandlers.initHandlersFromConfig created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 460305 T2741 oasc.RequestHandlers.initHandlersFromConfig created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 460306 T2741 oasc.RequestHandlers.initHandlersFromConfig created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 460306 T2741 oasc.RequestHandlers.initHandlersFromConfig created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 460306 T2741 oasc.RequestHandlers.initHandlersFromConfig created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 460306 T2741 oasc.RequestHandlers.initHandlersFromConfig created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 460306 T2741 oasc.RequestHandlers.initHandlersFromConfig created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 460307 T2741 oasc.RequestHandlers.initHandlersFromConfig created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 460307 T2741 oasc.RequestHandlers.initHandlersFromConfig created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 460307 T2741 oasc.RequestHandlers.initHandlersFromConfig created /admin/properties: org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 460307 T2741 oasc.RequestHandlers.initHandlersFromConfig created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 460307 T2741 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: org.apache.solr.handler.admin.ShowFileRequestHandler
[junit4] 2> 460308 T2741 oasc.RequestHandlers.initHandlersFromConfig created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 460308 T2741 oasc.RequestHandlers.initHandlersFromConfig created /select: solr.SearchHandler
[junit4] 2> 460310 T2741 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 460311 T2741 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 460312 T2741 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 460313 T2741 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 460314 T2741 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 460315 T2741 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 460315 T2741 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 460316 T2741 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=41, maxMergeAtOnceExplicit=29, maxMergedSegmentMB=98.9736328125, floorSegmentMB=1.4140625, forceMergeDeletesPctAllowed=2.6684977050046887, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8196520713965341
[junit4] 2> 460316 T2741 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@12882d6 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@a5c4b6),segFN=segments_1,generation=1}
[junit4] 2> 460316 T2741 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 460317 T2741 oass.SolrIndexSearcher.<init> Opening Searcher@1671c4c[collection1] main
[junit4] 2> 460317 T2741 oascc.ZkStateReader.readConfigName Load collection config from:/collections/control_collection
[junit4] 2> 460318 T2741 oascc.ZkStateReader.readConfigName path=/collections/control_collection configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 460318 T2741 oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1
[junit4] 2> 460319 T2741 oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 460319 T2741 oasr.RestManager.init Initializing RestManager with initArgs: {}
[junit4] 2> 460319 T2741 oasr.ManagedResourceStorage.load Reading _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 460320 T2741 oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found for znode /configs/conf1/_rest_managed.json
[junit4] 2> 460321 T2741 oasr.ManagedResourceStorage.load Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 460321 T2741 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 460321 T2741 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 460321 T2742 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1671c4c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 460321 T2741 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 460322 T2745 oasc.ZkController.register Register replica - core:collection1 address:https://127.0.0.1:33115 collection:control_collection shard:shard1
[junit4] 2> 460323 T2708 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0
[junit4] 2> 460324 T2708 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 460324 T2745 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leader_elect/shard1/election
[junit4] 2> 460328 T2745 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard1
[junit4] 2> 460328 T2708 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
[junit4] 2> 460328 T2708 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 460328 T2737 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 460329 T2745 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4] 2> 460329 T2745 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4] 2> ASYNC NEW_CORE C1670 name=collection1 org.apache.solr.core.SolrCore@1752fec url=https://127.0.0.1:33115/collection1 node=127.0.0.1:33115_ C1670_STATE=coll:control_collection core:collection1 props:{core=collection1, node_name=127.0.0.1:33115_, base_url=https://127.0.0.1:33115, state=down}
[junit4] 2> 460329 T2745 C1670 P33115 oasc.SyncStrategy.sync Sync replicas to https://127.0.0.1:33115/collection1/
[junit4] 2> 460329 T2745 C1670 P33115 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4] 2> 460329 T2748 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@c33920 name:ZooKeeperConnection Watcher:127.0.0.1:38958/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 460329 T2738 oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection"} current state version: 1
[junit4] 2> 460329 T2745 C1670 P33115 oasc.SyncStrategy.syncToMe https://127.0.0.1:33115/collection1/ has no replicas
[junit4] 2> 460330 T2708 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 460330 T2745 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: https://127.0.0.1:33115/collection1/ shard1
[junit4] 2> 460330 T2745 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leaders/shard1
[junit4] 2> 460330 T2708 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
[junit4] 2> 460331 T2708 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 460332 T2708 oasc.ChaosMonkey.monkeyLog monkey: init - expire sessions:false cause connection loss:false
[junit4] 2> 460333 T2737 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 460333 T2708 oasc.AbstractFullDistribZkTestBase.createJettys Creating collection1 with stateFormat=2
[junit4] 2> 460333 T2708 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
[junit4] 2> 460333 T2738 oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "base_url":"https://127.0.0.1:33115",
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 1
[junit4] 2> 460334 T2708 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 460334 T2737 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 460334 T2751 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@b69ca8 name:ZooKeeperConnection Watcher:127.0.0.1:38958/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 460334 T2748 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 460335 T2708 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 460336 T2708 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
[junit4] 2> 460338 T2738 oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"create",
[junit4] 2> "name":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "stateFormat":2} current state version: 2
[junit4] 2> 460338 T2738 oasco.ClusterStateMutator.createCollection building a new cName: collection1
[junit4] 2> 460339 T2752 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 460339 T2738 oasco.ZkStateWriter.writePendingUpdates going to create_collection /collections/collection1/state.json
[junit4] 2> 460340 T2748 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 460383 T2745 oasc.ZkController.register We are https://127.0.0.1:33115/collection1/ and leader is https://127.0.0.1:33115/collection1/
[junit4] 2> 460383 T2745 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=https://127.0.0.1:33115
[junit4] 2> 460383 T2745 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4] 2> 460383 T2745 oasc.ZkController.publish publishing core=collection1 state=active collection=control_collection
[junit4] 2> 460384 T2745 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4] 2> 460385 T2737 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 460386 T2738 oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "node_name":"127.0.0.1:33115_",
[junit4] 2> "base_url":"https://127.0.0.1:33115",
[junit4] 2> "state":"active",
[junit4] 2> "operation":"state",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null} current state version: 3
[junit4] 2> 460387 T2738 oasco.ReplicaMutator.updateState Update state numShards=2 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "node_name":"127.0.0.1:33115_",
[junit4] 2> "base_url":"https://127.0.0.1:33115",
[junit4] 2> "state":"active",
[junit4] 2> "operation":"state",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null}
[junit4] 2> 460490 T2748 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 460490 T2737 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 460552 T2708 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 1
[junit4] 2> 460552 T2708 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 460556 T2708 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2]
[junit4] 2> 460558 T2708 oejs.AbstractConnector.doStart Started SslSelectChannelConnector@127.0.0.1:36453
[junit4] 2> 460560 T2708 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@9ed5d6
[junit4] 2> 460560 T2708 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 460560 T2708 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-003
[junit4] 2> 460561 T2708 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-003/'
[junit4] 2> 460571 T2708 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-003/solr.xml
[junit4] 2> 460592 T2708 oasc.CoreContainer.<init> New CoreContainer 4569133
[junit4] 2> 460592 T2708 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-003/]
[junit4] 2> 460593 T2708 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 460593 T2708 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to:
[junit4] 2> 460593 T2708 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 460593 T2708 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 460594 T2708 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000
[junit4] 2> 460594 T2708 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 460594 T2708 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 460594 T2708 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 460595 T2708 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 460595 T2708 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 460596 T2708 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 460598 T2708 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 460598 T2708 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 460598 T2708 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 460599 T2708 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:38958/solr
[junit4] 2> 460599 T2708 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 460599 T2708 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
[junit4] 2> 460600 T2708 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 460601 T2764 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1d360eb name:ZooKeeperConnection Watcher:127.0.0.1:38958 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 460601 T2708 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 460602 T2708 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
[junit4] 2> 460604 T2708 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 460605 T2767 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@9d9660 name:ZooKeeperConnection Watcher:127.0.0.1:38958/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 460605 T2708 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 460610 T2708 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 461613 T2708 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:36453_
[junit4] 2> 461615 T2708 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:36453_
[junit4] 2> 461622 T2708 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 461631 T2768 oasc.ZkController.publish publishing core=collection1 state=down collection=collection1
[junit4] 2> 461631 T2768 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4] 2> 461633 T2737 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 461634 T2768 oasc.ZkController.preRegister Registering watch for external collection collection1
[junit4] 2> 461635 T2768 oascc.ZkStateReader.addZkWatch addZkWatch collection1
[junit4] 2> 461635 T2738 oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard":null,
[junit4] 2> "node_name":"127.0.0.1:36453_",
[junit4] 2> "base_url":"https://127.0.0.1:36453",
[junit4] 2> "state":"down",
[junit4] 2> "operation":"state",
[junit4] 2> "roles":null} current state version: 4
[junit4] 2> 461636 T2768 oascc.ZkStateReader.addZkWatch Updating collection state at /collections/collection1/state.json from ZooKeeper...
[junit4] 2> 461637 T2738 oasco.ReplicaMutator.updateState Update state numShards=2 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard":null,
[junit4] 2> "node_name":"127.0.0.1:36453_",
[junit4] 2> "base_url":"https://127.0.0.1:36453",
[junit4] 2> "state":"down",
[junit4] 2> "operation":"state",
[junit4] 2> "roles":null}
[junit4] 2> 461637 T2738 oasco.ReplicaMutator.updateState Collection already exists with numShards=2
[junit4] 2> 461637 T2768 oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to ver 0
[junit4] 2> 461637 T2738 oasco.ReplicaMutator.updateState Assigning new node to shard shard=shard1
[junit4] 2> 461638 T2768 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 461743 T2738 oasco.ZkStateWriter.writePendingUpdates going to update_collection /collections/collection1/state.json version: 0
[junit4] 2> 461744 T2767 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 461745 T2767 oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to ver 1
[junit4] 2> 462638 T2768 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1
[junit4] 2> 462639 T2768 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4] 2> 462640 T2768 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 462640 T2768 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1
[junit4] 2> 462642 T2768 oascc.ZkStateReader.readConfigName path=/collections/collection1 configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 462642 T2768 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-003/collection1/'
[junit4] 2> 462643 T2768 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest%205BF726B50F116C88-001/tempDir-003/collection1/lib/.svn/' to classloader
[junit4] 2> 462643 T2768 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest%205BF726B50F116C88-001/tempDir-003/collection1/lib/classes/' to classloader
[junit4] 2> 462644 T2768 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest%205BF726B50F116C88-001/tempDir-003/collection1/lib/README' to classloader
[junit4] 2> 462660 T2768 oasc.ZkController.watchZKConfDir watch zkdir /configs/conf1
[junit4] 2> 462663 T2768 oasc.Config.<init> loaded config solrconfig.xml with version 0
[junit4] 2> 462669 T2768 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
[junit4] 2> 462680 T2768 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0
[junit4] 2> 462700 T2768 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 462702 T2768 oass.IndexSchema.readSchema Reading Solr Schema from /configs/conf1/schema.xml
[junit4] 2> 462706 T2768 oass.IndexSchema.readSchema [collection1] Schema name=sortable
[junit4] 2> 462861 T2768 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 462862 T2768 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from collection collection1
[junit4] 2> 462862 T2768 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 462862 T2768 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-003/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-001/jetty1/
[junit4] 2> 462862 T2768 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 462863 T2768 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-001/jetty1
[junit4] 2> 462863 T2768 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-001/jetty1/index/
[junit4] 2> 462863 T2768 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-001/jetty1/index' doesn't exist. Creating new index...
[junit4] 2> 462864 T2768 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-001/jetty1/index
[junit4] 2> 462864 T2768 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=48, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5160384261868395]
[junit4] 2> 462865 T2768 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@196cc8d lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@14f44f9),segFN=segments_1,generation=1}
[junit4] 2> 462865 T2768 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 462865 T2768 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 462866 T2768 oasc.RequestHandlers.initHandlersFromConfig created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 462866 T2768 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 462866 T2768 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 462866 T2768 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 462866 T2768 oasc.RequestHandlers.initHandlersFromConfig created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 462866 T2768 oasc.RequestHandlers.initHandlersFromConfig created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 462867 T2768 oasc.RequestHandlers.initHandlersFromConfig created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 462867 T2768 oasc.RequestHandlers.initHandlersFromConfig created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 462867 T2768 oasc.RequestHandlers.initHandlersFromConfig created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 462867 T2768 oasc.RequestHandlers.initHandlersFromConfig created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 462867 T2768 oasc.RequestHandlers.initHandlersFromConfig created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 462868 T2768 oasc.RequestHandlers.initHandlersFromConfig created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 462868 T2768 oasc.RequestHandlers.initHandlersFromConfig created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 462868 T2768 oasc.RequestHandlers.initHandlersFromConfig created /admin/properties: org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 462868 T2768 oasc.RequestHandlers.initHandlersFromConfig created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 462869 T2768 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: org.apache.solr.handler.admin.ShowFileRequestHandler
[junit4] 2> 462869 T2768 oasc.RequestHandlers.initHandlersFromConfig created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 462869 T2768 oasc.RequestHandlers.initHandlersFromConfig created /select: solr.SearchHandler
[junit4] 2> 462872 T2768 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 462873 T2768 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 462874 T2768 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 462875 T2768 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 462876 T2768 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 462877 T2768 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 462877 T2768 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 462877 T2768 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=41, maxMergeAtOnceExplicit=29, maxMergedSegmentMB=98.9736328125, floorSegmentMB=1.4140625, forceMergeDeletesPctAllowed=2.6684977050046887, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8196520713965341
[junit4] 2> 462878 T2768 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@196cc8d lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@14f44f9),segFN=segments_1,generation=1}
[junit4] 2> 462878 T2768 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 462878 T2768 oass.SolrIndexSearcher.<init> Opening Searcher@1954cf[collection1] main
[junit4] 2> 462878 T2768 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1
[junit4] 2> 462880 T2768 oascc.ZkStateReader.readConfigName path=/collections/collection1 configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 462880 T2768 oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1
[junit4] 2> 462881 T2768 oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 462881 T2768 oasr.RestManager.init Initializing RestManager with initArgs: {}
[junit4] 2> 462881 T2768 oasr.ManagedResourceStorage.load Reading _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 462882 T2768 oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found for znode /configs/conf1/_rest_managed.json
[junit4] 2> 462882 T2768 oasr.ManagedResourceStorage.load Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 462882 T2768 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 462883 T2768 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 462883 T2769 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1954cf[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 462883 T2768 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 462884 T2772 oasc.ZkController.register Register replica - core:collection1 address:https://127.0.0.1:36453 collection:collection1 shard:shard1
[junit4] 2> 462885 T2708 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0
[junit4] 2> 462885 T2708 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 462886 T2772 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard1/election
[junit4] 2> 462893 T2772 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard1
[junit4] 2> 462894 T2737 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 462895 T2772 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4] 2> 462895 T2772 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4] 2> ASYNC NEW_CORE C1671 name=collection1 org.apache.solr.core.SolrCore@8075a8 url=https://127.0.0.1:36453/collection1 node=127.0.0.1:36453_ C1671_STATE=coll:collection1 core:collection1 props:{core=collection1, node_name=127.0.0.1:36453_, base_url=https://127.0.0.1:36453, state=down}
[junit4] 2> 462895 T2772 C1671 P36453 oasc.SyncStrategy.sync Sync replicas to https://127.0.0.1:36453/collection1/
[junit4] 2> 462896 T2738 oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"collection1"} current state version: 4
[junit4] 2> 462896 T2772 C1671 P36453 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4] 2> 462896 T2772 C1671 P36453 oasc.SyncStrategy.syncToMe https://127.0.0.1:36453/collection1/ has no replicas
[junit4] 2> 462897 T2772 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: https://127.0.0.1:36453/collection1/ shard1
[junit4] 2> 462897 T2772 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard1
[junit4] 2> 462897 T2738 oasco.ZkStateWriter.writePendingUpdates going to update_collection /collections/collection1/state.json version: 1
[junit4] 2> 462898 T2767 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 462899 T2767 oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to ver 2
[junit4] 2> 462901 T2738 oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "base_url":"https://127.0.0.1:36453",
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 4
[junit4] 2> 462902 T2738 oasco.ZkStateWriter.writePendingUpdates going to update_collection /collections/collection1/state.json version: 2
[junit4] 2> 462902 T2767 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 462903 T2767 oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to ver 3
[junit4] 2> 462904 T2737 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 462951 T2772 oasc.ZkController.register We are https://127.0.0.1:36453/collection1/ and leader is https://127.0.0.1:36453/collection1/
[junit4] 2> 462951 T2772 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=https://127.0.0.1:36453
[junit4] 2> 462951 T2772 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4] 2> 462951 T2772 oasc.ZkController.publish publishing core=collection1 state=active collection=collection1
[junit4] 2> 462951 T2772 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4] 2> 462952 T2737 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 462953 T2738 oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard":"shard1",
[junit4] 2> "node_name":"127.0.0.1:36453_",
[junit4] 2> "base_url":"https://127.0.0.1:36453",
[junit4] 2> "state":"active",
[junit4] 2> "operation":"state",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null} current state version: 4
[junit4] 2> 462954 T2738 oasco.ReplicaMutator.updateState Update state numShards=2 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard":"shard1",
[junit4] 2> "node_name":"127.0.0.1:36453_",
[junit4] 2> "base_url":"https://127.0.0.1:36453",
[junit4] 2> "state":"active",
[junit4] 2> "operation":"state",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null}
[junit4] 2> 462955 T2738 oasco.ZkStateWriter.writePendingUpdates going to update_collection /collections/collection1/state.json version: 3
[junit4] 2> 462955 T2772 oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to ver 3
[junit4] 2> 462955 T2767 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 462956 T2767 oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to ver 4
[junit4] 2> 463108 T2708 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 2
[junit4] 2> 463108 T2708 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 463112 T2708 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2]
[junit4] 2> 463114 T2708 oejs.AbstractConnector.doStart Started SslSelectChannelConnector@127.0.0.1:60319
[junit4] 2> 463116 T2708 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@9ed5d6
[junit4] 2> 463116 T2708 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 463117 T2708 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-004
[junit4] 2> 463117 T2708 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-004/'
[junit4] 2> 463127 T2708 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-004/solr.xml
[junit4] 2> 463146 T2708 oasc.CoreContainer.<init> New CoreContainer 24846494
[junit4] 2> 463147 T2708 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-004/]
[junit4] 2> 463148 T2708 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 463148 T2708 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to:
[junit4] 2> 463148 T2708 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 463148 T2708 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 463148 T2708 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000
[junit4] 2> 463149 T2708 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 463149 T2708 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 463149 T2708 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 463149 T2708 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 463150 T2708 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 463151 T2708 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 463153 T2708 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 463153 T2708 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 463153 T2708 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 463153 T2708 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:38958/solr
[junit4] 2> 463154 T2708 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 463154 T2708 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
[junit4] 2> 463155 T2708 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 463156 T2784 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@fc4a9a name:ZooKeeperConnection Watcher:127.0.0.1:38958 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 463157 T2708 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 463157 T2708 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
[junit4] 2> 463159 T2708 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 463160 T2787 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@4fa3f6 name:ZooKeeperConnection Watcher:127.0.0.1:38958/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 463160 T2708 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 463167 T2708 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 464172 T2708 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60319_
[junit4] 2> 464173 T2708 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:60319_
[junit4] 2> 464176 T2708 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 464181 T2788 oasc.ZkController.publish publishing core=collection1 state=down collection=collection1
[junit4] 2> 464181 T2788 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4] 2> 464182 T2737 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 464183 T2788 oasc.ZkController.preRegister Registering watch for external collection collection1
[junit4] 2> 464183 T2788 oascc.ZkStateReader.addZkWatch addZkWatch collection1
[junit4] 2> 464183 T2738 oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard":null,
[junit4] 2> "node_name":"127.0.0.1:60319_",
[junit4] 2> "base_url":"https://127.0.0.1:60319",
[junit4] 2> "state":"down",
[junit4] 2> "operation":"state",
[junit4] 2> "roles":null} current state version: 4
[junit4] 2> 464183 T2788 oascc.ZkStateReader.addZkWatch Updating collection state at /collections/collection1/state.json from ZooKeeper...
[junit4] 2> 464183 T2738 oasco.ReplicaMutator.updateState Update state numShards=2 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard":null,
[junit4] 2> "node_name":"127.0.0.1:60319_",
[junit4] 2> "base_url":"https://127.0.0.1:60319",
[junit4] 2> "state":"down",
[junit4] 2> "operation":"state",
[junit4] 2> "roles":null}
[junit4] 2> 464184 T2738 oasco.ReplicaMutator.updateState Collection already exists with numShards=2
[junit4] 2> 464184 T2738 oasco.ReplicaMutator.updateState Assigning new node to shard shard=shard2
[junit4] 2> 464184 T2788 oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to ver 4
[junit4] 2> 464184 T2788 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 464184 T2738 oasco.ZkStateWriter.writePendingUpdates going to update_collection /collections/collection1/state.json version: 4
[junit4] 2> 464185 T2767 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 464185 T2787 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 464185 T2767 oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to ver 5
[junit4] 2> 464185 T2787 oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to ver 5
[junit4] 2> 465184 T2788 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1
[junit4] 2> 465185 T2788 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4] 2> 465185 T2788 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 465185 T2788 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1
[junit4] 2> 465187 T2788 oascc.ZkStateReader.readConfigName path=/collections/collection1 configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 465187 T2788 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-004/collection1/'
[junit4] 2> 465187 T2788 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest%205BF726B50F116C88-001/tempDir-004/collection1/lib/.svn/' to classloader
[junit4] 2> 465188 T2788 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest%205BF726B50F116C88-001/tempDir-004/collection1/lib/classes/' to classloader
[junit4] 2> 465188 T2788 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest%205BF726B50F116C88-001/tempDir-004/collection1/lib/README' to classloader
[junit4] 2> 465198 T2788 oasc.ZkController.watchZKConfDir watch zkdir /configs/conf1
[junit4] 2> 465200 T2788 oasc.Config.<init> loaded config solrconfig.xml with version 0
[junit4] 2> 465205 T2788 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
[junit4] 2> 465221 T2788 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0
[junit4] 2> 465242 T2788 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 465244 T2788 oass.IndexSchema.readSchema Reading Solr Schema from /configs/conf1/schema.xml
[junit4] 2> 465249 T2788 oass.IndexSchema.readSchema [collection1] Schema name=sortable
[junit4] 2> 465387 T2788 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 465388 T2788 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from collection collection1
[junit4] 2> 465388 T2788 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 465388 T2788 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-004/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-001/jetty2/
[junit4] 2> 465388 T2788 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 465389 T2788 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-001/jetty2
[junit4] 2> 465389 T2788 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-001/jetty2/index/
[junit4] 2> 465390 T2788 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-001/jetty2/index' doesn't exist. Creating new index...
[junit4] 2> 465390 T2788 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest 5BF726B50F116C88-001/tempDir-001/jetty2/index
[junit4] 2> 465391 T2788 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=48, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5160384261868395]
[junit4] 2> 465391 T2788 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@86bca7 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cbb0a1),segFN=segments_1,generation=1}
[junit4] 2> 465391 T2788 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 465392 T2788 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 465392 T2788 oasc.RequestHandlers.initHandlersFromConfig created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 465393 T2788 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 465393 T2788 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 465393 T2788 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 465393 T2788 oasc.RequestHandlers.initHandlersFromConfig created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 465393 T2788 oasc.RequestHandlers.initHandlersFromConfig created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 465394 T2788 oasc.RequestHandlers.initHandlersFromConfig created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 465394 T2788 oasc.RequestHandlers.initHandlersFromConfig created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 465394 T2788 oasc.RequestHandlers.initHandlersFromConfig created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 465394 T2788 oasc.RequestHandlers.initHandlersFromConfig created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 465395 T2788 oasc.RequestHandlers.initHandlersFromConfig created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 465395 T2788 oasc.RequestHandlers.initHandlersFromConfig created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 465395 T2788 oasc.RequestHandlers.initHandlersFromConfig created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 465395 T2788 oasc.RequestHandlers.initHandlersFromConfig created /admin/properties: org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 465395 T2788 oasc.RequestHandlers.initHandlersFromConfig created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 465396 T2788 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: org.apache.solr.handler.admin.ShowFileRequestHandler
[junit4] 2> 465396 T2788 oasc.RequestHandlers.initHandlersFromConfig created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 465396 T2788 oasc.RequestHandlers.initHandlersFromConfig created /select: solr.SearchHandler
[junit4] 2> 465398 T2788 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 465399 T2788 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 465400 T2788 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 465401 T2788 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 465402 T2788 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 465403 T2788 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 465403 T2788 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 465404 T2788 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=41, maxMergeAtOnceExplicit=29, maxMergedSegmentMB=98.9736328125, floorSegmentMB=1.4140625, forceMergeDeletesPctAllowed=2.6684977050046887, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8196520713965341
[junit4] 2> 465404 T2788 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@86bca7 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cbb0a1),segFN=segments_1,generation=1}
[junit4] 2> 465404 T2788 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 465404 T2788 oass.SolrIndexSearcher.<init> Opening Searcher@7dcd05[collection1] main
[junit4] 2> 465405 T2788 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1
[junit4] 2> 465406 T2788 oascc.ZkStateReader.readConfigName path=/collections/collection1 configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 465406 T2788 oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1
[junit4] 2> 465407 T2788 oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 465407 T2788 oasr.RestManager.init Initializing RestManager with initArgs: {}
[junit4] 2> 465407 T2788 oasr.ManagedResourceStorage.load Reading _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 465408 T2788 oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found for znode /configs/conf1/_rest_managed.json
[junit4] 2> 465408 T2788 oasr.ManagedResourceStorage.load Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 465409
[...truncated too long message...]
01/tempDir-001/jetty4/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud 5BF726B50F116C88-001/tempDir-001/jetty4/index;done=false>>]
[junit4] 2> 1833161 T10671 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud 5BF726B50F116C88-001/tempDir-001/jetty4/index
[junit4] 2> 1833163 T10671 oasc.Overseer.close Overseer (id=93129830915899406-127.0.0.1:42295_-n_0000000004) closing
[junit4] 2> 1833163 T10893 oasc.Overseer$ClusterStateUpdater.run Overseer Loop exiting : 127.0.0.1:42295_
[junit4] 2> 1834663 T10885 oascc.ZkStateReader$7.process WARN ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 2> 1834664 T10886 oascc.ZkStateReader$3.process WARN ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 2> 1834686 T10671 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/,null}
[junit4] 2> 1834875 T10671 oas.SolrTestCaseJ4.tearDown ###Ending testDistribSearch
[junit4] 2> 1834876 T10671 oasc.ZkTestServer.send4LetterWord connecting to 127.0.0.1:42970 42970
[junit4] 2> 1835582 T10672 oasc.ZkTestServer.send4LetterWord connecting to 127.0.0.1:42970 42970
[junit4] 2> 1835584 T10672 oasc.ZkTestServer$ZKServerMain.runFromConfig WARN Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 50 /solr/configs/conf1
[junit4] 2> 6 /solr/aliases.json
[junit4] 2> 6 /solr/clusterstate.json
[junit4] 2> 4 /solr/collections/collection1/state.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 6 /solr/live_nodes
[junit4] 2> 5 /solr/overseer/collection-queue-work
[junit4] 2> 4 /solr/overseer/queue
[junit4] 2>
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestSolrConfigHandlerCloud -Dtests.method=testDistribSearch -Dtests.seed=5BF726B50F116C88 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=sr_ME -Dtests.timezone=Asia/Yekaterinburg -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 40.7s J0 | TestSolrConfigHandlerCloud.testDistribSearch <<<
[junit4] > Throwable #1: java.lang.AssertionError: Could not get expected value P val for path [response, params, y, p] full output {
[junit4] > "responseHeader":{
[junit4] > "status":0,
[junit4] > "QTime":0},
[junit4] > "response":{
[junit4] > "znodeVersion":0,
[junit4] > "params":{"x":{
[junit4] > "a":"A val",
[junit4] > "b":"B val",
[junit4] > "":{"v":0}}}}}
[junit4] > at __randomizedtesting.SeedInfo.seed([5BF726B50F116C88:DA11A8AD784E0CB4]:0)
[junit4] > at org.apache.solr.core.TestSolrConfigHandler.testForResponseElement(TestSolrConfigHandler.java:259)
[junit4] > at org.apache.solr.handler.TestSolrConfigHandlerCloud.testReqParams(TestSolrConfigHandlerCloud.java:261)
[junit4] > at org.apache.solr.handler.TestSolrConfigHandlerCloud.doTest(TestSolrConfigHandlerCloud.java:70)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:868)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 1835591 T10671 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud 5BF726B50F116C88-001
[junit4] 2> NOTE: test params are: codec=CheapBastard, sim=DefaultSimilarity, locale=sr_ME, timezone=Asia/Yekaterinburg
[junit4] 2> NOTE: Linux 3.13.0-43-generic i386/Oracle Corporation 1.7.0_72 (32-bit)/cpus=8,threads=1,free=156880232,total=440401920
[junit4] 2> NOTE: All tests run in this JVM: [DefaultValueUpdateProcessorTest, ShardRoutingTest, TestExtendedDismaxParser, DistanceFunctionTest, SimpleFacetsTest, DateMathParserTest, UnloadDistributedZkTest, TestReplicationHandlerBackup, CoreAdminHandlerTest, PathHierarchyTokenizerFactoryTest, TestLMDirichletSimilarityFactory, TestStressRecovery, NoCacheHeaderTest, TestRequestStatusCollectionAPI, TestAnalyzeInfixSuggestions, DistributedQueryElevationComponentTest, AddBlockUpdateTest, CachingDirectoryFactoryTest, ResourceLoaderTest, CoreAdminCreateDiscoverTest, DistributedQueueTest, SolrPluginUtilsTest, TestBlendedInfixSuggestions, TestDefaultStatsCache, SuggestComponentTest, TestCollationField, BasicDistributedZkTest, TestShardHandlerFactory, SolrInfoMBeanTest, SolrIndexConfigTest, DistributedFacetPivotSmallAdvancedTest, TestSolrCoreProperties, TestExceedMaxTermLength, TestSerializedLuceneMatchVersion, HdfsSyncSliceTest, SolrCoreCheckLockOnStartupTest, DeleteReplicaTest, TestReplicaProperties, XmlUpdateRequestHandlerTest, FacetPivotSmallTest, UUIDFieldTest, TestDynamicLoading, OpenExchangeRatesOrgProviderTest, TestCloudSchemaless, HdfsWriteToMultipleCollectionsTest, PreAnalyzedFieldTest, HdfsCollectionsAPIDistributedZkTest, DistribCursorPagingTest, CoreMergeIndexesAdminHandlerTest, AlternateDirectoryTest, TestFunctionQuery, TestSolr4Spatial2, TestRawResponseWriter, TestWordDelimiterFilterFactory, CoreContainerCoreInitFailuresTest, EnumFieldTest, HdfsLockFactoryTest, SolrCoreTest, FieldAnalysisRequestHandlerTest, TestSchemaManager, MinimalSchemaTest, DistributedFacetPivotLongTailTest, TestChildDocTransformer, TestFieldCollectionResource, TestSolrXmlPersistor, ZkControllerTest, SystemInfoHandlerTest, TestGroupingSearch, TestNRTOpen, TestCursorMarkWithoutUniqueKey, TestCoreContainer, TestCSVLoader, HardAutoCommitTest, AnalysisAfterCoreReloadTest, TestUpdate, TestOverriddenPrefixQueryForCustomFieldType, TestStressLucene, TestUniqueKeyFieldResource, TestReloadAndDeleteDocs, SuggesterWFSTTest, TestFastWriter, TriLevelCompositeIdRoutingTest, HdfsBasicDistributedZkTest, TestSolrDynamicMBean, TestFieldTypeResource, TestDocBasedVersionConstraints, TestSweetSpotSimilarityFactory, TestIndexSearcher, SuggesterFSTTest, TestSchemaResource, TestBinaryResponseWriter, DistribDocExpirationUpdateProcessorTest, TestComplexPhraseQParserPlugin, TestBlobHandler, TestManagedResourceStorage, TestExactStatsCache, RequestHandlersTest, TestExactSharedStatsCache, PrimUtilsTest, TestJmxIntegration, HdfsChaosMonkeySafeLeaderTest, TestCloudManagedSchemaConcurrent, TestQueryTypes, BadCopyFieldTest, TestStressReorder, SimpleMLTQParserTest, TestRandomDVFaceting, NumericFieldsTest, DeleteInactiveReplicaTest, TestComponentsName, OutOfBoxZkACLAndCredentialsProvidersTest, TestManagedResource, RecoveryZkTest, ClusterStateUpdateTest, LeaderElectionTest, TestFaceting, TestHashPartitioner, TestStressVersions, PeerSyncTest, ConvertedLegacyTest, TestFiltering, ShowFileRequestHandlerTest, SolrIndexSplitterTest, SuggesterTest, SpatialFilterTest, TestPseudoReturnFields, TestAtomicUpdateErrorCases, TestRemoteStreaming, CacheHeaderTest, LukeRequestHandlerTest, StandardRequestHandlerTest, DirectSolrSpellCheckerTest, DocumentAnalysisRequestHandlerTest, TestOmitPositions, TestValueSourceCache, TestIndexingPerformance, TestArbitraryIndexDir, IndexSchemaTest, UpdateRequestProcessorFactoryTest, JSONWriterTest, TestAnalyzedSuggestions, BinaryUpdateRequestHandlerTest, TestPHPSerializedResponseWriter, CSVRequestHandlerTest, HighlighterConfigTest, TestQuerySenderListener, TestQuerySenderNoQuery, CopyFieldTest, TestSolrDeletionPolicy2, SampleTest, TestBinaryField, TestElisionMultitermQuery, TestFuzzyAnalyzedSuggestions, TestPostingsSolrHighlighter, NotRequiredUniqueKeyTest, TestPhraseSuggestions, SynonymTokenizerTest, TestDFRSimilarityFactory, TestIBSimilarityFactory, TestBM25SimilarityFactory, LegacyHTMLStripCharFilterTest, ScriptEngineTest, PluginInfoTest, SpellingQueryConverterTest, DOMUtilTest, ClusterStateTest, TestLRUCache, TestUtils, TestDocumentBuilder, SliceStateTest, FileUtilsTest, TestRTGBase, SolrTestCaseJ4Test, TestDistributedMissingSort, TestHighlightDedupGrouping, AliasIntegrationTest, ConnectionManagerTest, CustomCollectionTest, ExternalCollectionsTest, LeaderFailoverAfterPartitionTest, LeaderInitiatedRecoveryOnCommitTest, MultiThreadedOCPTest, OverseerStatusTest, RollingRestartTest, SSLMigrationTest, ShardSplitTest, TestSolrConfigHandlerCloud]
[junit4] Completed on J0 in 40.71s, 1 test, 1 failure <<< FAILURES!
[...truncated 152 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:529: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:477: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:61: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/extra-targets.xml:39: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build.xml:190: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/common-build.xml:508: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:1363: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:970: There were test failures: 460 suites, 1871 tests, 1 suite-level error, 2 failures, 47 ignored (22 assumptions)
Total time: 64 minutes 45 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 32bit/jdk1.7.0_72 -server -XX:+UseParallelGC
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any