You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2018/03/26 17:53:07 UTC
[JENKINS] Lucene-Solr-7.x-Linux (64bit/jdk-9.0.4) - Build # 1596 -
Still Failing!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/1596/
Java: 64bit/jdk-9.0.4 -XX:-UseCompressedOops -XX:+UseParallelGC
1 tests failed.
FAILED: org.apache.lucene.spatial3d.TestGeo3DPoint.testGeo3DRelations
Error Message:
edge that ends in a crossing can't both up and down
Stack Trace:
java.lang.AssertionError: edge that ends in a crossing can't both up and down
at __randomizedtesting.SeedInfo.seed([4D9F621B36C94E0C:FDE01F8FB984E090]:0)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$DualCrossingEdgeIterator.countCrossingPoint(GeoComplexPolygon.java:1334)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$DualCrossingEdgeIterator.matches(GeoComplexPolygon.java:1283)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$Node.traverse(GeoComplexPolygon.java:564)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$Tree.traverse(GeoComplexPolygon.java:660)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$Tree.traverse(GeoComplexPolygon.java:646)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon.isWithin(GeoComplexPolygon.java:370)
at org.apache.lucene.spatial3d.geom.GeoBaseMembershipShape.isWithin(GeoBaseMembershipShape.java:36)
at org.apache.lucene.spatial3d.geom.GeoBaseShape.getBounds(GeoBaseShape.java:35)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon.getBounds(GeoComplexPolygon.java:440)
at org.apache.lucene.spatial3d.TestGeo3DPoint.testGeo3DRelations(TestGeo3DPoint.java:224)
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:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
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:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
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 1791 lines...]
[junit4] JVM J2: stdout was not empty, see: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/build/core/test/temp/junit4-J2-20180326_164736_2811974576501249460505.sysout
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] codec: Asserting, pf: Asserting, dvf: Lucene70
[junit4] <<< JVM J2: EOF ----
[...truncated 8386 lines...]
[junit4] Suite: org.apache.lucene.spatial3d.TestGeo3DPoint
[junit4] IGNOR/A 0.00s J1 | TestGeo3DPoint.testRandomBig
[junit4] > Assumption #1: 'nightly' test group is disabled (@Nightly())
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestGeo3DPoint -Dtests.method=testGeo3DRelations -Dtests.seed=4D9F621B36C94E0C -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=sn-ZW -Dtests.timezone=Atlantic/Reykjavik -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 1.32s J1 | TestGeo3DPoint.testGeo3DRelations <<<
[junit4] > Throwable #1: java.lang.AssertionError: edge that ends in a crossing can't both up and down
[junit4] > at __randomizedtesting.SeedInfo.seed([4D9F621B36C94E0C:FDE01F8FB984E090]:0)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$DualCrossingEdgeIterator.countCrossingPoint(GeoComplexPolygon.java:1334)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$DualCrossingEdgeIterator.matches(GeoComplexPolygon.java:1283)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$Node.traverse(GeoComplexPolygon.java:564)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$Tree.traverse(GeoComplexPolygon.java:660)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$Tree.traverse(GeoComplexPolygon.java:646)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoComplexPolygon.isWithin(GeoComplexPolygon.java:370)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoBaseMembershipShape.isWithin(GeoBaseMembershipShape.java:36)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoBaseShape.getBounds(GeoBaseShape.java:35)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoComplexPolygon.getBounds(GeoComplexPolygon.java:440)
[junit4] > at org.apache.lucene.spatial3d.TestGeo3DPoint.testGeo3DRelations(TestGeo3DPoint.java:224)
[junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] > at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] > at java.base/java.lang.reflect.Method.invoke(Method.java:564)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] 2> NOTE: test params are: codec=Lucene70, sim=RandomSimilarity(queryNorm=false): {}, locale=sn-ZW, timezone=Atlantic/Reykjavik
[junit4] 2> NOTE: Linux 4.13.0-36-generic amd64/Oracle Corporation 9.0.4 (64-bit)/cpus=8,threads=1,free=366163128,total=536346624
[junit4] 2> NOTE: All tests run in this JVM: [RandomGeoPolygonTest, TestGeo3DPoint]
[junit4] Completed [17/18 (1!)] on J1 in 60.58s, 14 tests, 1 failure, 1 skipped <<< FAILURES!
[...truncated 37942 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/build.xml:633: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/build.xml:122: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/build.xml:108: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/tools/custom-tasks.xml:108: java.lang.IllegalArgumentException: named capturing group is missing trailing '}'
at java.base/java.util.regex.Matcher.appendExpandedReplacement(Matcher.java:1052)
at java.base/java.util.regex.Matcher.appendReplacement(Matcher.java:908)
at org.apache.lucene.dependencies.InterpolatedProperties.interpolate(InterpolatedProperties.java:64)
at org.apache.lucene.dependencies.InterpolatedProperties.load(InterpolatedProperties.java:50)
at org.apache.lucene.validation.LibVersionsCheckTask.collectDirectDependencies(LibVersionsCheckTask.java:385)
at org.apache.lucene.validation.LibVersionsCheckTask.execute(LibVersionsCheckTask.java:220)
at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
at jdk.internal.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
at org.apache.tools.ant.Task.perform(Task.java:348)
at org.apache.tools.ant.taskdefs.Sequential.execute(Sequential.java:68)
at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
at jdk.internal.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
at org.apache.tools.ant.Task.perform(Task.java:348)
at org.apache.tools.ant.taskdefs.MacroInstance.execute(MacroInstance.java:398)
at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
at jdk.internal.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
at org.apache.tools.ant.Task.perform(Task.java:348)
at org.apache.tools.ant.Target.execute(Target.java:390)
at org.apache.tools.ant.Target.performTasks(Target.java:411)
at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1399)
at org.apache.tools.ant.helper.SingleCheckExecutor.executeTargets(SingleCheckExecutor.java:38)
at org.apache.tools.ant.Project.executeTargets(Project.java:1251)
at org.apache.tools.ant.taskdefs.Ant.execute(Ant.java:442)
at org.apache.tools.ant.taskdefs.SubAnt.execute(SubAnt.java:302)
at org.apache.tools.ant.taskdefs.SubAnt.execute(SubAnt.java:221)
at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
at jdk.internal.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
at org.apache.tools.ant.Task.perform(Task.java:348)
at org.apache.tools.ant.Target.execute(Target.java:390)
at org.apache.tools.ant.Target.performTasks(Target.java:411)
at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1399)
at org.apache.tools.ant.helper.SingleCheckExecutor.executeTargets(SingleCheckExecutor.java:38)
at org.apache.tools.ant.Project.executeTargets(Project.java:1251)
at org.apache.tools.ant.taskdefs.Ant.execute(Ant.java:442)
at org.apache.tools.ant.taskdefs.CallTarget.execute(CallTarget.java:105)
at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
at jdk.internal.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
at org.apache.tools.ant.Task.perform(Task.java:348)
at org.apache.tools.ant.Target.execute(Target.java:390)
at org.apache.tools.ant.Target.performTasks(Target.java:411)
at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1399)
at org.apache.tools.ant.Project.executeTarget(Project.java:1368)
at org.apache.tools.ant.helper.DefaultExecutor.executeTargets(DefaultExecutor.java:41)
at org.apache.tools.ant.Project.executeTargets(Project.java:1251)
at org.apache.tools.ant.Main.runBuild(Main.java:809)
at org.apache.tools.ant.Main.startAnt(Main.java:217)
at org.apache.tools.ant.launch.Launcher.run(Launcher.java:280)
at org.apache.tools.ant.launch.Launcher.main(Launcher.java:109)
Total time: 65 minutes 43 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[JENKINS] Lucene-Solr-7.x-Linux (32bit/jdk1.8.0_162) - Build # 1598
- Unstable!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/1598/
Java: 32bit/jdk1.8.0_162 -server -XX:+UseSerialGC
5 tests failed.
FAILED: org.apache.lucene.spatial3d.TestGeo3DPoint.testGeo3DRelations
Error Message:
assess edge that ends in a crossing can't both up and down
Stack Trace:
java.lang.AssertionError: assess edge that ends in a crossing can't both up and down
at __randomizedtesting.SeedInfo.seed([BACC479CC2D38CCA:AB33A084D9E2256]:0)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$DualCrossingEdgeIterator.countCrossingPoint(GeoComplexPolygon.java:1438)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$DualCrossingEdgeIterator.matches(GeoComplexPolygon.java:1283)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$Node.traverse(GeoComplexPolygon.java:564)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$Tree.traverse(GeoComplexPolygon.java:660)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$Tree.traverse(GeoComplexPolygon.java:646)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon.isWithin(GeoComplexPolygon.java:370)
at org.apache.lucene.spatial3d.geom.GeoBaseMembershipShape.isWithin(GeoBaseMembershipShape.java:36)
at org.apache.lucene.spatial3d.geom.GeoBaseShape.getBounds(GeoBaseShape.java:43)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon.getBounds(GeoComplexPolygon.java:440)
at org.apache.lucene.spatial3d.TestGeo3DPoint.testGeo3DRelations(TestGeo3DPoint.java:224)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
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:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
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 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.lang.Thread.run(Thread.java:748)
FAILED: org.apache.lucene.spatial3d.TestGeo3DPoint.testGeo3DRelations
Error Message:
assess edge that ends in a crossing can't both up and down
Stack Trace:
java.lang.AssertionError: assess edge that ends in a crossing can't both up and down
at __randomizedtesting.SeedInfo.seed([BACC479CC2D38CCA:AB33A084D9E2256]:0)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$DualCrossingEdgeIterator.countCrossingPoint(GeoComplexPolygon.java:1438)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$DualCrossingEdgeIterator.matches(GeoComplexPolygon.java:1283)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$Node.traverse(GeoComplexPolygon.java:564)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$Tree.traverse(GeoComplexPolygon.java:660)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$Tree.traverse(GeoComplexPolygon.java:646)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon.isWithin(GeoComplexPolygon.java:370)
at org.apache.lucene.spatial3d.geom.GeoBaseMembershipShape.isWithin(GeoBaseMembershipShape.java:36)
at org.apache.lucene.spatial3d.geom.GeoBaseShape.getBounds(GeoBaseShape.java:43)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon.getBounds(GeoComplexPolygon.java:440)
at org.apache.lucene.spatial3d.TestGeo3DPoint.testGeo3DRelations(TestGeo3DPoint.java:224)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
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:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
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 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.lang.Thread.run(Thread.java:748)
FAILED: org.apache.lucene.spatial3d.TestGeo3DPoint.testGeo3DRelations
Error Message:
assess edge that ends in a crossing can't both up and down
Stack Trace:
java.lang.AssertionError: assess edge that ends in a crossing can't both up and down
at __randomizedtesting.SeedInfo.seed([BACC479CC2D38CCA:AB33A084D9E2256]:0)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$DualCrossingEdgeIterator.countCrossingPoint(GeoComplexPolygon.java:1438)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$DualCrossingEdgeIterator.matches(GeoComplexPolygon.java:1283)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$Node.traverse(GeoComplexPolygon.java:564)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$Tree.traverse(GeoComplexPolygon.java:660)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$Tree.traverse(GeoComplexPolygon.java:646)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon.isWithin(GeoComplexPolygon.java:370)
at org.apache.lucene.spatial3d.geom.GeoBaseMembershipShape.isWithin(GeoBaseMembershipShape.java:36)
at org.apache.lucene.spatial3d.geom.GeoBaseShape.getBounds(GeoBaseShape.java:43)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon.getBounds(GeoComplexPolygon.java:440)
at org.apache.lucene.spatial3d.TestGeo3DPoint.testGeo3DRelations(TestGeo3DPoint.java:224)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
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:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
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 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.lang.Thread.run(Thread.java:748)
FAILED: org.apache.lucene.spatial3d.TestGeo3DPoint.testGeo3DRelations
Error Message:
assess edge that ends in a crossing can't both up and down
Stack Trace:
java.lang.AssertionError: assess edge that ends in a crossing can't both up and down
at __randomizedtesting.SeedInfo.seed([BACC479CC2D38CCA:AB33A084D9E2256]:0)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$DualCrossingEdgeIterator.countCrossingPoint(GeoComplexPolygon.java:1438)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$DualCrossingEdgeIterator.matches(GeoComplexPolygon.java:1283)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$Node.traverse(GeoComplexPolygon.java:564)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$Tree.traverse(GeoComplexPolygon.java:660)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$Tree.traverse(GeoComplexPolygon.java:646)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon.isWithin(GeoComplexPolygon.java:370)
at org.apache.lucene.spatial3d.geom.GeoBaseMembershipShape.isWithin(GeoBaseMembershipShape.java:36)
at org.apache.lucene.spatial3d.geom.GeoBaseShape.getBounds(GeoBaseShape.java:43)
at org.apache.lucene.spatial3d.geom.GeoComplexPolygon.getBounds(GeoComplexPolygon.java:440)
at org.apache.lucene.spatial3d.TestGeo3DPoint.testGeo3DRelations(TestGeo3DPoint.java:224)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
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:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
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 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.lang.Thread.run(Thread.java:748)
FAILED: org.apache.solr.cloud.autoscaling.NodeLostTriggerTest.testListenerAcceptance
Error Message:
expected:<1> but was:<0>
Stack Trace:
java.lang.AssertionError: expected:<1> but was:<0>
at __randomizedtesting.SeedInfo.seed([1499885FA502FD16:52DD2B81C8BE9E0]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at org.apache.solr.cloud.autoscaling.NodeLostTriggerTest.testListenerAcceptance(NodeLostTriggerTest.java:253)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
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:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
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 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.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 1781 lines...]
[junit4] JVM J0: stdout was not empty, see: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/build/core/test/temp/junit4-J0-20180327_005552_1211107913386088900107.sysout
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] codec: Lucene70, pf: Lucene50, dvf: Lucene70
[junit4] <<< JVM J0: EOF ----
[...truncated 8402 lines...]
[junit4] Suite: org.apache.lucene.spatial3d.TestGeo3DPoint
[junit4] IGNOR/A 0.00s J1 | TestGeo3DPoint.testRandomBig
[junit4] > Assumption #1: 'nightly' test group is disabled (@Nightly())
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestGeo3DPoint -Dtests.method=testGeo3DRelations -Dtests.seed=BACC479CC2D38CCA -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=lv -Dtests.timezone=SystemV/AST4ADT -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 2.27s J1 | TestGeo3DPoint.testGeo3DRelations <<<
[junit4] > Throwable #1: java.lang.AssertionError: assess edge that ends in a crossing can't both up and down
[junit4] > at __randomizedtesting.SeedInfo.seed([BACC479CC2D38CCA:AB33A084D9E2256]:0)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$DualCrossingEdgeIterator.countCrossingPoint(GeoComplexPolygon.java:1438)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$DualCrossingEdgeIterator.matches(GeoComplexPolygon.java:1283)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$Node.traverse(GeoComplexPolygon.java:564)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$Tree.traverse(GeoComplexPolygon.java:660)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$Tree.traverse(GeoComplexPolygon.java:646)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoComplexPolygon.isWithin(GeoComplexPolygon.java:370)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoBaseMembershipShape.isWithin(GeoBaseMembershipShape.java:36)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoBaseShape.getBounds(GeoBaseShape.java:43)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoComplexPolygon.getBounds(GeoComplexPolygon.java:440)
[junit4] > at org.apache.lucene.spatial3d.TestGeo3DPoint.testGeo3DRelations(TestGeo3DPoint.java:224)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {id=Lucene50(blocksize=128)}, docValues:{id=DocValuesFormat(name=Direct), point=DocValuesFormat(name=Lucene70)}, maxPointsInLeafNode=1082, maxMBSortInHeap=6.158794108376497, sim=RandomSimilarity(queryNorm=false): {}, locale=lv, timezone=SystemV/AST4ADT
[junit4] 2> NOTE: Linux 4.13.0-36-generic i386/Oracle Corporation 1.8.0_162 (32-bit)/cpus=8,threads=1,free=29621800,total=64946176
[junit4] 2> NOTE: All tests run in this JVM: [TestGeo3DPoint]
[junit4] Completed [16/18 (1!)] on J1 in 87.61s, 14 tests, 1 failure, 1 skipped <<< FAILURES!
[...truncated 2100 lines...]
[junit4] Suite: org.apache.solr.cloud.autoscaling.NodeLostTriggerTest
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.NodeLostTriggerTest_1499885FA502FD16-001/init-core-data-001
[junit4] 2> 133559 WARN (SUITE-NodeLostTriggerTest-seed#[1499885FA502FD16]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
[junit4] 2> 133560 INFO (SUITE-NodeLostTriggerTest-seed#[1499885FA502FD16]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 133561 INFO (SUITE-NodeLostTriggerTest-seed#[1499885FA502FD16]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 133562 INFO (SUITE-NodeLostTriggerTest-seed#[1499885FA502FD16]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 133562 INFO (SUITE-NodeLostTriggerTest-seed#[1499885FA502FD16]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 5 servers in /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.NodeLostTriggerTest_1499885FA502FD16-001/tempDir-001
[junit4] 2> 133562 INFO (SUITE-NodeLostTriggerTest-seed#[1499885FA502FD16]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 133562 INFO (Thread-337) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 133562 INFO (Thread-337) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 133574 ERROR (Thread-337) [ ] 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> 133662 INFO (SUITE-NodeLostTriggerTest-seed#[1499885FA502FD16]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:40467
[junit4] 2> 133664 INFO (zkConnectionManagerCallback-374-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 133668 INFO (jetty-launcher-371-thread-1) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-22T07:27:37+10:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 133670 INFO (jetty-launcher-371-thread-4) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-22T07:27:37+10:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 133670 INFO (jetty-launcher-371-thread-2) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-22T07:27:37+10:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 133671 INFO (jetty-launcher-371-thread-5) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-22T07:27:37+10:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 133678 INFO (jetty-launcher-371-thread-4) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 133678 INFO (jetty-launcher-371-thread-4) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 133678 INFO (jetty-launcher-371-thread-4) [ ] o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 133680 INFO (jetty-launcher-371-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@34b77d{/solr,null,AVAILABLE}
[junit4] 2> 133694 INFO (jetty-launcher-371-thread-3) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-22T07:27:37+10:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 133704 INFO (jetty-launcher-371-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 133704 INFO (jetty-launcher-371-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 133704 INFO (jetty-launcher-371-thread-1) [ ] o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 133704 INFO (jetty-launcher-371-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@a0021c{/solr,null,AVAILABLE}
[junit4] 2> 133704 INFO (jetty-launcher-371-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@87da56{SSL,[ssl, http/1.1]}{127.0.0.1:41429}
[junit4] 2> 133704 INFO (jetty-launcher-371-thread-4) [ ] o.e.j.s.Server Started @133732ms
[junit4] 2> 133704 INFO (jetty-launcher-371-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=41429}
[junit4] 2> 133705 INFO (jetty-launcher-371-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@e5d0a1{SSL,[ssl, http/1.1]}{127.0.0.1:36771}
[junit4] 2> 133705 INFO (jetty-launcher-371-thread-1) [ ] o.e.j.s.Server Started @133732ms
[junit4] 2> 133705 ERROR (jetty-launcher-371-thread-4) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 133705 INFO (jetty-launcher-371-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=36771}
[junit4] 2> 133705 INFO (jetty-launcher-371-thread-4) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 133705 INFO (jetty-launcher-371-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.4.0
[junit4] 2> 133705 INFO (jetty-launcher-371-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 133705 INFO (jetty-launcher-371-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 133705 ERROR (jetty-launcher-371-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 133705 INFO (jetty-launcher-371-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 133705 INFO (jetty-launcher-371-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-27T01:26:00.817Z
[junit4] 2> 133705 INFO (jetty-launcher-371-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.4.0
[junit4] 2> 133705 INFO (jetty-launcher-371-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 133705 INFO (jetty-launcher-371-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 133705 INFO (jetty-launcher-371-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-27T01:26:00.817Z
[junit4] 2> 133777 INFO (zkConnectionManagerCallback-376-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 133777 INFO (jetty-launcher-371-thread-5) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 133777 INFO (jetty-launcher-371-thread-5) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 133777 INFO (jetty-launcher-371-thread-5) [ ] o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 133777 INFO (jetty-launcher-371-thread-5) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@f11cef{/solr,null,AVAILABLE}
[junit4] 2> 133777 INFO (jetty-launcher-371-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 133778 INFO (jetty-launcher-371-thread-5) [ ] o.e.j.s.AbstractConnector Started ServerConnector@11b9630{SSL,[ssl, http/1.1]}{127.0.0.1:42199}
[junit4] 2> 133778 INFO (jetty-launcher-371-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 133778 INFO (jetty-launcher-371-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 133778 INFO (jetty-launcher-371-thread-5) [ ] o.e.j.s.Server Started @133805ms
[junit4] 2> 133778 INFO (jetty-launcher-371-thread-2) [ ] o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 133778 INFO (jetty-launcher-371-thread-5) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=42199}
[junit4] 2> 133778 ERROR (jetty-launcher-371-thread-5) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 133778 INFO (jetty-launcher-371-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@91aefd{/solr,null,AVAILABLE}
[junit4] 2> 133778 INFO (jetty-launcher-371-thread-5) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 133778 INFO (jetty-launcher-371-thread-5) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.4.0
[junit4] 2> 133778 INFO (jetty-launcher-371-thread-5) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 133778 INFO (jetty-launcher-371-thread-5) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 133779 INFO (jetty-launcher-371-thread-5) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-27T01:26:00.890Z
[junit4] 2> 133779 INFO (jetty-launcher-371-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@f21a0f{SSL,[ssl, http/1.1]}{127.0.0.1:38325}
[junit4] 2> 133779 INFO (jetty-launcher-371-thread-2) [ ] o.e.j.s.Server Started @133806ms
[junit4] 2> 133779 INFO (jetty-launcher-371-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=38325}
[junit4] 2> 133779 ERROR (jetty-launcher-371-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 133779 INFO (jetty-launcher-371-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 133779 INFO (jetty-launcher-371-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.4.0
[junit4] 2> 133779 INFO (jetty-launcher-371-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 133779 INFO (jetty-launcher-371-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 133779 INFO (jetty-launcher-371-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-27T01:26:00.891Z
[junit4] 2> 133779 INFO (jetty-launcher-371-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 133779 INFO (jetty-launcher-371-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 133779 INFO (jetty-launcher-371-thread-3) [ ] o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 133780 INFO (jetty-launcher-371-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@150b8a2{/solr,null,AVAILABLE}
[junit4] 2> 133781 INFO (zkConnectionManagerCallback-380-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 133782 INFO (zkConnectionManagerCallback-378-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 133782 INFO (jetty-launcher-371-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1a6aa47{SSL,[ssl, http/1.1]}{127.0.0.1:38187}
[junit4] 2> 133782 INFO (jetty-launcher-371-thread-3) [ ] o.e.j.s.Server Started @133809ms
[junit4] 2> 133782 INFO (jetty-launcher-371-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=38187}
[junit4] 2> 133782 INFO (jetty-launcher-371-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 133782 ERROR (jetty-launcher-371-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 133782 INFO (jetty-launcher-371-thread-3) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 133782 INFO (jetty-launcher-371-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.4.0
[junit4] 2> 133782 INFO (jetty-launcher-371-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 133782 INFO (jetty-launcher-371-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 133782 INFO (jetty-launcher-371-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-27T01:26:00.894Z
[junit4] 2> 133783 INFO (jetty-launcher-371-thread-5) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 133786 INFO (jetty-launcher-371-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40467/solr
[junit4] 2> 133792 INFO (zkConnectionManagerCallback-388-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 133798 INFO (zkConnectionManagerCallback-384-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 133798 INFO (jetty-launcher-371-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 133804 INFO (jetty-launcher-371-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40467/solr
[junit4] 2> 133805 INFO (zkConnectionManagerCallback-382-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 133806 INFO (jetty-launcher-371-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 133817 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x100863432990005, likely client has closed socket
[junit4] 2> 133817 INFO (zkConnectionManagerCallback-392-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 133819 INFO (jetty-launcher-371-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40467/solr
[junit4] 2> 133822 INFO (zkConnectionManagerCallback-394-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 133822 INFO (zkConnectionManagerCallback-399-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 133823 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x100863432990009, likely client has closed socket
[junit4] 2> 133823 INFO (jetty-launcher-371-thread-5) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40467/solr
[junit4] 2> 133823 INFO (zkConnectionManagerCallback-401-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 133831 INFO (zkConnectionManagerCallback-404-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 133831 INFO (jetty-launcher-371-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40467/solr
[junit4] 2> 133838 INFO (jetty-launcher-371-thread-1) [n:127.0.0.1:36771_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 133850 INFO (jetty-launcher-371-thread-1) [n:127.0.0.1:36771_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:36771_solr
[junit4] 2> 133851 INFO (jetty-launcher-371-thread-1) [n:127.0.0.1:36771_solr ] o.a.s.c.Overseer Overseer (id=72205152783237130-127.0.0.1:36771_solr-n_0000000000) starting
[junit4] 2> 133857 INFO (zkConnectionManagerCallback-411-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 133860 INFO (zkConnectionManagerCallback-408-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 133861 INFO (zkConnectionManagerCallback-414-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 133861 INFO (zkConnectionManagerCallback-420-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 133863 INFO (jetty-launcher-371-thread-1) [n:127.0.0.1:36771_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:40467/solr ready
[junit4] 2> 133863 INFO (zkConnectionManagerCallback-418-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 133864 INFO (jetty-launcher-371-thread-1) [n:127.0.0.1:36771_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:36771_solr
[junit4] 2> 133867 INFO (jetty-launcher-371-thread-5) [n:127.0.0.1:42199_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 133868 INFO (jetty-launcher-371-thread-2) [n:127.0.0.1:38325_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 133870 INFO (jetty-launcher-371-thread-5) [n:127.0.0.1:42199_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 133870 INFO (jetty-launcher-371-thread-3) [n:127.0.0.1:38187_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 133871 INFO (jetty-launcher-371-thread-2) [n:127.0.0.1:38325_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 133871 INFO (jetty-launcher-371-thread-5) [n:127.0.0.1:42199_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:42199_solr
[junit4] 2> 133874 INFO (zkCallback-419-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 133875 INFO (jetty-launcher-371-thread-3) [n:127.0.0.1:38187_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 133878 INFO (jetty-launcher-371-thread-3) [n:127.0.0.1:38187_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:38187_solr
[junit4] 2> 133882 INFO (jetty-launcher-371-thread-4) [n:127.0.0.1:41429_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 133883 INFO (jetty-launcher-371-thread-4) [n:127.0.0.1:41429_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 133884 INFO (jetty-launcher-371-thread-4) [n:127.0.0.1:41429_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:41429_solr
[junit4] 2> 133885 INFO (OverseerStateUpdate-72205152783237130-127.0.0.1:36771_solr-n_0000000000) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 133903 INFO (zkCallback-419-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (4)
[junit4] 2> 133909 INFO (jetty-launcher-371-thread-2) [n:127.0.0.1:38325_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:38325_solr
[junit4] 2> 133922 INFO (zkCallback-413-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (4)
[junit4] 2> 133924 INFO (zkCallback-413-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 133925 INFO (zkCallback-393-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (5)
[junit4] 2> 133932 INFO (zkCallback-407-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (5)
[junit4] 2> 133950 INFO (zkCallback-400-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (5)
[junit4] 2> 133957 INFO (zkCallback-419-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 133990 INFO (zkCallback-417-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (5)
[junit4] 2> 134470 INFO (jetty-launcher-371-thread-5) [n:127.0.0.1:42199_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42199.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e1ed2
[junit4] 2> 134504 INFO (jetty-launcher-371-thread-5) [n:127.0.0.1:42199_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42199.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e1ed2
[junit4] 2> 134504 INFO (jetty-launcher-371-thread-5) [n:127.0.0.1:42199_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42199.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e1ed2
[junit4] 2> 134505 INFO (jetty-launcher-371-thread-5) [n:127.0.0.1:42199_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.NodeLostTriggerTest_1499885FA502FD16-001/tempDir-001/node5/.
[junit4] 2> 134576 INFO (jetty-launcher-371-thread-3) [n:127.0.0.1:38187_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38187.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e1ed2
[junit4] 2> 134603 INFO (jetty-launcher-371-thread-3) [n:127.0.0.1:38187_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38187.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e1ed2
[junit4] 2> 134603 INFO (jetty-launcher-371-thread-3) [n:127.0.0.1:38187_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38187.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e1ed2
[junit4] 2> 134605 INFO (jetty-launcher-371-thread-3) [n:127.0.0.1:38187_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.NodeLostTriggerTest_1499885FA502FD16-001/tempDir-001/node3/.
[junit4] 2> 134617 INFO (zkConnectionManagerCallback-427-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 134618 INFO (jetty-launcher-371-thread-5) [n:127.0.0.1:42199_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5)
[junit4] 2> 134618 INFO (jetty-launcher-371-thread-5) [n:127.0.0.1:42199_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:40467/solr ready
[junit4] 2> 134736 INFO (zkConnectionManagerCallback-431-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 134742 INFO (jetty-launcher-371-thread-3) [n:127.0.0.1:38187_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5)
[junit4] 2> 134742 INFO (jetty-launcher-371-thread-3) [n:127.0.0.1:38187_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:40467/solr ready
[junit4] 2> 135036 INFO (jetty-launcher-371-thread-4) [n:127.0.0.1:41429_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41429.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e1ed2
[junit4] 2> 135043 INFO (jetty-launcher-371-thread-4) [n:127.0.0.1:41429_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41429.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e1ed2
[junit4] 2> 135043 INFO (jetty-launcher-371-thread-4) [n:127.0.0.1:41429_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41429.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e1ed2
[junit4] 2> 135044 INFO (jetty-launcher-371-thread-4) [n:127.0.0.1:41429_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.NodeLostTriggerTest_1499885FA502FD16-001/tempDir-001/node4/.
[junit4] 2> 135057 INFO (zkConnectionManagerCallback-435-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 135058 INFO (jetty-launcher-371-thread-4) [n:127.0.0.1:41429_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5)
[junit4] 2> 135059 INFO (jetty-launcher-371-thread-4) [n:127.0.0.1:41429_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:40467/solr ready
[junit4] 2> 135498 INFO (jetty-launcher-371-thread-1) [n:127.0.0.1:36771_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36771.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e1ed2
[junit4] 2> 135513 INFO (jetty-launcher-371-thread-1) [n:127.0.0.1:36771_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36771.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e1ed2
[junit4] 2> 135513 INFO (jetty-launcher-371-thread-1) [n:127.0.0.1:36771_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36771.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e1ed2
[junit4] 2> 135514 INFO (jetty-launcher-371-thread-1) [n:127.0.0.1:36771_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.NodeLostTriggerTest_1499885FA502FD16-001/tempDir-001/node1/.
[junit4] 2> 136125 INFO (jetty-launcher-371-thread-2) [n:127.0.0.1:38325_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38325.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e1ed2
[junit4] 2> 136130 INFO (jetty-launcher-371-thread-2) [n:127.0.0.1:38325_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38325.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e1ed2
[junit4] 2> 136131 INFO (jetty-launcher-371-thread-2) [n:127.0.0.1:38325_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38325.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e1ed2
[junit4] 2> 136132 INFO (jetty-launcher-371-thread-2) [n:127.0.0.1:38325_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.NodeLostTriggerTest_1499885FA502FD16-001/tempDir-001/node2/.
[junit4] 2> 136134 INFO (zkConnectionManagerCallback-439-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 136135 INFO (jetty-launcher-371-thread-2) [n:127.0.0.1:38325_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5)
[junit4] 2> 136135 INFO (jetty-launcher-371-thread-2) [n:127.0.0.1:38325_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:40467/solr ready
[junit4] 2> 136168 INFO (zkConnectionManagerCallback-441-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 136170 INFO (zkConnectionManagerCallback-445-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 136171 INFO (SUITE-NodeLostTriggerTest-seed#[1499885FA502FD16]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5)
[junit4] 2> 136171 INFO (SUITE-NodeLostTriggerTest-seed#[1499885FA502FD16]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:40467/solr ready
[junit4] 2> 136201 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testTrigger
[junit4] 2> 136219 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@1a6aa47{SSL,[ssl, http/1.1]}{127.0.0.1:0}
[junit4] 2> 136219 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=25196945
[junit4] 2> 136219 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 136219 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1a56d3b: rootName = solr_38187, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@12bcc9
[junit4] 2> 136225 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 136225 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@63131e: rootName = solr_38187, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@d836dd
[junit4] 2> 136228 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 136228 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@cbb775: rootName = solr_38187, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@e7bfde
[junit4] 2> 136229 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:38187_solr
[junit4] 2> 136230 INFO (zkCallback-400-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 136230 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 136230 INFO (zkCallback-413-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 136230 INFO (zkCallback-419-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 136230 INFO (zkCallback-407-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 136230 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 136230 INFO (zkCallback-417-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 136230 INFO (zkCallback-393-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 136231 INFO (zkCallback-444-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 136231 INFO (zkCallback-438-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 136231 INFO (zkCallback-426-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 136231 INFO (zkCallback-434-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 136232 INFO (zkCallback-430-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 136232 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@150b8a2{/solr,null,UNAVAILABLE}
[junit4] 2> 136233 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.e.j.s.session Stopped scavenging
[junit4] 2> 136233 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@87da56{SSL,[ssl, http/1.1]}{127.0.0.1:0}
[junit4] 2> 136234 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=12522997
[junit4] 2> 136234 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 136234 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1d28728: rootName = solr_41429, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@80f4fd
[junit4] 2> 136239 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 136239 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@318381: rootName = solr_41429, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@d836dd
[junit4] 2> 136249 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 136249 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@10d6c8a: rootName = solr_41429, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@e7bfde
[junit4] 2> 136250 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:41429_solr
[junit4] 2> 136251 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 136251 INFO (zkCallback-400-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 136251 INFO (zkCallback-426-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 136251 INFO (zkCallback-393-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 136251 INFO (zkCallback-438-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 136251 INFO (zkCallback-407-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 136251 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 136251 INFO (zkCallback-434-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 136251 INFO (zkCallback-419-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 136251 INFO (zkCallback-413-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 136251 INFO (zkCallback-444-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 136253 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@34b77d{/solr,null,UNAVAILABLE}
[junit4] 2> 136253 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.e.j.s.session Stopped scavenging
[junit4] 2> 143257 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@e5d0a1{SSL,[ssl, http/1.1]}{127.0.0.1:0}
[junit4] 2> 143258 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=29063630
[junit4] 2> 143258 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 143258 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@145ab1c: rootName = solr_36771, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@11e7db6
[junit4] 2> 143264 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 143264 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1d65fdc: rootName = solr_36771, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@d836dd
[junit4] 2> 143268 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 143268 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@bd66c8: rootName = solr_36771, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@e7bfde
[junit4] 2> 143269 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:36771_solr
[junit4] 2> 143269 INFO (zkCallback-444-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 143269 INFO (zkCallback-419-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 143269 INFO (zkCallback-413-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 143269 INFO (zkCallback-426-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 143269 INFO (zkCallback-407-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 143269 INFO (zkCallback-438-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 143269 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 143269 INFO (zkCallback-400-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 143270 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 143270 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.c.Overseer Overseer (id=72205152783237130-127.0.0.1:36771_solr-n_0000000000) closing
[junit4] 2> 143270 INFO (OverseerStateUpdate-72205152783237130-127.0.0.1:36771_solr-n_0000000000) [ ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:36771_solr
[junit4] 2> 143271 WARN (OverseerAutoScalingTriggerThread-72205152783237130-127.0.0.1:36771_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 143273 INFO (zkCallback-413-thread-2) [ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:42199_solr
[junit4] 2> 143273 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@a0021c{/solr,null,UNAVAILABLE}
[junit4] 2> 143273 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.e.j.s.session Stopped scavenging
[junit4] 2> 143274 INFO (zkCallback-413-thread-2) [ ] o.a.s.c.Overseer Overseer (id=72205152783237134-127.0.0.1:42199_solr-n_0000000001) starting
[junit4] 2> 143275 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-22T07:27:37+10:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 143276 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 143276 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 143276 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 143276 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@137e134{/solr,null,AVAILABLE}
[junit4] 2> 143277 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@18875f1{SSL,[ssl, http/1.1]}{127.0.0.1:36771}
[junit4] 2> 143277 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.e.j.s.Server Started @143304ms
[junit4] 2> 143277 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=36771}
[junit4] 2> 143277 ERROR (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 143277 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 143277 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.4.0
[junit4] 2> 143277 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 143277 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 143277 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-27T01:26:10.389Z
[junit4] 2> 143281 INFO (zkConnectionManagerCallback-447-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 143282 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 143289 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40467/solr
[junit4] 2> 143290 INFO (zkConnectionManagerCallback-451-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 143291 INFO (zkConnectionManagerCallback-453-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 143295 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [n:127.0.0.1:36771_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 143296 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [n:127.0.0.1:36771_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 143297 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [n:127.0.0.1:36771_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:36771_solr
[junit4] 2> 143298 INFO (zkCallback-444-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 143298 INFO (zkCallback-426-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 143298 INFO (zkCallback-407-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 143298 INFO (zkCallback-413-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 143298 INFO (zkCallback-438-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 143299 INFO (zkCallback-452-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 144088 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [n:127.0.0.1:36771_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36771.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e1ed2
[junit4] 2> 144096 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [n:127.0.0.1:36771_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36771.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e1ed2
[junit4] 2> 144096 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [n:127.0.0.1:36771_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36771.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e1ed2
[junit4] 2> 144098 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [n:127.0.0.1:36771_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.NodeLostTriggerTest_1499885FA502FD16-001/tempDir-001/node1/.
[junit4] 2> 144101 INFO (zkConnectionManagerCallback-458-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 144102 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [n:127.0.0.1:36771_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 144102 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [n:127.0.0.1:36771_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:40467/solr ready
[junit4] 2> 149133 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[1499885FA502FD16]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testTrigger
[junit4] 2> 149156 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testListenerAcceptance
[junit4] 2> 149158 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-22T07:27:37+10:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 149182 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 149182 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 149182 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [ ] o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 149194 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@71ec31{/solr,null,AVAILABLE}
[junit4] 2> 149194 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1dc1105{SSL,[ssl, http/1.1]}{127.0.0.1:40487}
[junit4] 2> 149194 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [ ] o.e.j.s.Server Started @149222ms
[junit4] 2> 149194 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=40487}
[junit4] 2> 149195 ERROR (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 149195 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 149196 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.4.0
[junit4] 2> 149196 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 149196 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 149196 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-27T01:26:16.308Z
[junit4] 2> 149237 INFO (zkConnectionManagerCallback-460-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 149238 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 149262 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40467/solr
[junit4] 2> 149277 INFO (zkConnectionManagerCallback-464-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 149294 INFO (zkConnectionManagerCallback-466-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 149298 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [n:127.0.0.1:40487_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 149298 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [n:127.0.0.1:40487_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 149300 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [n:127.0.0.1:40487_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:40487_solr
[junit4] 2> 149300 INFO (zkCallback-444-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 149300 INFO (zkCallback-426-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 149300 INFO (zkCallback-452-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 149300 INFO (zkCallback-407-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 149301 INFO (zkCallback-413-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 149306 INFO (zkCallback-438-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 149308 INFO (zkCallback-457-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 149310 INFO (zkCallback-465-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 150867 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [n:127.0.0.1:40487_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_40487.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e1ed2
[junit4] 2> 150875 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [n:127.0.0.1:40487_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_40487.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e1ed2
[junit4] 2> 150876 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [n:127.0.0.1:40487_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_40487.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e1ed2
[junit4] 2> 150877 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [n:127.0.0.1:40487_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.NodeLostTriggerTest_1499885FA502FD16-001/tempDir-001/node6/.
[junit4] 2> 150880 INFO (zkConnectionManagerCallback-471-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 150881 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [n:127.0.0.1:40487_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 150881 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [n:127.0.0.1:40487_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:40467/solr ready
[junit4] 2> 150937 INFO (zkConnectionManagerCallback-473-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 150939 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@1dc1105{SSL,[ssl, http/1.1]}{127.0.0.1:0}
[junit4] 2> 150939 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=21860105
[junit4] 2> 150939 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 150939 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1676163: rootName = solr_40487, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@e4dd89
[junit4] 2> 150951 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 150951 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@bc72b: rootName = solr_40487, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@d836dd
[junit4] 2> 150956 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 150956 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@11ec65c: rootName = solr_40487, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@e7bfde
[junit4] 2> 150957 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:40487_solr
[junit4] 2> 150957 INFO (zkCallback-444-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 150957 INFO (zkCallback-438-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 150957 INFO (zkCallback-452-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 150958 INFO (zkCallback-457-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 150958 INFO (zkCallback-407-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 150958 INFO (zkCallback-413-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 150958 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 150958 INFO (zkCallback-465-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 150958 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 150966 INFO (zkCallback-470-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 150966 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@71ec31{/solr,null,UNAVAILABLE}
[junit4] 2> 150966 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [ ] o.e.j.s.session Stopped scavenging
[junit4] 2> 150968 INFO (zkConnectionManagerCallback-475-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 150969 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[1499885FA502FD16]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testListenerAcceptance
[junit4] 2> 150971 INFO (zkCallback-426-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=NodeLostTriggerTest -Dtests.method=testListenerAcceptance -Dtests.seed=1499885FA502FD16 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=es-AR -Dtests.timezone=Asia/Tbilisi -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] FAILURE 1.84s J2 | NodeLostTriggerTest.testListenerAcceptance <<<
[junit4] > Throwable #1: java.lang.AssertionError: expected:<1> but was:<0>
[junit4] > at __randomizedtesting.SeedInfo.seed([1499885FA502FD16:52DD2B81C8BE9E0]:0)
[junit4] > at org.apache.solr.cloud.autoscaling.NodeLostTriggerTest.testListenerAcceptance(NodeLostTriggerTest.java:253)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 150990 INFO (TEST-NodeLostTriggerTest.testActionLifecycle-seed#[1499885FA502FD16]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testActionLifecycle
[junit4] 2> 150991 INFO (TEST-NodeLostTriggerTest.testActionLifecycle-seed#[1499885FA502FD16]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testActionLifecycle
[junit4] 2> 151010 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[1499885FA502FD16]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testRestoreState
[junit4] 2> 151012 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[1499885FA502FD16]) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-22T07:27:37+10:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 151014 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[1499885FA502FD16]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 151014 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[1499885FA502FD16]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 151014 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[1499885FA502FD16]) [ ] o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 151015 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[1499885FA502FD16]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@15db57{/solr,null,AVAILABLE}
[junit4] 2> 151015 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[1499885FA502FD16]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@e107f5{SSL,[ssl, http/1.1]}{127.0.0.1:35835}
[junit4] 2> 151015 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[1499885FA502FD16]) [ ] o.e.j.s.Server Started @151042ms
[junit4] 2> 151015 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[1499885FA502FD16]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=35835}
[junit4] 2> 151016 ERROR (TEST-NodeLostTriggerTest.testRestoreState-seed#[1499885FA502FD16]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 151016 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[1499885FA502FD16]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 151016 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[1499885FA502FD16]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.4.0
[junit4] 2> 151016 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[1499885FA502FD16]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 151016 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[1499885FA502FD16]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 151016 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[1499885FA502FD16]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-27T01:26:18.128Z
[junit4] 2> 151020 INFO (zkConnectionManagerCallback-477-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 151020 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[1499885FA502FD16]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[...truncated too long message...]
ape.java:36)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoBaseShape.getBounds(GeoBaseShape.java:43)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoComplexPolygon.getBounds(GeoComplexPolygon.java:440)
[junit4] > at org.apache.lucene.spatial3d.TestGeo3DPoint.testGeo3DRelations(TestGeo3DPoint.java:224)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] OK 0.01s J1 | TestGeo3DPoint.testEncodeDecodeIsStable
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {id=Lucene50(blocksize=128)}, docValues:{id=DocValuesFormat(name=Direct), point=DocValuesFormat(name=Lucene70)}, maxPointsInLeafNode=1082, maxMBSortInHeap=6.158794108376497, sim=RandomSimilarity(queryNorm=false): {}, locale=lv, timezone=SystemV/AST4ADT
[junit4] 2> NOTE: Linux 4.13.0-36-generic i386/Oracle Corporation 1.8.0_162 (32-bit)/cpus=8,threads=1,free=41742800,total=64946176
[junit4] 2> NOTE: All tests run in this JVM: [TestGeo3DPoint]
[junit4] Completed [3/5 (3!)] on J1 in 92.51s, 14 tests, 1 failure, 1 skipped <<< FAILURES!
[...truncated 3 lines...]
[junit4] Suite: org.apache.lucene.spatial3d.TestGeo3DPoint
[junit4] OK 0.01s J2 | TestGeo3DPoint.testBasic
[junit4] OK 0.00s J2 | TestGeo3DPoint.testToString
[junit4] OK 86.1s J2 | TestGeo3DPoint.testRandomMedium
[junit4] IGNOR/A 0.00s J2 | TestGeo3DPoint.testRandomBig
[junit4] > Assumption #1: 'nightly' test group is disabled (@Nightly())
[junit4] OK 0.17s J2 | TestGeo3DPoint.testRandomTiny
[junit4] OK 0.01s J2 | TestGeo3DPoint.testComplexPolygons
[junit4] OK 1.88s J2 | TestGeo3DPoint.testEncodeDecodeRoundsDown
[junit4] OK 0.50s J2 | TestGeo3DPoint.testEncodeDecodeCeil
[junit4] OK 0.22s J2 | TestGeo3DPoint.testQuantization
[junit4] OK 0.00s J2 | TestGeo3DPoint.testShapeQueryToString
[junit4] OK 0.00s J2 | TestGeo3DPoint.testPolygonOrdering
[junit4] OK 0.00s J2 | TestGeo3DPoint.testEquals
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestGeo3DPoint -Dtests.method=testGeo3DRelations -Dtests.seed=BACC479CC2D38CCA -Dtests.multiplier=3 -Dtests.slow=true -Dtests.badapples=true -Dtests.locale=lv -Dtests.timezone=SystemV/AST4ADT -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 2.14s J2 | TestGeo3DPoint.testGeo3DRelations <<<
[junit4] > Throwable #1: java.lang.AssertionError: assess edge that ends in a crossing can't both up and down
[junit4] > at __randomizedtesting.SeedInfo.seed([BACC479CC2D38CCA:AB33A084D9E2256]:0)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$DualCrossingEdgeIterator.countCrossingPoint(GeoComplexPolygon.java:1438)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$DualCrossingEdgeIterator.matches(GeoComplexPolygon.java:1283)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$Node.traverse(GeoComplexPolygon.java:564)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$Tree.traverse(GeoComplexPolygon.java:660)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$Tree.traverse(GeoComplexPolygon.java:646)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoComplexPolygon.isWithin(GeoComplexPolygon.java:370)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoBaseMembershipShape.isWithin(GeoBaseMembershipShape.java:36)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoBaseShape.getBounds(GeoBaseShape.java:43)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoComplexPolygon.getBounds(GeoComplexPolygon.java:440)
[junit4] > at org.apache.lucene.spatial3d.TestGeo3DPoint.testGeo3DRelations(TestGeo3DPoint.java:224)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] OK 0.01s J2 | TestGeo3DPoint.testEncodeDecodeIsStable
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {id=Lucene50(blocksize=128)}, docValues:{id=DocValuesFormat(name=Direct), point=DocValuesFormat(name=Lucene70)}, maxPointsInLeafNode=1082, maxMBSortInHeap=6.158794108376497, sim=RandomSimilarity(queryNorm=false): {}, locale=lv, timezone=SystemV/AST4ADT
[junit4] 2> NOTE: Linux 4.13.0-36-generic i386/Oracle Corporation 1.8.0_162 (32-bit)/cpus=8,threads=1,free=20700184,total=64946176
[junit4] 2> NOTE: All tests run in this JVM: [TestGeo3DPoint, TestGeo3DPoint]
[junit4] Completed [4/5 (4!)] on J2 in 91.09s, 14 tests, 1 failure, 1 skipped <<< FAILURES!
[...truncated 1 lines...]
[junit4] Suite: org.apache.lucene.spatial3d.TestGeo3DPoint
[junit4] OK 0.01s J0 | TestGeo3DPoint.testBasic
[junit4] OK 0.02s J0 | TestGeo3DPoint.testToString
[junit4] OK 85.2s J0 | TestGeo3DPoint.testRandomMedium
[junit4] IGNOR/A 0.00s J0 | TestGeo3DPoint.testRandomBig
[junit4] > Assumption #1: 'nightly' test group is disabled (@Nightly())
[junit4] OK 0.21s J0 | TestGeo3DPoint.testRandomTiny
[junit4] OK 0.01s J0 | TestGeo3DPoint.testComplexPolygons
[junit4] OK 1.67s J0 | TestGeo3DPoint.testEncodeDecodeRoundsDown
[junit4] OK 0.47s J0 | TestGeo3DPoint.testEncodeDecodeCeil
[junit4] OK 0.24s J0 | TestGeo3DPoint.testQuantization
[junit4] OK 0.00s J0 | TestGeo3DPoint.testShapeQueryToString
[junit4] OK 0.00s J0 | TestGeo3DPoint.testPolygonOrdering
[junit4] OK 0.00s J0 | TestGeo3DPoint.testEquals
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestGeo3DPoint -Dtests.method=testGeo3DRelations -Dtests.seed=BACC479CC2D38CCA -Dtests.multiplier=3 -Dtests.slow=true -Dtests.badapples=true -Dtests.locale=lv -Dtests.timezone=SystemV/AST4ADT -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 2.42s J0 | TestGeo3DPoint.testGeo3DRelations <<<
[junit4] > Throwable #1: java.lang.AssertionError: assess edge that ends in a crossing can't both up and down
[junit4] > at __randomizedtesting.SeedInfo.seed([BACC479CC2D38CCA:AB33A084D9E2256]:0)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$DualCrossingEdgeIterator.countCrossingPoint(GeoComplexPolygon.java:1438)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$DualCrossingEdgeIterator.matches(GeoComplexPolygon.java:1283)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$Node.traverse(GeoComplexPolygon.java:564)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$Tree.traverse(GeoComplexPolygon.java:660)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$Tree.traverse(GeoComplexPolygon.java:646)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoComplexPolygon.isWithin(GeoComplexPolygon.java:370)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoBaseMembershipShape.isWithin(GeoBaseMembershipShape.java:36)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoBaseShape.getBounds(GeoBaseShape.java:43)
[junit4] > at org.apache.lucene.spatial3d.geom.GeoComplexPolygon.getBounds(GeoComplexPolygon.java:440)
[junit4] > at org.apache.lucene.spatial3d.TestGeo3DPoint.testGeo3DRelations(TestGeo3DPoint.java:224)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] OK 0.01s J0 | TestGeo3DPoint.testEncodeDecodeIsStable
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {id=Lucene50(blocksize=128)}, docValues:{id=DocValuesFormat(name=Direct), point=DocValuesFormat(name=Lucene70)}, maxPointsInLeafNode=1082, maxMBSortInHeap=6.158794108376497, sim=RandomSimilarity(queryNorm=false): {}, locale=lv, timezone=SystemV/AST4ADT
[junit4] 2> NOTE: Linux 4.13.0-36-generic i386/Oracle Corporation 1.8.0_162 (32-bit)/cpus=8,threads=1,free=20279960,total=64946176
[junit4] 2> NOTE: All tests run in this JVM: [TestGeo3DPoint, TestGeo3DPoint]
[junit4] Completed [5/5 (5!)] on J0 in 90.32s, 14 tests, 1 failure, 1 skipped <<< FAILURES!
[...truncated 15 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/common-build.xml:1568: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/common-build.xml:1092: There were test failures: 5 suites, 70 tests, 5 failures, 5 ignored (5 assumptions) [seed: BACC479CC2D38CCA]
Total time: 3 minutes 5 seconds
[repro] Setting last failure code to 256
[repro] Failures:
[repro] 0/5 failed: org.apache.solr.cloud.autoscaling.NodeLostTriggerTest
[repro] 5/5 failed: org.apache.lucene.spatial3d.TestGeo3DPoint
[repro] Exiting with code 256
+ mv lucene/build lucene/build.repro
+ mv solr/build solr/build.repro
+ mv lucene/build.orig lucene/build
+ mv solr/build.orig solr/build
Archiving artifacts
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
<Git Blamer> Using GitBlamer to create author and commit information for all warnings.
<Git Blamer> GIT_COMMIT=43796e516932881da7abbc8cc379ec2661020f7e, workspace=/var/lib/jenkins/workspace/Lucene-Solr-7.x-Linux
[WARNINGS] Computing warning deltas based on reference build #1593
Recording test results
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[JENKINS] Lucene-Solr-7.x-Linux (64bit/jdk-9.0.4) - Build # 1597 -
Still Failing!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/1597/
Java: 64bit/jdk-9.0.4 -XX:+UseCompressedOops -XX:+UseParallelGC
1 tests failed.
FAILED: org.apache.solr.cloud.autoscaling.NodeLostTriggerTest.testListenerAcceptance
Error Message:
expected:<1> but was:<0>
Stack Trace:
java.lang.AssertionError: expected:<1> but was:<0>
at __randomizedtesting.SeedInfo.seed([4618117EB5C454CB:57AC4B990C4D403D]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at org.apache.solr.cloud.autoscaling.NodeLostTriggerTest.testListenerAcceptance(NodeLostTriggerTest.java:253)
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:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
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:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
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 1787 lines...]
[junit4] JVM J0: stdout was not empty, see: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/build/core/test/temp/junit4-J0-20180326_203235_2249743761758069931226.sysout
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] codec: Lucene70, pf: Asserting, dvf: Memory
[junit4] <<< JVM J0: EOF ----
[...truncated 12426 lines...]
[junit4] Suite: org.apache.solr.cloud.autoscaling.NodeLostTriggerTest
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeLostTriggerTest_4618117EB5C454CB-001/init-core-data-001
[junit4] 2> 1629639 WARN (SUITE-NodeLostTriggerTest-seed#[4618117EB5C454CB]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
[junit4] 2> 1629639 INFO (SUITE-NodeLostTriggerTest-seed#[4618117EB5C454CB]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 1629639 INFO (SUITE-NodeLostTriggerTest-seed#[4618117EB5C454CB]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, clientAuth=0.0/0.0)
[junit4] 2> 1629639 INFO (SUITE-NodeLostTriggerTest-seed#[4618117EB5C454CB]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1629640 INFO (SUITE-NodeLostTriggerTest-seed#[4618117EB5C454CB]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 5 servers in /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeLostTriggerTest_4618117EB5C454CB-001/tempDir-001
[junit4] 2> 1629640 INFO (SUITE-NodeLostTriggerTest-seed#[4618117EB5C454CB]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1629641 INFO (Thread-6340) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1629641 INFO (Thread-6340) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1629644 ERROR (Thread-6340) [ ] 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> 1629741 INFO (SUITE-NodeLostTriggerTest-seed#[4618117EB5C454CB]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:44627
[junit4] 2> 1629743 INFO (zkConnectionManagerCallback-4229-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1629744 INFO (jetty-launcher-4226-thread-1) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: ٢٠١٧-١١-٢١T٢٣:٢٧:٣٧+02:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 1629744 INFO (jetty-launcher-4226-thread-4) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: ٢٠١٧-١١-٢١T٢٣:٢٧:٣٧+02:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 1629744 INFO (jetty-launcher-4226-thread-3) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: ٢٠١٧-١١-٢١T٢٣:٢٧:٣٧+02:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 1629744 INFO (jetty-launcher-4226-thread-2) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: ٢٠١٧-١١-٢١T٢٣:٢٧:٣٧+02:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 1629745 INFO (jetty-launcher-4226-thread-5) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: ٢٠١٧-١١-٢١T٢٣:٢٧:٣٧+02:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 1629746 INFO (jetty-launcher-4226-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1629746 INFO (jetty-launcher-4226-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1629746 INFO (jetty-launcher-4226-thread-1) [ ] o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 1629747 INFO (jetty-launcher-4226-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@74e072b4{/solr,null,AVAILABLE}
[junit4] 2> 1629747 INFO (jetty-launcher-4226-thread-4) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1629747 INFO (jetty-launcher-4226-thread-4) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1629747 INFO (jetty-launcher-4226-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1629747 INFO (jetty-launcher-4226-thread-4) [ ] o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 1629747 INFO (jetty-launcher-4226-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1629747 INFO (jetty-launcher-4226-thread-3) [ ] o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 1629747 INFO (jetty-launcher-4226-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1d220291{/solr,null,AVAILABLE}
[junit4] 2> 1629747 INFO (jetty-launcher-4226-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@8f3d974{/solr,null,AVAILABLE}
[junit4] 2> 1629748 INFO (jetty-launcher-4226-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1629748 INFO (jetty-launcher-4226-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1629748 INFO (jetty-launcher-4226-thread-2) [ ] o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 1629748 INFO (jetty-launcher-4226-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@a99e93c{HTTP/1.1,[http/1.1]}{127.0.0.1:46167}
[junit4] 2> 1629748 INFO (jetty-launcher-4226-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@74cff015{HTTP/1.1,[http/1.1]}{127.0.0.1:37083}
[junit4] 2> 1629748 INFO (jetty-launcher-4226-thread-3) [ ] o.e.j.s.Server Started @1629784ms
[junit4] 2> 1629748 INFO (jetty-launcher-4226-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@6c73852d{HTTP/1.1,[http/1.1]}{127.0.0.1:39061}
[junit4] 2> 1629748 INFO (jetty-launcher-4226-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@29b40931{/solr,null,AVAILABLE}
[junit4] 2> 1629748 INFO (jetty-launcher-4226-thread-1) [ ] o.e.j.s.Server Started @1629784ms
[junit4] 2> 1629748 INFO (jetty-launcher-4226-thread-4) [ ] o.e.j.s.Server Started @1629784ms
[junit4] 2> 1629748 INFO (jetty-launcher-4226-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=46167}
[junit4] 2> 1629748 INFO (jetty-launcher-4226-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=39061}
[junit4] 2> 1629748 INFO (jetty-launcher-4226-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=37083}
[junit4] 2> 1629749 ERROR (jetty-launcher-4226-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1629749 INFO (jetty-launcher-4226-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@23f953a1{HTTP/1.1,[http/1.1]}{127.0.0.1:37949}
[junit4] 2> 1629749 INFO (jetty-launcher-4226-thread-3) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1629749 INFO (jetty-launcher-4226-thread-2) [ ] o.e.j.s.Server Started @1629784ms
[junit4] 2> 1629749 INFO (jetty-launcher-4226-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.4.0
[junit4] 2> 1629749 INFO (jetty-launcher-4226-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=37949}
[junit4] 2> 1629749 INFO (jetty-launcher-4226-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1629749 INFO (jetty-launcher-4226-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1629749 INFO (jetty-launcher-4226-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-26T21:21:30.304260Z
[junit4] 2> 1629749 ERROR (jetty-launcher-4226-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1629749 INFO (jetty-launcher-4226-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1629749 INFO (jetty-launcher-4226-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.4.0
[junit4] 2> 1629749 INFO (jetty-launcher-4226-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1629749 INFO (jetty-launcher-4226-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1629749 INFO (jetty-launcher-4226-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-26T21:21:30.304419Z
[junit4] 2> 1629749 INFO (jetty-launcher-4226-thread-5) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1629749 INFO (jetty-launcher-4226-thread-5) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1629749 INFO (jetty-launcher-4226-thread-5) [ ] o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 1629749 ERROR (jetty-launcher-4226-thread-4) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1629749 INFO (jetty-launcher-4226-thread-4) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1629749 INFO (jetty-launcher-4226-thread-5) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@71dd697a{/solr,null,AVAILABLE}
[junit4] 2> 1629749 INFO (jetty-launcher-4226-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.4.0
[junit4] 2> 1629749 INFO (jetty-launcher-4226-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1629749 INFO (jetty-launcher-4226-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1629749 INFO (jetty-launcher-4226-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-26T21:21:30.304772Z
[junit4] 2> 1629749 INFO (jetty-launcher-4226-thread-5) [ ] o.e.j.s.AbstractConnector Started ServerConnector@240806{HTTP/1.1,[http/1.1]}{127.0.0.1:39121}
[junit4] 2> 1629749 INFO (jetty-launcher-4226-thread-5) [ ] o.e.j.s.Server Started @1629785ms
[junit4] 2> 1629749 INFO (jetty-launcher-4226-thread-5) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=39121}
[junit4] 2> 1629749 ERROR (jetty-launcher-4226-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1629750 INFO (jetty-launcher-4226-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1629750 ERROR (jetty-launcher-4226-thread-5) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1629750 INFO (jetty-launcher-4226-thread-5) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1629750 INFO (jetty-launcher-4226-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.4.0
[junit4] 2> 1629750 INFO (jetty-launcher-4226-thread-5) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.4.0
[junit4] 2> 1629750 INFO (jetty-launcher-4226-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1629750 INFO (jetty-launcher-4226-thread-5) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1629750 INFO (jetty-launcher-4226-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1629750 INFO (jetty-launcher-4226-thread-5) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1629750 INFO (jetty-launcher-4226-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-26T21:21:30.305154Z
[junit4] 2> 1629750 INFO (jetty-launcher-4226-thread-5) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-26T21:21:30.305164Z
[junit4] 2> 1629750 INFO (zkConnectionManagerCallback-4233-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1629750 INFO (zkConnectionManagerCallback-4235-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1629750 INFO (zkConnectionManagerCallback-4231-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1629751 INFO (zkConnectionManagerCallback-4237-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1629751 INFO (jetty-launcher-4226-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1629751 INFO (jetty-launcher-4226-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1629751 INFO (jetty-launcher-4226-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1629751 INFO (zkConnectionManagerCallback-4239-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1629751 INFO (jetty-launcher-4226-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1629751 INFO (jetty-launcher-4226-thread-5) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1629765 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x1008554580c0004, likely client has closed socket
[junit4] 2> 1629768 INFO (jetty-launcher-4226-thread-5) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44627/solr
[junit4] 2> 1629769 INFO (jetty-launcher-4226-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44627/solr
[junit4] 2> 1629769 INFO (jetty-launcher-4226-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44627/solr
[junit4] 2> 1629769 INFO (jetty-launcher-4226-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44627/solr
[junit4] 2> 1629769 INFO (jetty-launcher-4226-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44627/solr
[junit4] 2> 1629770 INFO (zkConnectionManagerCallback-4250-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1629770 INFO (zkConnectionManagerCallback-4253-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1629770 INFO (zkConnectionManagerCallback-4259-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1629770 INFO (zkConnectionManagerCallback-4257-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1629770 INFO (zkConnectionManagerCallback-4255-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1629770 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x1008554580c0006, likely client has closed socket
[junit4] 2> 1629770 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x1008554580c000a, likely client has closed socket
[junit4] 2> 1629770 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x1008554580c0009, likely client has closed socket
[junit4] 2> 1629771 INFO (zkConnectionManagerCallback-4261-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1629771 INFO (zkConnectionManagerCallback-4263-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1629771 INFO (zkConnectionManagerCallback-4267-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1629771 INFO (zkConnectionManagerCallback-4265-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1629771 INFO (zkConnectionManagerCallback-4269-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1629787 INFO (jetty-launcher-4226-thread-1) [n:127.0.0.1:39061_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1629788 INFO (jetty-launcher-4226-thread-1) [n:127.0.0.1:39061_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:39061_solr
[junit4] 2> 1629788 INFO (jetty-launcher-4226-thread-1) [n:127.0.0.1:39061_solr ] o.a.s.c.Overseer Overseer (id=72204191338856462-127.0.0.1:39061_solr-n_0000000000) starting
[junit4] 2> 1629792 INFO (zkConnectionManagerCallback-4278-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1629794 INFO (jetty-launcher-4226-thread-1) [n:127.0.0.1:39061_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:44627/solr ready
[junit4] 2> 1629794 INFO (jetty-launcher-4226-thread-1) [n:127.0.0.1:39061_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:39061_solr
[junit4] 2> 1629795 INFO (zkCallback-4277-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1629805 INFO (OverseerStateUpdate-72204191338856462-127.0.0.1:39061_solr-n_0000000000) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1629821 INFO (jetty-launcher-4226-thread-2) [n:127.0.0.1:37949_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1629822 INFO (jetty-launcher-4226-thread-2) [n:127.0.0.1:37949_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1629822 INFO (jetty-launcher-4226-thread-3) [n:127.0.0.1:46167_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1629823 INFO (jetty-launcher-4226-thread-4) [n:127.0.0.1:37083_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1629823 INFO (jetty-launcher-4226-thread-5) [n:127.0.0.1:39121_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1629823 INFO (jetty-launcher-4226-thread-2) [n:127.0.0.1:37949_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:37949_solr
[junit4] 2> 1629826 INFO (jetty-launcher-4226-thread-3) [n:127.0.0.1:46167_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1629826 INFO (zkCallback-4266-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1629826 INFO (zkCallback-4262-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1629826 INFO (zkCallback-4277-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1629827 INFO (jetty-launcher-4226-thread-5) [n:127.0.0.1:39121_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1629827 INFO (jetty-launcher-4226-thread-4) [n:127.0.0.1:37083_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1629827 INFO (jetty-launcher-4226-thread-3) [n:127.0.0.1:46167_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:46167_solr
[junit4] 2> 1629828 INFO (jetty-launcher-4226-thread-5) [n:127.0.0.1:39121_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:39121_solr
[junit4] 2> 1629828 INFO (jetty-launcher-4226-thread-4) [n:127.0.0.1:37083_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:37083_solr
[junit4] 2> 1629828 INFO (zkCallback-4266-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1629828 INFO (zkCallback-4277-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1629841 INFO (zkCallback-4264-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (5)
[junit4] 2> 1629842 INFO (zkCallback-4260-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (5)
[junit4] 2> 1629842 INFO (zkCallback-4277-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (5)
[junit4] 2> 1629842 INFO (zkCallback-4268-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (5)
[junit4] 2> 1629842 INFO (zkCallback-4262-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (5)
[junit4] 2> 1629842 INFO (zkCallback-4266-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (5)
[junit4] 2> 1629911 INFO (jetty-launcher-4226-thread-3) [n:127.0.0.1:46167_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_46167.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@561989f2
[junit4] 2> 1629916 INFO (jetty-launcher-4226-thread-5) [n:127.0.0.1:39121_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39121.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@561989f2
[junit4] 2> 1629924 INFO (jetty-launcher-4226-thread-3) [n:127.0.0.1:46167_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_46167.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@561989f2
[junit4] 2> 1629924 INFO (jetty-launcher-4226-thread-3) [n:127.0.0.1:46167_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_46167.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@561989f2
[junit4] 2> 1629925 INFO (jetty-launcher-4226-thread-3) [n:127.0.0.1:46167_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeLostTriggerTest_4618117EB5C454CB-001/tempDir-001/node3/.
[junit4] 2> 1629929 INFO (jetty-launcher-4226-thread-2) [n:127.0.0.1:37949_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37949.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@561989f2
[junit4] 2> 1629932 INFO (jetty-launcher-4226-thread-5) [n:127.0.0.1:39121_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39121.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@561989f2
[junit4] 2> 1629932 INFO (jetty-launcher-4226-thread-5) [n:127.0.0.1:39121_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39121.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@561989f2
[junit4] 2> 1629933 INFO (jetty-launcher-4226-thread-5) [n:127.0.0.1:39121_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeLostTriggerTest_4618117EB5C454CB-001/tempDir-001/node5/.
[junit4] 2> 1629936 INFO (jetty-launcher-4226-thread-2) [n:127.0.0.1:37949_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37949.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@561989f2
[junit4] 2> 1629936 INFO (jetty-launcher-4226-thread-2) [n:127.0.0.1:37949_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37949.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@561989f2
[junit4] 2> 1629937 INFO (jetty-launcher-4226-thread-2) [n:127.0.0.1:37949_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeLostTriggerTest_4618117EB5C454CB-001/tempDir-001/node2/.
[junit4] 2> 1629953 INFO (zkConnectionManagerCallback-4282-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1629953 INFO (jetty-launcher-4226-thread-4) [n:127.0.0.1:37083_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37083.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@561989f2
[junit4] 2> 1629953 INFO (jetty-launcher-4226-thread-3) [n:127.0.0.1:46167_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5)
[junit4] 2> 1629954 INFO (jetty-launcher-4226-thread-3) [n:127.0.0.1:46167_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:44627/solr ready
[junit4] 2> 1629966 INFO (jetty-launcher-4226-thread-4) [n:127.0.0.1:37083_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37083.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@561989f2
[junit4] 2> 1629966 INFO (jetty-launcher-4226-thread-4) [n:127.0.0.1:37083_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37083.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@561989f2
[junit4] 2> 1629967 INFO (jetty-launcher-4226-thread-4) [n:127.0.0.1:37083_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeLostTriggerTest_4618117EB5C454CB-001/tempDir-001/node4/.
[junit4] 2> 1629978 INFO (zkConnectionManagerCallback-4290-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1629979 INFO (jetty-launcher-4226-thread-5) [n:127.0.0.1:39121_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5)
[junit4] 2> 1629979 INFO (jetty-launcher-4226-thread-5) [n:127.0.0.1:39121_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:44627/solr ready
[junit4] 2> 1629982 INFO (zkConnectionManagerCallback-4287-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1629983 INFO (jetty-launcher-4226-thread-2) [n:127.0.0.1:37949_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5)
[junit4] 2> 1629983 INFO (jetty-launcher-4226-thread-2) [n:127.0.0.1:37949_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:44627/solr ready
[junit4] 2> 1630022 INFO (zkConnectionManagerCallback-4294-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1630023 INFO (jetty-launcher-4226-thread-4) [n:127.0.0.1:37083_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5)
[junit4] 2> 1630023 INFO (jetty-launcher-4226-thread-4) [n:127.0.0.1:37083_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:44627/solr ready
[junit4] 2> 1630033 INFO (jetty-launcher-4226-thread-1) [n:127.0.0.1:39061_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39061.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@561989f2
[junit4] 2> 1630043 INFO (jetty-launcher-4226-thread-1) [n:127.0.0.1:39061_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39061.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@561989f2
[junit4] 2> 1630043 INFO (jetty-launcher-4226-thread-1) [n:127.0.0.1:39061_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39061.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@561989f2
[junit4] 2> 1630044 INFO (jetty-launcher-4226-thread-1) [n:127.0.0.1:39061_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeLostTriggerTest_4618117EB5C454CB-001/tempDir-001/node1/.
[junit4] 2> 1630126 INFO (zkConnectionManagerCallback-4296-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1630127 INFO (zkConnectionManagerCallback-4300-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1630128 INFO (SUITE-NodeLostTriggerTest-seed#[4618117EB5C454CB]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5)
[junit4] 2> 1630135 INFO (SUITE-NodeLostTriggerTest-seed#[4618117EB5C454CB]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:44627/solr ready
[junit4] 2> 1630160 INFO (TEST-NodeLostTriggerTest.testActionLifecycle-seed#[4618117EB5C454CB]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testActionLifecycle
[junit4] 2> 1630162 INFO (TEST-NodeLostTriggerTest.testActionLifecycle-seed#[4618117EB5C454CB]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testActionLifecycle
[junit4] 2> 1630184 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testListenerAcceptance
[junit4] 2> 1630185 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: ٢٠١٧-١١-٢١T٢٣:٢٧:٣٧+02:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 1630191 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1630191 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1630191 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [ ] o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 1630194 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6047a35a{/solr,null,AVAILABLE}
[junit4] 2> 1630195 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1279649{HTTP/1.1,[http/1.1]}{127.0.0.1:46143}
[junit4] 2> 1630195 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [ ] o.e.j.s.Server Started @1630230ms
[junit4] 2> 1630195 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=46143}
[junit4] 2> 1630195 ERROR (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1630195 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1630195 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.4.0
[junit4] 2> 1630195 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1630195 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1630195 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-26T21:21:30.750646Z
[junit4] 2> 1630196 INFO (zkConnectionManagerCallback-4302-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1630196 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1630202 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44627/solr
[junit4] 2> 1630210 INFO (zkConnectionManagerCallback-4306-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1630215 INFO (zkConnectionManagerCallback-4308-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1630219 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [n:127.0.0.1:46143_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5)
[junit4] 2> 1630220 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [n:127.0.0.1:46143_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1630221 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [n:127.0.0.1:46143_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:46143_solr
[junit4] 2> 1630222 INFO (zkCallback-4266-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1630222 INFO (zkCallback-4262-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1630222 INFO (zkCallback-4264-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1630222 INFO (zkCallback-4293-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1630222 INFO (zkCallback-4260-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1630237 INFO (zkCallback-4281-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1630237 INFO (zkCallback-4277-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1630237 INFO (zkCallback-4286-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1630237 INFO (zkCallback-4268-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1630237 INFO (zkCallback-4289-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1630238 INFO (zkCallback-4307-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1630238 INFO (zkCallback-4299-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1630365 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [n:127.0.0.1:46143_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_46143.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@561989f2
[junit4] 2> 1630375 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [n:127.0.0.1:46143_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_46143.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@561989f2
[junit4] 2> 1630375 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [n:127.0.0.1:46143_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_46143.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@561989f2
[junit4] 2> 1630376 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [n:127.0.0.1:46143_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeLostTriggerTest_4618117EB5C454CB-001/tempDir-001/node6/.
[junit4] 2> 1630378 INFO (zkConnectionManagerCallback-4313-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1630379 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [n:127.0.0.1:46143_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (6)
[junit4] 2> 1630379 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [n:127.0.0.1:46143_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:44627/solr ready
[junit4] 2> 1630437 INFO (zkConnectionManagerCallback-4315-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1630438 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@1279649{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 1630438 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=911043119
[junit4] 2> 1630438 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1630438 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@205e2a16: rootName = solr_46143, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@5a55dccf
[junit4] 2> 1630442 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1630442 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2aeb1d46: rootName = solr_46143, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@6571ca03
[junit4] 2> 1630445 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1630445 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@76ce631b: rootName = solr_46143, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@17596ab4
[junit4] 2> 1630446 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:46143_solr
[junit4] 2> 1630447 INFO (zkCallback-4266-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 1630447 INFO (zkCallback-4299-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 1630447 INFO (zkCallback-4262-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 1630447 INFO (zkCallback-4277-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 1630447 INFO (zkCallback-4268-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 1630447 INFO (zkCallback-4293-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 1630447 INFO (zkCallback-4289-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 1630447 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 1630447 INFO (zkCallback-4264-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 1630447 INFO (zkCallback-4307-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 1630447 INFO (zkCallback-4260-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 1630447 INFO (zkCallback-4312-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 1630447 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1630448 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@6047a35a{/solr,null,UNAVAILABLE}
[junit4] 2> 1630448 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [ ] o.e.j.s.session Stopped scavenging
[junit4] 2> 1630448 INFO (zkConnectionManagerCallback-4317-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1630449 INFO (TEST-NodeLostTriggerTest.testListenerAcceptance-seed#[4618117EB5C454CB]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testListenerAcceptance
[junit4] 2> 1630450 INFO (zkCallback-4281-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 1630450 INFO (zkCallback-4286-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=NodeLostTriggerTest -Dtests.method=testListenerAcceptance -Dtests.seed=4618117EB5C454CB -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ast -Dtests.timezone=America/Panama -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 0.29s J0 | NodeLostTriggerTest.testListenerAcceptance <<<
[junit4] > Throwable #1: java.lang.AssertionError: expected:<1> but was:<0>
[junit4] > at __randomizedtesting.SeedInfo.seed([4618117EB5C454CB:57AC4B990C4D403D]:0)
[junit4] > at org.apache.solr.cloud.autoscaling.NodeLostTriggerTest.testListenerAcceptance(NodeLostTriggerTest.java:253)
[junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] > at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] > at java.base/java.lang.reflect.Method.invoke(Method.java:564)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] 2> 1630487 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testRestoreState
[junit4] 2> 1630488 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: ٢٠١٧-١١-٢١T٢٣:٢٧:٣٧+02:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 1630488 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1630488 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1630488 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [ ] o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 1630489 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@292aecea{/solr,null,AVAILABLE}
[junit4] 2> 1630489 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@6eb31bfc{HTTP/1.1,[http/1.1]}{127.0.0.1:44539}
[junit4] 2> 1630489 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [ ] o.e.j.s.Server Started @1630524ms
[junit4] 2> 1630489 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=44539}
[junit4] 2> 1630489 ERROR (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1630489 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1630489 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.4.0
[junit4] 2> 1630489 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1630489 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1630489 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-26T21:21:31.044581Z
[junit4] 2> 1630490 INFO (zkConnectionManagerCallback-4319-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1630490 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1630494 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44627/solr
[junit4] 2> 1630495 INFO (zkConnectionManagerCallback-4323-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1630496 INFO (zkConnectionManagerCallback-4325-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1630500 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [n:127.0.0.1:44539_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5)
[junit4] 2> 1630500 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [n:127.0.0.1:44539_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1630501 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [n:127.0.0.1:44539_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:44539_solr
[junit4] 2> 1630501 INFO (zkCallback-4293-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1630501 INFO (zkCallback-4281-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1630502 INFO (zkCallback-4277-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1630502 INFO (zkCallback-4289-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1630502 INFO (zkCallback-4262-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1630502 INFO (zkCallback-4264-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1630502 INFO (zkCallback-4286-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1630502 INFO (zkCallback-4268-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1630502 INFO (zkCallback-4266-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1630502 INFO (zkCallback-4260-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1630503 INFO (zkCallback-4299-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1630506 INFO (zkCallback-4324-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1630555 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [n:127.0.0.1:44539_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_44539.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@561989f2
[junit4] 2> 1630561 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [n:127.0.0.1:44539_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_44539.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@561989f2
[junit4] 2> 1630561 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [n:127.0.0.1:44539_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_44539.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@561989f2
[junit4] 2> 1630562 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [n:127.0.0.1:44539_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeLostTriggerTest_4618117EB5C454CB-001/tempDir-001/node7/.
[junit4] 2> 1630563 INFO (zkConnectionManagerCallback-4330-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1630564 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [n:127.0.0.1:44539_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (6)
[junit4] 2> 1630564 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [n:127.0.0.1:44539_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:44627/solr ready
[junit4] 2> 1630615 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@6eb31bfc{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 1630615 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=2042614710
[junit4] 2> 1630615 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1630615 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@502257b2: rootName = solr_44539, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@54b6a706
[junit4] 2> 1630619 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1630619 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@7a936d65: rootName = solr_44539, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@6571ca03
[junit4] 2> 1630622 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1630622 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4294890f: rootName = solr_44539, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@17596ab4
[junit4] 2> 1630623 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:44539_solr
[junit4] 2> 1630624 INFO (zkCallback-4260-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 1630624 INFO (zkCallback-4293-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 1630624 INFO (zkCallback-4266-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 1630624 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 1630624 INFO (zkCallback-4268-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 1630624 INFO (zkCallback-4324-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 1630624 INFO (zkCallback-4299-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 1630624 INFO (zkCallback-4277-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 1630624 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1630624 INFO (zkCallback-4289-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 1630624 INFO (zkCallback-4264-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 1630624 INFO (zkCallback-4286-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 1630624 INFO (zkCallback-4262-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 1630626 WARN (zkCallback-4329-thread-1) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 1630626 INFO (zkCallback-4281-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 1630627 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@292aecea{/solr,null,UNAVAILABLE}
[junit4] 2> 1630627 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [ ] o.e.j.s.session Stopped scavenging
[junit4] 2> 1633630 INFO (TEST-NodeLostTriggerTest.testRestoreState-seed#[4618117EB5C454CB]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testRestoreState
[junit4] 2> 1633656 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testTrigger
[junit4] 2> 1633657 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@23f953a1{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 1633658 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1765099935
[junit4] 2> 1633658 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1633658 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@e425e3b: rootName = solr_37949, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@56faae2b
[junit4] 2> 1633663 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1633663 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3ce71089: rootName = solr_37949, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@6571ca03
[junit4] 2> 1633666 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1633666 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@123ee1cf: rootName = solr_37949, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@17596ab4
[junit4] 2> 1633667 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:37949_solr
[junit4] 2> 1633667 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 1633667 INFO (zkCallback-4293-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 1633667 INFO (zkCallback-4266-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 1633667 INFO (zkCallback-4264-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 1633667 INFO (zkCallback-4299-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 1633667 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1633667 INFO (zkCallback-4262-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 1633667 INFO (zkCallback-4260-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 1633667 INFO (zkCallback-4281-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 1633667 INFO (zkCallback-4268-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 1633667 INFO (zkCallback-4277-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 1633669 INFO (zkCallback-4289-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 1633669 INFO (zkCallback-4286-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 1633669 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@29b40931{/solr,null,UNAVAILABLE}
[junit4] 2> 1633670 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.e.j.s.session Stopped scavenging
[junit4] 2> 1633670 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@240806{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 1633670 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=2082085481
[junit4] 2> 1633670 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1633670 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3acdaaaa: rootName = solr_39121, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@be0c494
[junit4] 2> 1633675 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1633675 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@93fccce: rootName = solr_39121, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@6571ca03
[junit4] 2> 1633678 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1633678 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@a4a3aa4: rootName = solr_39121, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@17596ab4
[junit4] 2> 1633679 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:39121_solr
[junit4] 2> 1633680 INFO (zkCallback-4281-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1633680 INFO (zkCallback-4277-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1633680 INFO (zkCallback-4293-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1633680 INFO (zkCallback-4289-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1633680 INFO (zkCallback-4262-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1633680 INFO (zkCallback-4299-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1633680 INFO (zkCallback-4264-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1633680 INFO (zkCallback-4260-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1633680 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 1633680 INFO (zkCallback-4266-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1633680 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1633681 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@71dd697a{/solr,null,UNAVAILABLE}
[junit4] 2> 1633681 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.e.j.s.session Stopped scavenging
[junit4] 2> 1638684 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@74cff015{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 1638684 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1714551417
[junit4] 2> 1638684 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1638684 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@221f2280: rootName = solr_37083, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@548c42b3
[junit4] 2> 1638688 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1638688 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3d4ae71c: rootName = solr_37083, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@6571ca03
[junit4] 2> 1638691 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1638691 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@31e65773: rootName = solr_37083, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@17596ab4
[junit4] 2> 1638692 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:37083_solr
[junit4] 2> 1638692 INFO (zkCallback-4262-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 1638692 INFO (zkCallback-4293-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 1638692 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 1638693 INFO (zkCallback-4266-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 1638693 INFO (zkCallback-4299-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 1638693 INFO (zkCallback-4264-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 1638693 INFO (zkCallback-4277-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 1638693 INFO (zkCallback-4281-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 1638693 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1638693 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1d220291{/solr,null,UNAVAILABLE}
[junit4] 2> 1638694 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.e.j.s.session Stopped scavenging
[junit4] 2> 1638694 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: ٢٠١٧-١١-٢١T٢٣:٢٧:٣٧+02:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 1638695 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1638695 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1638695 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 1638695 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3a196c0b{/solr,null,AVAILABLE}
[junit4] 2> 1638695 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@41556ad{HTTP/1.1,[http/1.1]}{127.0.0.1:37083}
[junit4] 2> 1638695 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.e.j.s.Server Started @1638731ms
[junit4] 2> 1638695 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=37083}
[junit4] 2> 1638695 ERROR (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1638695 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1638696 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.4.0
[junit4] 2> 1638696 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1638696 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1638696 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-26T21:21:39.251168Z
[junit4] 2> 1638697 INFO (zkConnectionManagerCallback-4332-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1638697 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1638702 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44627/solr
[junit4] 2> 1638703 INFO (zkConnectionManagerCallback-4336-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1638704 INFO (zkConnectionManagerCallback-4338-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1638707 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [n:127.0.0.1:37083_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1638708 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [n:127.0.0.1:37083_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1638708 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [n:127.0.0.1:37083_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:37083_solr
[junit4] 2> 1638709 INFO (zkCallback-4281-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1638709 INFO (zkCallback-4262-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1638709 INFO (zkCallback-4266-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1638709 INFO (zkCallback-4299-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1638709 INFO (zkCallback-4277-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1638714 INFO (zkCallback-4337-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1638826 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [n:127.0.0.1:37083_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37083.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@561989f2
[junit4] 2> 1638833 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [n:127.0.0.1:37083_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37083.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@561989f2
[junit4] 2> 1638833 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [n:127.0.0.1:37083_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37083.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@561989f2
[junit4] 2> 1638834 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [n:127.0.0.1:37083_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeLostTriggerTest_4618117EB5C454CB-001/tempDir-001/node4/.
[junit4] 2> 1638836 INFO (zkConnectionManagerCallback-4343-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1638836 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [n:127.0.0.1:37083_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 1638837 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [n:127.0.0.1:37083_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:44627/solr ready
[junit4] 2> 1643858 INFO (TEST-NodeLostTriggerTest.testTrigger-seed#[4618117EB5C454CB]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testTrigger
[junit4] 2> 1643860 INFO (jetty-closer-4227-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@a99e93c{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 1643860 INFO (jetty-closer-4227-thread-2) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@41556ad{HTTP/1.1,[http/1.1]}{127.0.0.1:37083}
[junit4] 2> 1643860 INFO (jetty-closer-4227-thread-3) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@6c73852d{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 1643860 INFO (jetty-closer-4227-thread-1) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=599760561
[junit4] 2> 1643860 INFO (jetty-closer-4227-thread-3) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1093879418
[junit4] 2> 1643860 INFO (jetty-closer-4227-thread-2) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=276773035
[junit4] 2> 1643860 INFO (jetty-closer-4227-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1643860 INFO (jetty-closer-4227-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1643860 INFO (jetty-closer-4227-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1b7bfbca: rootName = solr_46167, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@34250d0a
[junit4] 2> 1643860 INFO (jetty-closer-4227-thread-3) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3fdd6388: rootName = solr_39061, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@487691aa
[junit4] 2> 1643860 INFO (jetty-closer-4227-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1643860 INFO (jetty-closer-4227-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@23261e40: rootName = solr_37083, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@3d977747
[junit4] 2> 1643863 INFO (jetty-closer-4227-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1643863 INFO (jetty-closer-4227-thread-3) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@52dc1382: rootName = solr_39061, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@6571ca03
[junit4] 2> 1643866 INFO (jetty-closer-4227-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1643866 INFO (jetty-closer-4227-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1643866 INFO (jetty-closer-4227-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1643866 INFO (jetty-closer-4227-thread-3) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@691b84fd: rootName = solr_39061, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@17596ab4
[junit4] 2> 1643866 INFO (jetty-closer-4227-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4cd7b7a6: rootName = solr_37083, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@6571ca03
[junit4] 2> 1643866 INFO (jetty-closer-4227-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2939804d: rootName = solr_46167, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@6571ca03
[junit4] 2> 1643866 INFO (jetty-closer-4227-thread-3) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:39061_solr
[junit4] 2> 1643867 INFO (jetty-closer-4227-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 1643867 INFO (zkCallback-4281-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 1643867 INFO (zkCallback-4277-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 1643867 INFO (jetty-closer-4227-thread-3) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1643867 INFO (zkCallback-4262-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 1643867 INFO (zkCallback-4266-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 1643867 INFO (jetty-closer-4227-thread-3) [ ] o.a.s.c.Overseer Overseer (id=72204191338856462-127.0.0.1:39061_solr-n_0000000000) closing
[junit4] 2> 1643867 INFO (OverseerStateUpdate-72204191338856462-127.0.0.1:39061_solr-n_0000000000) [ ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:39061_solr
[junit4] 2> 1643867 INFO (zkCallback-4337-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 1643867 WARN (OverseerAutoScalingTriggerThread-72204191338856462-127.0.0.1:39061_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 1643868 INFO (zkCallback-4262-thread-1) [ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:46167_solr
[junit4] 2> 1643868 INFO (jetty-closer-4227-thread-3) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@74e072b4{/solr,null,UNAVAILABLE}
[junit4] 2> 1643869 INFO (jetty-closer-4227-thread-3) [ ] o.e.j.s.session Stopped scavenging
[junit4] 2> 1643867 INFO (zkCallback-4342-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 1643870 INFO (jetty-closer-4227-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1643870 INFO (jetty-closer-4227-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@62f322c1: rootName = solr_46167, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@17596ab4
[junit4] 2> 1643871 INFO (jetty-closer-4227-thread-1) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:46167_solr
[junit4] 2> 1643871 INFO (jetty-closer-4227-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1643871 INFO (jetty-closer-4227-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2cca6032: rootName = solr_37083, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@17596ab4
[junit4] 2> 1643871 INFO (jetty-closer-4227-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 1643871 INFO (jetty-closer-4227-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1643871 INFO (zkCallback-4262-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 1643871 INFO (zkCallback-4342-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 1643871 INFO (zkCallback-4337-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 1643871 INFO (zkCallback-4281-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 1643871 INFO (jetty-closer-4227-thread-2) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:37083_solr
[junit4] 2> 1643872 INFO (jetty-closer-4227-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 1643872 INFO (jetty-closer-4227-thread-2) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1643872 INFO (zkCallback-4337-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
[junit4] 2> 1643872 INFO (zkCallback-4342-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
[junit4] 2> 1643872 INFO (zkCallback-4337-thread-2) [ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:37083_solr
[junit4] 2> 1645372 WARN (zkCallback-4262-thread-1) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 1645372 INFO (jetty-closer-4227-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@8f3d974{/solr,null,UNAVAILABLE}
[junit4] 2> 1645372 INFO (jetty-closer-4227-thread-1) [ ] o.e.j.s.session Stopped scavenging
[junit4] 2> 1645373 INFO (jetty-closer-4227-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@3a196c0b{/solr,null,UNAVAILABLE}
[junit4] 2> 1645373 INFO (jetty-closer-4227-thread-2) [ ] o.e.j.s.session Stopped scavenging
[junit4] 2> 1645373 ERROR
[...truncated too long message...]
OverseerModifyCollectionTest, HighlighterConfigTest, TestReRankQParserPlugin, CurrencyRangeFacetCloudTest, DebugComponentTest, TestGroupingSearch, PKIAuthenticationIntegrationTest, ResponseBuilderTest, ExitableDirectoryReaderTest, TestFastOutputStream, CreateRoutedAliasTest, TermVectorComponentDistributedTest, TestOnReconnectListenerSupport, TestUninvertingReader, TestNRTOpen, TestImplicitCoreProperties, TestClusterStateMutator, PluginInfoTest, TestSort, MetricsConfigTest, SolrMetricReporterTest, CdcrBidirectionalTest, TestLRUStatsCache, DocumentAnalysisRequestHandlerTest, TestHalfAndHalfDocValues, MergeStrategyTest, EchoParamsTest, TestIndexSearcher, DistributedFacetPivotWhiteBoxTest, SuggesterWFSTTest, TestClusterProperties, V2StandaloneTest, CleanupOldIndexTest, TestCloudPseudoReturnFields, SolrIndexMetricsTest, TestXmlQParser, IndexBasedSpellCheckerTest, TestSimpleTextCodec, DefaultValueUpdateProcessorTest, SolrGraphiteReporterTest, BasicDistributedZkTest, AutoAddReplicasPlanActionTest, TestDistribIDF, BadIndexSchemaTest, MetricUtilsTest, TestBinaryResponseWriter, TestNestedDocsSort, DocExpirationUpdateProcessorFactoryTest, StatsComponentTest, HttpSolrCallGetCoreTest, TestManagedResource, TestLegacyFieldCache, TestStressLucene, ConfigSetsAPITest, SynonymTokenizerTest, TestTolerantUpdateProcessorRandomCloud, TestCSVLoader, InfoHandlerTest, SolrCoreCheckLockOnStartupTest, TestSubQueryTransformer, TestMacros, TestConfigSetProperties, TestDocumentBuilder, TestSolrDeletionPolicy1, ConfigureRecoveryStrategyTest, BlockJoinFacetSimpleTest, ConnectionReuseTest, ImplicitSnitchTest, TestClusterStateProvider, TestApiFramework, UUIDUpdateProcessorFallbackTest, AliasIntegrationTest, TestHdfsUpdateLog, TestCollectionsAPIViaSolrCloudCluster, HdfsDirectoryTest, TestConfigSetsAPIZkFailure, TestCSVResponseWriter, TestMaxTokenLenTokenizer, SolrCLIZkUtilsTest, ConcurrentDeleteAndCreateCollectionTest, TestPhraseSuggestions, TestFieldCache, TestOverriddenPrefixQueryForCustomFieldType, SpellingQueryConverterTest, TestSolrConfigHandlerConcurrent, TestIndexingPerformance, TestCrossCoreJoin, TestExclusionRuleCollectionAccess, AtomicUpdateProcessorFactoryTest, SpellCheckCollatorTest, TestSearcherReuse, CdcrReplicationHandlerTest, TestMergePolicyConfig, TestPseudoReturnFields, UpdateLogTest, TestQuerySenderNoQuery, BJQParserTest, BasicDistributedZk2Test, UnloadDistributedZkTest, SyncSliceTest, ShardRoutingTest, TestReplicationHandler, ZkSolrClientTest, TestHashPartitioner, ZkControllerTest, TestRealTimeGet, TestStressReorder, TestReload, SimpleFacetsTest, SolrCmdDistributorTest, ConvertedLegacyTest, BasicFunctionalityTest, DirectUpdateHandlerTest, TestBadConfig, HighlighterTest, ShowFileRequestHandlerTest, SolrIndexSplitterTest, SuggesterFSTTest, SuggesterTSTTest, TestTrie, NoCacheHeaderTest, WordBreakSolrSpellCheckerTest, SchemaVersionSpecificBehaviorTest, TestUpdate, TestWordDelimiterFilterFactory, QueryEqualityTest, DocValuesMultiTest, TestWriterPerf, PrimitiveFieldTypeTest, FileBasedSpellCheckerTest, XmlUpdateRequestHandlerTest, DocumentBuilderTest, RequiredFieldsTest, TestSolrQueryParser, RegexBoostProcessorTest, TestCollationField, MBeansHandlerTest, TestLRUCache, ZkNodePropsTest, SystemInfoHandlerTest, DistributedMLTComponentTest, SolrTestCaseJ4Test, TestCursorMarkWithoutUniqueKey, TestHighlightDedupGrouping, TestEmbeddedSolrServerAdminHandler, TestEmbeddedSolrServerSchemaAPI, AsyncCallRequestStatusResponseTest, ChaosMonkeyNothingIsSafeWithPullReplicasTest, MoveReplicaHDFSTest, OverseerTaskQueueTest, RemoteQueryErrorTest, ReplaceNodeNoTargetTest, ReplaceNodeTest, TestLeaderElectionZkExpiry, TestLeaderInitiatedRecoveryThread, TestLockTree, TestPullReplicaErrorHandling, TestStressCloudBlindAtomicUpdates, TestTlogReplica, CollectionsAPIDistributedZkTest, TestLocalFSCloudBackupRestore, TestReplicaProperties, MetricTriggerTest, NodeLostTriggerTest]
[junit4] Completed [587/785 (1!)] on J0 in 16.87s, 4 tests, 1 failure <<< FAILURES!
[...truncated 33891 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/build.xml:633: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/build.xml:122: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/build.xml:108: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/tools/custom-tasks.xml:108: java.lang.IllegalArgumentException: named capturing group is missing trailing '}'
at java.base/java.util.regex.Matcher.appendExpandedReplacement(Matcher.java:1052)
at java.base/java.util.regex.Matcher.appendReplacement(Matcher.java:908)
at org.apache.lucene.dependencies.InterpolatedProperties.interpolate(InterpolatedProperties.java:64)
at org.apache.lucene.dependencies.InterpolatedProperties.load(InterpolatedProperties.java:50)
at org.apache.lucene.validation.LibVersionsCheckTask.collectDirectDependencies(LibVersionsCheckTask.java:385)
at org.apache.lucene.validation.LibVersionsCheckTask.execute(LibVersionsCheckTask.java:220)
at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
at jdk.internal.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
at org.apache.tools.ant.Task.perform(Task.java:348)
at org.apache.tools.ant.taskdefs.Sequential.execute(Sequential.java:68)
at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
at jdk.internal.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
at org.apache.tools.ant.Task.perform(Task.java:348)
at org.apache.tools.ant.taskdefs.MacroInstance.execute(MacroInstance.java:398)
at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
at jdk.internal.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
at org.apache.tools.ant.Task.perform(Task.java:348)
at org.apache.tools.ant.Target.execute(Target.java:390)
at org.apache.tools.ant.Target.performTasks(Target.java:411)
at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1399)
at org.apache.tools.ant.helper.SingleCheckExecutor.executeTargets(SingleCheckExecutor.java:38)
at org.apache.tools.ant.Project.executeTargets(Project.java:1251)
at org.apache.tools.ant.taskdefs.Ant.execute(Ant.java:442)
at org.apache.tools.ant.taskdefs.SubAnt.execute(SubAnt.java:302)
at org.apache.tools.ant.taskdefs.SubAnt.execute(SubAnt.java:221)
at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
at jdk.internal.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
at org.apache.tools.ant.Task.perform(Task.java:348)
at org.apache.tools.ant.Target.execute(Target.java:390)
at org.apache.tools.ant.Target.performTasks(Target.java:411)
at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1399)
at org.apache.tools.ant.helper.SingleCheckExecutor.executeTargets(SingleCheckExecutor.java:38)
at org.apache.tools.ant.Project.executeTargets(Project.java:1251)
at org.apache.tools.ant.taskdefs.Ant.execute(Ant.java:442)
at org.apache.tools.ant.taskdefs.CallTarget.execute(CallTarget.java:105)
at org.apache.tools.ant.UnknownElement.execute(UnknownElement.java:291)
at jdk.internal.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at org.apache.tools.ant.dispatch.DispatchUtils.execute(DispatchUtils.java:106)
at org.apache.tools.ant.Task.perform(Task.java:348)
at org.apache.tools.ant.Target.execute(Target.java:390)
at org.apache.tools.ant.Target.performTasks(Target.java:411)
at org.apache.tools.ant.Project.executeSortedTargets(Project.java:1399)
at org.apache.tools.ant.Project.executeTarget(Project.java:1368)
at org.apache.tools.ant.helper.DefaultExecutor.executeTargets(DefaultExecutor.java:41)
at org.apache.tools.ant.Project.executeTargets(Project.java:1251)
at org.apache.tools.ant.Main.runBuild(Main.java:809)
at org.apache.tools.ant.Main.startAnt(Main.java:217)
at org.apache.tools.ant.launch.Launcher.run(Launcher.java:280)
at org.apache.tools.ant.launch.Launcher.main(Launcher.java:109)
Total time: 65 minutes 4 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2