Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Windows/112/ Java: 64bit/jdk-9-ea+181 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC --illegal-access=deny
1 tests failed. FAILED: org.apache.solr.cloud.ForceLeaderTest.testReplicasInLIRNoLeader Error Message: Doc with id=1 not found in http://127.0.0.1:59653/tt_p/ca/forceleader_test_collection due to: Path not found: /id; rsp={doc=null} Stack Trace: java.lang.AssertionError: Doc with id=1 not found in http://127.0.0.1:59653/tt_p/ca/forceleader_test_collection due to: Path not found: /id; rsp={doc=null} at __randomizedtesting.SeedInfo.seed([CF8D0105BDFF8979:291A35C5847D7018]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.apache.solr.cloud.HttpPartitionTest.assertDocExists(HttpPartitionTest.java:603) at org.apache.solr.cloud.HttpPartitionTest.assertDocsExistInAllReplicas(HttpPartitionTest.java:556) at org.apache.solr.cloud.ForceLeaderTest.testReplicasInLIRNoLeader(ForceLeaderTest.java:142) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:993) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:968) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) 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:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.base/java.lang.Thread.run(Thread.java:844) Build Log: [...truncated 1716 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\temp\junit4-J1-20170812_115717_8937599263899313674547.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 3 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\temp\junit4-J0-20170812_115717_8896664594064066511433.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 301 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\test-framework\test\temp\junit4-J1-20170812_120236_08016504858271876853161.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 3 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\test-framework\test\temp\junit4-J0-20170812_120236_0805393506078319257745.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 1034 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\analysis\common\test\temp\junit4-J0-20170812_120335_47011717371423676072589.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 3 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\analysis\common\test\temp\junit4-J1-20170812_120335_4701324624050387261230.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 220 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\analysis\icu\test\temp\junit4-J1-20170812_120540_3535629721521217131425.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\analysis\icu\test\temp\junit4-J0-20170812_120540_3533511759644223674584.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 238 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\analysis\kuromoji\test\temp\junit4-J0-20170812_120552_305745655141006029815.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 3 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\analysis\kuromoji\test\temp\junit4-J1-20170812_120552_30514738752007045986947.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 147 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\analysis\morfologik\test\temp\junit4-J1-20170812_120615_56912887699260621755916.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Suite: org.apache.lucene.analysis.uk.TestUkrainianAnalyzer [junit4] Completed [3/3] on J0 in 1.80s, 7 tests [junit4] [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\analysis\morfologik\test\temp\junit4-J0-20170812_120615_56911635505379036818478.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 159 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\analysis\phonetic\test\temp\junit4-J0-20170812_120619_74617809298710348528188.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 3 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\analysis\phonetic\test\temp\junit4-J1-20170812_120619_74611063535227559956448.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 144 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\analysis\smartcn\test\temp\junit4-J1-20170812_120628_49814410757362836105533.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 3 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\analysis\smartcn\test\temp\junit4-J0-20170812_120628_498188080569740744192.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 152 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\analysis\stempel\test\temp\junit4-J1-20170812_120634_3546544589303616683183.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\analysis\stempel\test\temp\junit4-J0-20170812_120634_35414823572948452672981.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 160 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\analysis\uima\test\temp\junit4-J0-20170812_120637_62311726687764426746842.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 187 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\backward-codecs\test\temp\junit4-J1-20170812_120654_2225268658351249823067.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 26 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\backward-codecs\test\temp\junit4-J0-20170812_120654_22216349229229816633782.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 1219 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\benchmark\test\temp\junit4-J1-20170812_120748_2958898656023469922553.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 3 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\benchmark\test\temp\junit4-J0-20170812_120748_29517279898821703890171.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 222 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\classification\test\temp\junit4-J1-20170812_120758_7311258358478264525559.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 3 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\classification\test\temp\junit4-J0-20170812_120758_7313601807155105012932.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 250 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\codecs\test\temp\junit4-J0-20170812_120810_6815587104129178222651.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 5 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\codecs\test\temp\junit4-J1-20170812_120810_681681516064794967088.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 229 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\demo\test\temp\junit4-J0-20170812_120919_4577916951197906395046.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\demo\test\temp\junit4-J1-20170812_120919_4574449405651833969244.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 163 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\expressions\test\temp\junit4-J1-20170812_120923_26518402268975655004147.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 3 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\expressions\test\temp\junit4-J0-20170812_120923_26512754604577641055615.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 205 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\facet\test\temp\junit4-J0-20170812_120928_8447812625201947327729.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 6 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\facet\test\temp\junit4-J1-20170812_120928_84411810785278392381331.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 175 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\grouping\test\temp\junit4-J1-20170812_120949_3846728665397270047357.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\grouping\test\temp\junit4-J0-20170812_120949_3849558430333007629670.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 236 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\highlighter\test\temp\junit4-J1-20170812_120957_0225171150336466940696.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 3 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\highlighter\test\temp\junit4-J0-20170812_120957_02214627605215020501918.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 156 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\join\test\temp\junit4-J0-20170812_121013_24916009958217277345384.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 3 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\join\test\temp\junit4-J1-20170812_121013_2496425159817390779976.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 140 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\memory\test\temp\junit4-J0-20170812_121024_736342671986132961335.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 3 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\memory\test\temp\junit4-J1-20170812_121024_73613041164548551470396.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 177 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\misc\test\temp\junit4-J0-20170812_121030_564728860453081320704.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 3 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\misc\test\temp\junit4-J1-20170812_121030_5646688625020734769059.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 305 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\queries\test\temp\junit4-J0-20170812_121046_6249521350092651402065.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 3 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\queries\test\temp\junit4-J1-20170812_121046_62311999314188567786233.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 217 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\queryparser\test\temp\junit4-J0-20170812_121055_3679119690517255732870.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 3 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\queryparser\test\temp\junit4-J1-20170812_121055_36715290028733911781079.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 200 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\replicator\test\temp\junit4-J1-20170812_121104_53115816141598975737646.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 3 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\replicator\test\temp\junit4-J0-20170812_121104_53111981354582152089135.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 198 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\sandbox\test\temp\junit4-J1-20170812_121120_0829185746278875594430.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 7 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\sandbox\test\temp\junit4-J0-20170812_121120_0822915868065625666999.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 208 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\spatial-extras\test\temp\junit4-J0-20170812_121148_22914194452299748773470.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 3 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\spatial-extras\test\temp\junit4-J1-20170812_121148_22913924054235197754544.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 169 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\spatial3d\test\temp\junit4-J0-20170812_121201_8225532437615433914002.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 8 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\spatial3d\test\temp\junit4-J1-20170812_121201_8223065326438229791477.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 139 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\spatial\test\temp\junit4-J0-20170812_121218_61413946445014368615876.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 240 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\suggest\test\temp\junit4-J1-20170812_121222_1121305173434634936419.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\suggest\test\temp\junit4-J0-20170812_121222_11216677636604020266282.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 1755 lines...] [junit4] Suite: org.apache.solr.cloud.ForceLeaderTest [junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.ForceLeaderTest_CF8D0105BDFF8979-001\init-core-data-001 [junit4] 2> 514315 WARN (SUITE-ForceLeaderTest-seed#[CF8D0105BDFF8979]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=10 numCloses=10 [junit4] 2> 514315 INFO (SUITE-ForceLeaderTest-seed#[CF8D0105BDFF8979]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true [junit4] 2> 514317 INFO (SUITE-ForceLeaderTest-seed#[CF8D0105BDFF8979]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl="https://issues.apache.org/jira/browse/SOLR-5776") [junit4] 2> 514317 INFO (SUITE-ForceLeaderTest-seed#[CF8D0105BDFF8979]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> 514317 INFO (SUITE-ForceLeaderTest-seed#[CF8D0105BDFF8979]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /tt_p/ca [junit4] 2> 514318 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 514319 INFO (Thread-1190) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 514319 INFO (Thread-1190) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 514323 ERROR (Thread-1190) [ ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes [junit4] 2> 514420 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.ZkTestServer start zk server on port:59260 [junit4] 2> 514424 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x15dd664db0b0000, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203) [junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844) [junit4] 2> 514431 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.AbstractZkTestCase put C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig-tlog.xml to /configs/conf1/solrconfig.xml [junit4] 2> 514432 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.AbstractZkTestCase put C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\conf\schema.xml to /configs/conf1/schema.xml [junit4] 2> 514434 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.AbstractZkTestCase put C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 514434 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.AbstractZkTestCase put C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\conf\stopwords.txt to /configs/conf1/stopwords.txt [junit4] 2> 514434 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.AbstractZkTestCase put C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\conf\protwords.txt to /configs/conf1/protwords.txt [junit4] 2> 514434 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.AbstractZkTestCase put C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\conf\currency.xml to /configs/conf1/currency.xml [junit4] 2> 514439 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.AbstractZkTestCase put C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\conf\enumsConfig.xml to /configs/conf1/enumsConfig.xml [junit4] 2> 514440 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.AbstractZkTestCase put C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\conf\open-exchange-rates.json to /configs/conf1/open-exchange-rates.json [junit4] 2> 514441 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.AbstractZkTestCase put C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\conf\mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 514442 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.AbstractZkTestCase put C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\conf\old_synonyms.txt to /configs/conf1/old_synonyms.txt [junit4] 2> 514443 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.AbstractZkTestCase put C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\conf\synonyms.txt to /configs/conf1/synonyms.txt [junit4] 2> 514445 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x15dd664db0b0001, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203) [junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844) [junit4] 2> 514445 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Will use TLOG replicas unless explicitly asked otherwise [junit4] 2> 514704 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028 [junit4] 2> 514704 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4cecba59{/tt_p/ca,null,AVAILABLE} [junit4] 2> 514706 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@743e6c99{HTTP/1.1,[http/1.1]}{127.0.0.1:59270} [junit4] 2> 514706 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.e.j.s.Server Started @516069ms [junit4] 2> 514706 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/tt_p/ca, solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.ForceLeaderTest_CF8D0105BDFF8979-001\tempDir-001/control/data, hostPort=59269, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.ForceLeaderTest_CF8D0105BDFF8979-001\control-001\cores, replicaType=NRT} [junit4] 2> 514706 ERROR (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 514706 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.1.0 [junit4] 2> 514706 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 514706 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config dir: null [junit4] 2> 514706 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-08-12T12:22:00.587505600Z [junit4] 2> 514710 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 514710 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.ForceLeaderTest_CF8D0105BDFF8979-001\control-001\solr.xml [junit4] 2> 514712 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@133202d4, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 514719 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:59260/solr [junit4] 2> 514812 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 514812 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:59269_tt_p%2Fca [junit4] 2> 514813 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.Overseer Overseer (id=98470495532023812-127.0.0.1:59269_tt_p%2Fca-n_0000000000) starting [junit4] 2> 514820 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:59269_tt_p%2Fca [junit4] 2> 514821 INFO (zkCallback-845-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 514878 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@133202d4 [junit4] 2> 514881 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@133202d4 [junit4] 2> 514881 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@133202d4 [junit4] 2> 514882 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.ForceLeaderTest_CF8D0105BDFF8979-001\control-001\cores [junit4] 2> 514897 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 514898 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:59260/solr ready [junit4] 2> 514899 INFO (SocketProxy-Acceptor-59269) [ ] o.a.s.c.SocketProxy accepted Socket[addr=/127.0.0.1,port=59287,localport=59269], receiveBufferSize:65536 [junit4] 2> 514905 INFO (SocketProxy-Acceptor-59269) [ ] o.a.s.c.SocketProxy proxy connection Socket[addr=/127.0.0.1,port=59270,localport=59288], receiveBufferSize=65536 [junit4] 2> 514907 INFO (qtp396609358-5161) [ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=1&collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:59269_tt_p%252Fca&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 514909 INFO (OverseerThreadFactory-2272-thread-1) [ ] o.a.s.c.CreateCollectionCmd Create collection control_collection [junit4] 2> 515019 INFO (SocketProxy-Acceptor-59269) [ ] o.a.s.c.SocketProxy accepted Socket[addr=/127.0.0.1,port=59289,localport=59269], receiveBufferSize:65536 [junit4] 2> 515019 INFO (SocketProxy-Acceptor-59269) [ ] o.a.s.c.SocketProxy proxy connection Socket[addr=/127.0.0.1,port=59270,localport=59290], receiveBufferSize=65536 [junit4] 2> 515022 INFO (qtp396609358-5162) [ ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT [junit4] 2> 515022 INFO (qtp396609358-5162) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 515134 INFO (zkCallback-845-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1]) [junit4] 2> 516047 INFO (qtp396609358-5162) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0 [junit4] 2> 516070 INFO (qtp396609358-5162) [ ] o.a.s.s.IndexSchema [control_collection_shard1_replica_n1] Schema name=test [junit4] 2> 516174 INFO (qtp396609358-5162) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 516192 INFO (qtp396609358-5162) [ ] o.a.s.c.CoreContainer Creating SolrCore 'control_collection_shard1_replica_n1' using configuration from collection control_collection, trusted=true [junit4] 2> 516192 INFO (qtp396609358-5162) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.control_collection.shard1.replica_n1' (registry 'solr.core.control_collection.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@133202d4 [junit4] 2> 516192 INFO (qtp396609358-5162) [ ] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 516192 INFO (qtp396609358-5162) [ ] o.a.s.c.SolrCore [[control_collection_shard1_replica_n1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.ForceLeaderTest_CF8D0105BDFF8979-001\control-001\cores\control_collection_shard1_replica_n1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.ForceLeaderTest_CF8D0105BDFF8979-001\control-001\cores\control_collection_shard1_replica_n1\data\] [junit4] 2> 516197 INFO (qtp396609358-5162) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=10, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.2401738689316308] [junit4] 2> 516198 WARN (qtp396609358-5162) [ ] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}} [junit4] 2> 516250 INFO (qtp396609358-5162) [ ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 516250 INFO (qtp396609358-5162) [ ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 516252 INFO (qtp396609358-5162) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 516252 INFO (qtp396609358-5162) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 516252 INFO (qtp396609358-5162) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=30, maxMergeAtOnceExplicit=17, maxMergedSegmentMB=33.1142578125, floorSegmentMB=1.9912109375, forceMergeDeletesPctAllowed=9.488150556768307, segmentsPerTier=22.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0 [junit4] 2> 516253 INFO (qtp396609358-5162) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1ead3664[control_collection_shard1_replica_n1] main] [junit4] 2> 516255 INFO (qtp396609358-5162) [ ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 516255 INFO (qtp396609358-5162) [ ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 516255 INFO (qtp396609358-5162) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 516257 INFO (searcherExecutor-2275-thread-1) [ ] o.a.s.c.SolrCore [control_collection_shard1_replica_n1] Registered new searcher Searcher@1ead3664[control_collection_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 516257 INFO (qtp396609358-5162) [ ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1575527930541375488 [junit4] 2> 516263 INFO (qtp396609358-5162) [ ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 516263 INFO (qtp396609358-5162) [ ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 516263 INFO (qtp396609358-5162) [ ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:59269/tt_p/ca/control_collection_shard1_replica_n1/ [junit4] 2> 516263 INFO (qtp396609358-5162) [ ] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 516263 INFO (qtp396609358-5162) [ ] o.a.s.c.SyncStrategy http://127.0.0.1:59269/tt_p/ca/control_collection_shard1_replica_n1/ has no replicas [junit4] 2> 516263 INFO (qtp396609358-5162) [ ] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR [junit4] 2> 516266 INFO (qtp396609358-5162) [ ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:59269/tt_p/ca/control_collection_shard1_replica_n1/ shard1 [junit4] 2> 516370 INFO (zkCallback-845-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1]) [junit4] 2> 516417 INFO (qtp396609358-5162) [ ] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 516420 INFO (qtp396609358-5162) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1398 [junit4] 2> 516424 INFO (qtp396609358-5161) [ ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 30 seconds. Check all shard replicas [junit4] 2> 516526 INFO (zkCallback-845-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1]) [junit4] 2> 516911 INFO (OverseerCollectionConfigSetProcessor-98470495532023812-127.0.0.1:59269_tt_p%2Fca-n_0000000000) [ ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 517426 INFO (qtp396609358-5161) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={replicationFactor=1&collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:59269_tt_p%252Fca&wt=javabin&version=2} status=0 QTime=2518 [junit4] 2> 517441 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 517444 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:59260/solr ready [junit4] 2> 517444 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false [junit4] 2> 517446 INFO (SocketProxy-Acceptor-59269) [ ] o.a.s.c.SocketProxy accepted Socket[addr=/127.0.0.1,port=59306,localport=59269], receiveBufferSize:65536 [junit4] 2> 517447 INFO (SocketProxy-Acceptor-59269) [ ] o.a.s.c.SocketProxy proxy connection Socket[addr=/127.0.0.1,port=59270,localport=59307], receiveBufferSize=65536 [junit4] 2> 517450 INFO (qtp396609358-5166) [ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=1&collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&createNodeSet=&stateFormat=2&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 517456 INFO (OverseerThreadFactory-2272-thread-2) [ ] o.a.s.c.CreateCollectionCmd Create collection collection1 [junit4] 2> 517458 WARN (OverseerThreadFactory-2272-thread-2) [ ] o.a.s.c.CreateCollectionCmd It is unusual to create a collection (collection1) without cores. [junit4] 2> 517671 INFO (qtp396609358-5166) [ ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 30 seconds. Check all shard replicas [junit4] 2> 517672 INFO (qtp396609358-5166) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={replicationFactor=1&collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&createNodeSet=&stateFormat=2&wt=javabin&version=2} status=0 QTime=222 [junit4] 2> 518009 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.ForceLeaderTest_CF8D0105BDFF8979-001\shard-1-001 of type TLOG [junit4] 2> 518009 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028 [junit4] 2> 518010 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5739b6ea{/tt_p/ca,null,AVAILABLE} [junit4] 2> 518011 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@5ee0e57a{HTTP/1.1,[http/1.1]}{127.0.0.1:59311} [junit4] 2> 518011 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.e.j.s.Server Started @519375ms [junit4] 2> 518011 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/tt_p/ca, solrconfig=solrconfig.xml, solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.ForceLeaderTest_CF8D0105BDFF8979-001\tempDir-001/jetty1, hostPort=59310, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.ForceLeaderTest_CF8D0105BDFF8979-001\shard-1-001\cores, replicaType=TLOG} [junit4] 2> 518011 ERROR (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 518011 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.1.0 [junit4] 2> 518011 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 518011 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config dir: null [junit4] 2> 518011 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-08-12T12:22:03.892725900Z [junit4] 2> 518014 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 518014 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.ForceLeaderTest_CF8D0105BDFF8979-001\shard-1-001\solr.xml [junit4] 2> 518020 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@133202d4, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 518023 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:59260/solr [junit4] 2> 518034 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 518036 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 518038 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:59310_tt_p%2Fca [junit4] 2> 518039 INFO (zkCallback-852-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 518039 INFO (zkCallback-845-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 518039 INFO (zkCallback-857-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 518100 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@133202d4 [junit4] 2> 518103 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@133202d4 [junit4] 2> 518103 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@133202d4 [junit4] 2> 518105 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.ForceLeaderTest_CF8D0105BDFF8979-001\shard-1-001\cores [junit4] 2> 518119 INFO (qtp396609358-5163) [ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params node=127.0.0.1:59310_tt_p%252Fca&action=ADDREPLICA&collection=collection1&shard=shard2&type=TLOG&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 518122 INFO (OverseerCollectionConfigSetProcessor-98470495532023812-127.0.0.1:59269_tt_p%2Fca-n_0000000000) [ ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000002 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 518122 INFO (OverseerThreadFactory-2272-thread-3) [ ] o.a.s.c.AddReplicaCmd Node Identified 127.0.0.1:59310_tt_p%2Fca for creating new replica [junit4] 2> 518124 INFO (SocketProxy-Acceptor-59310) [ ] o.a.s.c.SocketProxy accepted Socket[addr=/127.0.0.1,port=59323,localport=59310], receiveBufferSize:65536 [junit4] 2> 518125 INFO (SocketProxy-Acceptor-59310) [ ] o.a.s.c.SocketProxy proxy connection Socket[addr=/127.0.0.1,port=59311,localport=59324], receiveBufferSize=65536 [junit4] 2> 518127 INFO (qtp1996508724-5209) [ ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf1&name=collection1_shard2_replica_t41&action=CREATE&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=TLOG [junit4] 2> 518127 INFO (qtp1996508724-5209) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 518237 INFO (zkCallback-857-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [2]) [junit4] 2> 519150 INFO (qtp1996508724-5209) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0 [junit4] 2> 519164 INFO (qtp1996508724-5209) [ ] o.a.s.s.IndexSchema [collection1_shard2_replica_t41] Schema name=test [junit4] 2> 519261 INFO (qtp1996508724-5209) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 519278 INFO (qtp1996508724-5209) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard2_replica_t41' using configuration from collection collection1, trusted=true [junit4] 2> 519278 INFO (qtp1996508724-5209) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1.shard2.replica_t41' (registry 'solr.core.collection1.shard2.replica_t41') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@133202d4 [junit4] 2> 519279 INFO (qtp1996508724-5209) [ ] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 519279 INFO (qtp1996508724-5209) [ ] o.a.s.c.SolrCore [[collection1_shard2_replica_t41] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.ForceLeaderTest_CF8D0105BDFF8979-001\shard-1-001\cores\collection1_shard2_replica_t41], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.ForceLeaderTest_CF8D0105BDFF8979-001\shard-1-001\cores\collection1_shard2_replica_t41\data\] [junit4] 2> 519280 INFO (qtp1996508724-5209) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=10, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.2401738689316308] [junit4] 2> 519282 WARN (qtp1996508724-5209) [ ] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}} [junit4] 2> 519333 INFO (qtp1996508724-5209) [ ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 519333 INFO (qtp1996508724-5209) [ ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 519334 INFO (qtp1996508724-5209) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 519334 INFO (qtp1996508724-5209) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 519340 INFO (qtp1996508724-5209) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=30, maxMergeAtOnceExplicit=17, maxMergedSegmentMB=33.1142578125, floorSegmentMB=1.9912109375, forceMergeDeletesPctAllowed=9.488150556768307, segmentsPerTier=22.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0 [junit4] 2> 519340 INFO (qtp1996508724-5209) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@59f66d38[collection1_shard2_replica_t41] main] [junit4] 2> 519342 INFO (qtp1996508724-5209) [ ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 519343 INFO (qtp1996508724-5209) [ ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 519343 INFO (qtp1996508724-5209) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 519343 INFO (qtp1996508724-5209) [ ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1575527933777281024 [junit4] 2> 519344 INFO (searcherExecutor-2286-thread-1) [ ] o.a.s.c.SolrCore [collection1_shard2_replica_t41] Registered new searcher Searcher@59f66d38[collection1_shard2_replica_t41] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 519351 INFO (qtp1996508724-5209) [ ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 519351 INFO (qtp1996508724-5209) [ ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 519351 INFO (qtp1996508724-5209) [ ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:59310/tt_p/ca/collection1_shard2_replica_t41/ [junit4] 2> 519351 INFO (qtp1996508724-5209) [ ] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 519351 INFO (qtp1996508724-5209) [ ] o.a.s.c.SyncStrategy http://127.0.0.1:59310/tt_p/ca/collection1_shard2_replica_t41/ has no replicas [junit4] 2> 519351 INFO (qtp1996508724-5209) [ ] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR [junit4] 2> 519351 INFO (qtp1996508724-5209) [ ] o.a.s.c.ZkController collection1_shard2_replica_t41 stopping background replication from leader [junit4] 2> 519354 INFO (qtp1996508724-5209) [ ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:59310/tt_p/ca/collection1_shard2_replica_t41/ shard2 [junit4] 2> 519457 INFO (zkCallback-857-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [2]) [junit4] 2> 519505 INFO (qtp1996508724-5209) [ ] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 519506 INFO (qtp1996508724-5209) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=conf1&name=collection1_shard2_replica_t41&action=CREATE&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=TLOG} status=0 QTime=1378 [junit4] 2> 519510 INFO (qtp396609358-5163) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={node=127.0.0.1:59310_tt_p%252Fca&action=ADDREPLICA&collection=collection1&shard=shard2&type=TLOG&wt=javabin&version=2} status=0 QTime=1390 [junit4] 2> 519611 INFO (zkCallback-857-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [2]) [junit4] 2> 519772 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.ForceLeaderTest_CF8D0105BDFF8979-001\shard-2-001 of type TLOG [junit4] 2> 519773 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028 [junit4] 2> 519773 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@199b4982{/tt_p/ca,null,AVAILABLE} [junit4] 2> 519774 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@6591f7a0{HTTP/1.1,[http/1.1]}{127.0.0.1:59334} [junit4] 2> 519774 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.e.j.s.Server Started @521138ms [junit4] 2> 519774 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/tt_p/ca, solrconfig=solrconfig.xml, solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.ForceLeaderTest_CF8D0105BDFF8979-001\tempDir-001/jetty2, hostPort=59333, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.ForceLeaderTest_CF8D0105BDFF8979-001\shard-2-001\cores, replicaType=TLOG} [junit4] 2> 519774 ERROR (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 519776 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.1.0 [junit4] 2> 519776 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 519776 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config dir: null [junit4] 2> 519776 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-08-12T12:22:05.657656700Z [junit4] 2> 519780 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 519780 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.ForceLeaderTest_CF8D0105BDFF8979-001\shard-2-001\solr.xml [junit4] 2> 519783 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@133202d4, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 519786 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:59260/solr [junit4] 2> 519789 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x15dd664db0b000b, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203) [junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844) [junit4] 2> 519798 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 519800 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 519802 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:59333_tt_p%2Fca [junit4] 2> 519803 INFO (zkCallback-852-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 519803 INFO (zkCallback-845-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 519803 INFO (zkCallback-857-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 519804 INFO (zkCallback-863-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 519845 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@133202d4 [junit4] 2> 519848 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@133202d4 [junit4] 2> 519848 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@133202d4 [junit4] 2> 519849 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.ForceLeaderTest_CF8D0105BDFF8979-001\shard-2-001\cores [junit4] 2> 519872 INFO (qtp396609358-5162) [ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params node=127.0.0.1:59333_tt_p%252Fca&action=ADDREPLICA&collection=collection1&shard=shard1&type=TLOG&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 519875 INFO (OverseerCollectionConfigSetProcessor-98470495532023812-127.0.0.1:59269_tt_p%2Fca-n_0000000000) [ ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000004 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 519875 INFO (OverseerThreadFactory-2272-thread-4) [ ] o.a.s.c.AddReplicaCmd Node Identified 127.0.0.1:59333_tt_p%2Fca for creating new replica [junit4] 2> 519877 INFO (SocketProxy-Acceptor-59333) [ ] o.a.s.c.SocketProxy accepted Socket[addr=/127.0.0.1,port=59346,localport=59333], receiveBufferSize:65536 [junit4] 2> 519877 INFO (SocketProxy-Acceptor-59333) [ ] o.a.s.c.SocketProxy proxy connection Socket[addr=/127.0.0.1,port=59334,localport=59347], receiveBufferSize=65536 [junit4] 2> 519880 INFO (qtp694529340-5244) [ ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf1&name=collection1_shard1_replica_t43&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=TLOG [junit4] 2> 519880 INFO (qtp694529340-5244) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 519987 INFO (zkCallback-863-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3]) [junit4] 2> 519987 INFO (zkCallback-857-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3]) [junit4] 2> 520906 INFO (qtp694529340-5244) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0 [junit4] 2> 520937 INFO (qtp694529340-5244) [ ] o.a.s.s.IndexSchema [collection1_shard1_replica_t43] Schema name=test [junit4] 2> 521031 INFO (qtp694529340-5244) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 521054 INFO (qtp694529340-5244) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard1_replica_t43' using configuration from collection collection1, trusted=true [junit4] 2> 521054 INFO (qtp694529340-5244) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1.shard1.replica_t43' (registry 'solr.core.collection1.shard1.replica_t43') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@133202d4 [junit4] 2> 521054 INFO (qtp694529340-5244) [ ] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 521054 INFO (qtp694529340-5244) [ ] o.a.s.c.SolrCore [[collection1_shard1_replica_t43] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.ForceLeaderTest_CF8D0105BDFF8979-001\shard-2-001\cores\collection1_shard1_replica_t43], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.ForceLeaderTest_CF8D0105BDFF8979-001\shard-2-001\cores\collection1_shard1_replica_t43\data\] [junit4] 2> 521056 INFO (qtp694529340-5244) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=10, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.2401738689316308] [junit4] 2> 521057 WARN (qtp694529340-5244) [ ] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}} [junit4] 2> 521108 INFO (qtp694529340-5244) [ ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 521108 INFO (qtp694529340-5244) [ ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 521110 INFO (qtp694529340-5244) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 521110 INFO (qtp694529340-5244) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 521110 INFO (qtp694529340-5244) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=30, maxMergeAtOnceExplicit=17, maxMergedSegmentMB=33.1142578125, floorSegmentMB=1.9912109375, forceMergeDeletesPctAllowed=9.488150556768307, segmentsPerTier=22.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0 [junit4] 2> 521110 INFO (qtp694529340-5244) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5e5bc527[collection1_shard1_replica_t43] main] [junit4] 2> 521113 INFO (qtp694529340-5244) [ ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 521113 INFO (qtp694529340-5244) [ ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 521113 INFO (qtp694529340-5244) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 521114 INFO (qtp694529340-5244) [ ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1575527935634309120 [junit4] 2> 521115 INFO (searcherExecutor-2297-thread-1) [ ] o.a.s.c.SolrCore [collection1_shard1_replica_t43] Registered new searcher Searcher@5e5bc527[collection1_shard1_replica_t43] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 521120 INFO (qtp694529340-5244) [ ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 521120 INFO (qtp694529340-5244) [ ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 521120 INFO (qtp694529340-5244) [ ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:59333/tt_p/ca/collection1_shard1_replica_t43/ [junit4] 2> 521120 INFO (qtp694529340-5244) [ ] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 521120 INFO (qtp694529340-5244) [ ] o.a.s.c.SyncStrategy http://127.0.0.1:59333/tt_p/ca/collection1_shard1_replica_t43/ has no replicas [junit4] 2> 521120 INFO (qtp694529340-5244) [ ] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR [junit4] 2> 521120 INFO (qtp694529340-5244) [ ] o.a.s.c.ZkController collection1_shard1_replica_t43 stopping background replication from leader [junit4] 2> 521122 INFO (qtp694529340-5244) [ ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:59333/tt_p/ca/collection1_shard1_replica_t43/ shard1 [junit4] 2> 521225 INFO (zkCallback-857-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3]) [junit4] 2> 521225 INFO (zkCallback-863-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3]) [junit4] 2> 521274 INFO (qtp694529340-5244) [ ] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 521276 INFO (qtp694529340-5244) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=conf1&name=collection1_shard1_replica_t43&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=TLOG} status=0 QTime=1396 [junit4] 2> 521279 INFO (qtp396609358-5162) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={node=127.0.0.1:59333_tt_p%252Fca&action=ADDREPLICA&collection=collection1&shard=shard1&type=TLOG&wt=javabin&version=2} status=0 QTime=1407 [junit4] 2> 521379 INFO (zkCallback-863-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3]) [junit4] 2> 521379 INFO (zkCallback-857-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3]) [junit4] 2> 521634 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 3 in directory C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.ForceLeaderTest_CF8D0105BDFF8979-001\shard-3-001 of type TLOG [junit4] 2> 521634 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028 [junit4] 2> 521635 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@37728c3d{/tt_p/ca,null,AVAILABLE} [junit4] 2> 521635 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@69f44810{HTTP/1.1,[http/1.1]}{127.0.0.1:59359} [junit4] 2> 521635 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.e.j.s.Server Started @522999ms [junit4] 2> 521635 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/tt_p/ca, solrconfig=solrconfig.xml, solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.ForceLeaderTest_CF8D0105BDFF8979-001\tempDir-001/jetty3, hostPort=59358, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.ForceLeaderTest_CF8D0105BDFF8979-001\shard-3-001\cores, replicaType=TLOG} [junit4] 2> 521638 ERROR (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 521638 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.1.0 [junit4] 2> 521638 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 521638 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config dir: null [junit4] 2> 521638 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-08-12T12:22:07.519045200Z [junit4] 2> 521642 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 521643 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.ForceLeaderTest_CF8D0105BDFF8979-001\shard-3-001\solr.xml [junit4] 2> 521650 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@133202d4, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 521653 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:59260/solr [junit4] 2> 521666 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 521669 INFO (TEST-ForceLeaderTest.testLastPublishedStateIsActive-seed#[CF8D0105BDFF8979]) [ ] o.a.s.c.Overseer Overseer (id=null) closing [jun [...truncated too long message...] release. [junit4] <<< JVM J1: EOF ---- [...truncated 815 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\temp\junit4-J0-20170812_130650_9316650162167624451654.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 21 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\temp\junit4-J1-20170812_130650_9316106268844106166512.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 1241 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\temp\junit4-J0-20170812_131033_2994044956860936602104.syserr [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\temp\junit4-J1-20170812_131033_2991557435370375998533.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 551 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analytics\test\temp\junit4-J0-20170812_131056_14316445882713199415266.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 3 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analytics\test\temp\junit4-J1-20170812_131056_1437753667554686646349.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 500 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-clustering\test\temp\junit4-J1-20170812_131143_64812536886897247054799.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 3 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-clustering\test\temp\junit4-J0-20170812_131143_64810921932906625499576.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 1130 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-dataimporthandler-extras\test\temp\junit4-J1-20170812_131219_7818609682153831824456.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 3 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-dataimporthandler-extras\test\temp\junit4-J0-20170812_131219_78113064888031564701950.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 593 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-dataimporthandler\test\temp\junit4-J1-20170812_131239_2279980709274035416817.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 3 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-dataimporthandler\test\temp\junit4-J0-20170812_131239_22717363230012388884153.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 501 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-cell\test\temp\junit4-J1-20170812_131325_0693138104069119615314.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 6 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-cell\test\temp\junit4-J0-20170812_131325_06912560178718403619897.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 506 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-langid\test\temp\junit4-J0-20170812_131349_70011934278292311047657.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-langid\test\temp\junit4-J1-20170812_131349_7005003658337534559023.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 595 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-ltr\test\temp\junit4-J0-20170812_131409_78916734217291757924850.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 3 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-ltr\test\temp\junit4-J1-20170812_131409_7893303864117350140134.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 538 lines...] [junit4] JVM J1: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-uima\test\temp\junit4-J1-20170812_131500_35216507953141272882987.syserr [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J1: EOF ---- [...truncated 3 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-uima\test\temp\junit4-J0-20170812_131500_35115531288415943725164.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 495 lines...] [junit4] JVM J0: stderr was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-velocity\test\temp\junit4-J0-20170812_131526_4856868656857773122187.syserr [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] Java HotSpot(TM) 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release. [junit4] <<< JVM J0: EOF ---- [...truncated 29015 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org