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/13 12:53:44 UTC
[JENKINS] Lucene-Solr-7.x-Windows (32bit/jdk1.8.0_144) - Build #
501 - Still Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Windows/501/
Java: 32bit/jdk1.8.0_144 -server -XX:+UseParallelGC
5 tests failed.
FAILED: junit.framework.TestSuite.org.apache.lucene.store.TestNIOFSDirectory
Error Message:
Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestNIOFSDirectory_4EBA5D6E89FCCC0D-001\testThreadSafety-001: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestNIOFSDirectory_4EBA5D6E89FCCC0D-001\testThreadSafety-001 C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestNIOFSDirectory_4EBA5D6E89FCCC0D-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestNIOFSDirectory_4EBA5D6E89FCCC0D-001
Stack Trace:
java.io.IOException: Could not remove the following files (in the order of attempts):
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestNIOFSDirectory_4EBA5D6E89FCCC0D-001\testThreadSafety-001: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestNIOFSDirectory_4EBA5D6E89FCCC0D-001\testThreadSafety-001
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestNIOFSDirectory_4EBA5D6E89FCCC0D-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestNIOFSDirectory_4EBA5D6E89FCCC0D-001
at __randomizedtesting.SeedInfo.seed([4EBA5D6E89FCCC0D]:0)
at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
at org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:216)
at com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterAlways(TestRuleAdapter.java:31)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43)
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.replicator.IndexAndTaxonomyReplicationClientTest.testNoUpdateThread
Error Message:
Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\replicator\test\J0\temp\lucene.replicator.IndexAndTaxonomyReplicationClientTest_2E0B9B68CC9A97D8-001\replicationClientTest-002\1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\replicator\test\J0\temp\lucene.replicator.IndexAndTaxonomyReplicationClientTest_2E0B9B68CC9A97D8-001\replicationClientTest-002\1
Stack Trace:
java.io.IOException: Could not remove the following files (in the order of attempts):
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\replicator\test\J0\temp\lucene.replicator.IndexAndTaxonomyReplicationClientTest_2E0B9B68CC9A97D8-001\replicationClientTest-002\1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\replicator\test\J0\temp\lucene.replicator.IndexAndTaxonomyReplicationClientTest_2E0B9B68CC9A97D8-001\replicationClientTest-002\1
at __randomizedtesting.SeedInfo.seed([2E0B9B68CC9A97D8:4B125805EF1ACE1E]:0)
at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
at org.apache.lucene.replicator.PerSessionDirectoryFactory.cleanupSession(PerSessionDirectoryFactory.java:58)
at org.apache.lucene.replicator.ReplicationClient.doUpdate(ReplicationClient.java:259)
at org.apache.lucene.replicator.ReplicationClient.updateNow(ReplicationClient.java:401)
at org.apache.lucene.replicator.IndexAndTaxonomyReplicationClientTest.testNoUpdateThread(IndexAndTaxonomyReplicationClientTest.java:227)
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: junit.framework.TestSuite.org.apache.solr.handler.component.DistributedTermsComponentTest
Error Message:
Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedTermsComponentTest_43F6A4DD3FFEE7CC-001\tempDir-001\shard2\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedTermsComponentTest_43F6A4DD3FFEE7CC-001\tempDir-001\shard2\collection1 C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedTermsComponentTest_43F6A4DD3FFEE7CC-001\tempDir-001\shard2: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedTermsComponentTest_43F6A4DD3FFEE7CC-001\tempDir-001\shard2 C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedTermsComponentTest_43F6A4DD3FFEE7CC-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedTermsComponentTest_43F6A4DD3FFEE7CC-001\tempDir-001
Stack Trace:
java.io.IOException: Could not remove the following files (in the order of attempts):
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedTermsComponentTest_43F6A4DD3FFEE7CC-001\tempDir-001\shard2\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedTermsComponentTest_43F6A4DD3FFEE7CC-001\tempDir-001\shard2\collection1
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedTermsComponentTest_43F6A4DD3FFEE7CC-001\tempDir-001\shard2: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedTermsComponentTest_43F6A4DD3FFEE7CC-001\tempDir-001\shard2
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedTermsComponentTest_43F6A4DD3FFEE7CC-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedTermsComponentTest_43F6A4DD3FFEE7CC-001\tempDir-001
at __randomizedtesting.SeedInfo.seed([43F6A4DD3FFEE7CC]:0)
at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
at org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:216)
at com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterAlways(TestRuleAdapter.java:31)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43)
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: junit.framework.TestSuite.org.apache.lucene.index.TestBackwardsCompatibility
Error Message:
Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\backward-codecs\test\J0\temp\lucene.index.TestBackwardsCompatibility_52E1A9D9D9F22740-001\7.2.1-nocfs-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\backward-codecs\test\J0\temp\lucene.index.TestBackwardsCompatibility_52E1A9D9D9F22740-001\7.2.1-nocfs-001
Stack Trace:
java.io.IOException: Could not remove the following files (in the order of attempts):
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\backward-codecs\test\J0\temp\lucene.index.TestBackwardsCompatibility_52E1A9D9D9F22740-001\7.2.1-nocfs-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\backward-codecs\test\J0\temp\lucene.index.TestBackwardsCompatibility_52E1A9D9D9F22740-001\7.2.1-nocfs-001
at __randomizedtesting.SeedInfo.seed([52E1A9D9D9F22740]:0)
at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
at org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:216)
at com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterAlways(TestRuleAdapter.java:31)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43)
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: junit.framework.TestSuite.org.apache.lucene.index.TestBackwardsCompatibility
Error Message:
Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\backward-codecs\test\J0\temp\lucene.index.TestBackwardsCompatibility_52E1A9D9D9F22740-001\4.3.0-cfs-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\backward-codecs\test\J0\temp\lucene.index.TestBackwardsCompatibility_52E1A9D9D9F22740-001\4.3.0-cfs-001
Stack Trace:
java.io.IOException: Could not remove the following files (in the order of attempts):
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\backward-codecs\test\J0\temp\lucene.index.TestBackwardsCompatibility_52E1A9D9D9F22740-001\4.3.0-cfs-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\backward-codecs\test\J0\temp\lucene.index.TestBackwardsCompatibility_52E1A9D9D9F22740-001\4.3.0-cfs-001
at __randomizedtesting.SeedInfo.seed([52E1A9D9D9F22740]:0)
at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
at org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:216)
at com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterAlways(TestRuleAdapter.java:31)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43)
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 392 lines...]
[junit4] Suite: org.apache.lucene.store.TestNIOFSDirectory
[junit4] 2> NOTE: test params are: codec=Lucene70, sim=RandomSimilarity(queryNorm=true): {}, locale=he-IL, timezone=SystemV/MST7MDT
[junit4] 2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_144 (32-bit)/cpus=3,threads=1,free=56485760,total=185073664
[junit4] 2> NOTE: All tests run in this JVM: [TestLockFactory, TestRateLimiter, TestStringMSBRadixSorter, TestIndexSorting, TestAttributeSource, TestRegexpRandom2, TestManyFields, TestIntroSelector, TestBytesRefArray, TestRecyclingIntBlockAllocator, TestNIOFSDirectory]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestNIOFSDirectory -Dtests.seed=4EBA5D6E89FCCC0D -Dtests.slow=true -Dtests.locale=he-IL -Dtests.timezone=SystemV/MST7MDT -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] ERROR 0.00s J0 | TestNIOFSDirectory (suite) <<<
[junit4] > Throwable #1: java.io.IOException: Could not remove the following files (in the order of attempts):
[junit4] > C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestNIOFSDirectory_4EBA5D6E89FCCC0D-001\testThreadSafety-001: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestNIOFSDirectory_4EBA5D6E89FCCC0D-001\testThreadSafety-001
[junit4] > C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestNIOFSDirectory_4EBA5D6E89FCCC0D-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestNIOFSDirectory_4EBA5D6E89FCCC0D-001
[junit4] > at __randomizedtesting.SeedInfo.seed([4EBA5D6E89FCCC0D]:0)
[junit4] > at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] Completed [48/466 (1!)] on J0 in 1.97s, 42 tests, 1 error <<< FAILURES!
[...truncated 1394 lines...]
[junit4] JVM J1: stdout was not empty, see: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\temp\junit4-J1-20180313_110652_7661343024169062042791.sysout
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] codec: FastCompressingStoredFields, pf: FST50, dvf: Direct
[junit4] <<< JVM J1: EOF ----
[...truncated 3064 lines...]
[junit4] Suite: org.apache.lucene.index.TestBackwardsCompatibility
[junit4] IGNOR/A 0.05s J0 | TestBackwardsCompatibility.testCreateSingleSegmentNoCFS
[junit4] > Assumption #1: backcompat creation tests must be run with -Dtests.bwcdir=/path/to/write/indexes
[junit4] IGNOR/A 0.00s J0 | TestBackwardsCompatibility.testCreateEmptyIndex
[junit4] > Assumption #1: backcompat creation tests must be run with -Dtests.bwcdir=/path/to/write/indexes
[junit4] IGNOR/A 0.00s J0 | TestBackwardsCompatibility.testCreateSortedIndex
[junit4] > Assumption #1: backcompat creation tests must be run with -Dtests.bwcdir=/path/to/write/indexes
[junit4] IGNOR/A 0.00s J0 | TestBackwardsCompatibility.testCreateMoreTermsIndex
[junit4] > Assumption #1: backcompat creation tests must be run with -Dtests.bwcdir=/path/to/write/indexes
[junit4] IGNOR/A 0.00s J0 | TestBackwardsCompatibility.testCreateCFS
[junit4] > Assumption #1: backcompat creation tests must be run with -Dtests.bwcdir=/path/to/write/indexes
[junit4] IGNOR/A 0.00s J0 | TestBackwardsCompatibility.testCreateIndexWithDocValuesUpdates
[junit4] > Assumption #1: backcompat creation tests must be run with -Dtests.bwcdir=/path/to/write/indexes
[junit4] IGNOR/A 0.00s J0 | TestBackwardsCompatibility.testCreateSingleSegmentCFS
[junit4] > Assumption #1: backcompat creation tests must be run with -Dtests.bwcdir=/path/to/write/indexes
[junit4] IGNOR/A 0.00s J0 | TestBackwardsCompatibility.testCreateNoCFS
[junit4] > Assumption #1: backcompat creation tests must be run with -Dtests.bwcdir=/path/to/write/indexes
[junit4] 2> NOTE: test params are: codec=Lucene70, sim=RandomSimilarity(queryNorm=false): {content6=DFR I(ne)LZ(0.3), content5=DFR GB2, content2=DFR I(n)L2, utf8=DFR I(F)B1, fie?ld=DFR I(n)L1, content=DFR I(F)BZ(0.3), autf8=DFR I(F)L1}, locale=hu, timezone=Europe/Zaporozhye
[junit4] 2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_144 (32-bit)/cpus=3,threads=1,free=140417248,total=169082880
[junit4] 2> NOTE: All tests run in this JVM: [TestBackwardsCompatibility]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestBackwardsCompatibility -Dtests.seed=52E1A9D9D9F22740 -Dtests.slow=true -Dtests.locale=hu -Dtests.timezone=Europe/Zaporozhye -Dtests.asserts=true -Dtests.file.encoding=Cp1252
[junit4] ERROR 0.00s J0 | TestBackwardsCompatibility (suite) <<<
[junit4] > Throwable #1: java.io.IOException: Could not remove the following files (in the order of attempts):
[junit4] > C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\backward-codecs\test\J0\temp\lucene.index.TestBackwardsCompatibility_52E1A9D9D9F22740-001\4.3.0-cfs-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\backward-codecs\test\J0\temp\lucene.index.TestBackwardsCompatibility_52E1A9D9D9F22740-001\4.3.0-cfs-001
[junit4] > at __randomizedtesting.SeedInfo.seed([52E1A9D9D9F22740]:0)
[junit4] > at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] Completed [2/9 (1!)] on J0 in 51.53s, 30 tests, 1 error, 8 skipped <<< FAILURES!
[...truncated 4388 lines...]
[junit4] Suite: org.apache.lucene.replicator.IndexAndTaxonomyReplicationClientTest
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=IndexAndTaxonomyReplicationClientTest -Dtests.method=testNoUpdateThread -Dtests.seed=2E0B9B68CC9A97D8 -Dtests.slow=true -Dtests.locale=cs-CZ -Dtests.timezone=Antarctica/Vostok -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] ERROR 0.05s J0 | IndexAndTaxonomyReplicationClientTest.testNoUpdateThread <<<
[junit4] > Throwable #1: java.io.IOException: Could not remove the following files (in the order of attempts):
[junit4] > C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\replicator\test\J0\temp\lucene.replicator.IndexAndTaxonomyReplicationClientTest_2E0B9B68CC9A97D8-001\replicationClientTest-002\1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\replicator\test\J0\temp\lucene.replicator.IndexAndTaxonomyReplicationClientTest_2E0B9B68CC9A97D8-001\replicationClientTest-002\1
[junit4] > at __randomizedtesting.SeedInfo.seed([2E0B9B68CC9A97D8:4B125805EF1ACE1E]:0)
[junit4] > at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
[junit4] > at org.apache.lucene.replicator.PerSessionDirectoryFactory.cleanupSession(PerSessionDirectoryFactory.java:58)
[junit4] > at org.apache.lucene.replicator.ReplicationClient.doUpdate(ReplicationClient.java:259)
[junit4] > at org.apache.lucene.replicator.ReplicationClient.updateNow(ReplicationClient.java:401)
[junit4] > at org.apache.lucene.replicator.IndexAndTaxonomyReplicationClientTest.testNoUpdateThread(IndexAndTaxonomyReplicationClientTest.java:227)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\replicator\test\J0\temp\lucene.replicator.IndexAndTaxonomyReplicationClientTest_2E0B9B68CC9A97D8-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {$full_path$=PostingsFormat(name=Asserting), $facets=PostingsFormat(name=Memory), $payloads$=FSTOrd50}, docValues:{$facets=DocValuesFormat(name=Memory)}, maxPointsInLeafNode=1973, maxMBSortInHeap=5.343180763204498, sim=RandomSimilarity(queryNorm=false): {}, locale=cs-CZ, timezone=Antarctica/Vostok
[junit4] 2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_144 (32-bit)/cpus=3,threads=1,free=47679760,total=60817408
[junit4] 2> NOTE: All tests run in this JVM: [IndexAndTaxonomyReplicationClientTest]
[junit4] Completed [4/9 (1!)] on J0 in 5.56s, 5 tests, 1 error <<< FAILURES!
[...truncated 3940 lines...]
[junit4] Suite: org.apache.solr.handler.component.DistributedTermsComponentTest
[junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedTermsComponentTest_43F6A4DD3FFEE7CC-001\init-core-data-001
[junit4] 2> 1502207 WARN (SUITE-DistributedTermsComponentTest-seed#[43F6A4DD3FFEE7CC]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=33 numCloses=33
[junit4] 2> 1502207 INFO (SUITE-DistributedTermsComponentTest-seed#[43F6A4DD3FFEE7CC]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 1502211 INFO (SUITE-DistributedTermsComponentTest-seed#[43F6A4DD3FFEE7CC]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 1502211 INFO (SUITE-DistributedTermsComponentTest-seed#[43F6A4DD3FFEE7CC]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1502211 INFO (SUITE-DistributedTermsComponentTest-seed#[43F6A4DD3FFEE7CC]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /y/
[junit4] 2> 1502615 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedTermsComponentTest_43F6A4DD3FFEE7CC-001\tempDir-001\control\cores\collection1
[junit4] 2> 1502659 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-21T17:27:37-04:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 1502660 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1502660 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1502660 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 1502660 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@62711{/y,null,AVAILABLE}
[junit4] 2> 1502662 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@14c449e{SSL,[ssl, http/1.1]}{127.0.0.1:54679}
[junit4] 2> 1502662 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.Server Started @1510706ms
[junit4] 2> 1502662 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/y, hostPort=54679, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedTermsComponentTest_43F6A4DD3FFEE7CC-001\tempDir-001\control\cores}
[junit4] 2> 1502662 ERROR (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1502662 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.4.0
[junit4] 2> 1502662 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 1502662 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1502662 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-13T11:53:30.771Z
[junit4] 2> 1502663 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedTermsComponentTest_43F6A4DD3FFEE7CC-001\tempDir-001\control\solr.xml
[junit4] 2> 1502668 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1502668 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1502669 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@1c0742b, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1502734 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1c0742b
[junit4] 2> 1502739 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1c0742b
[junit4] 2> 1502739 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1c0742b
[junit4] 2> 1502742 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedTermsComponentTest_43F6A4DD3FFEE7CC-001\tempDir-001\control\cores
[junit4] 2> 1502742 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1502760 INFO (coreLoadExecutor-6369-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1502762 INFO (coreLoadExecutor-6369-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1502814 INFO (coreLoadExecutor-6369-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
[junit4] 2> 1502829 INFO (coreLoadExecutor-6369-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1502909 INFO (coreLoadExecutor-6369-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1502917 INFO (coreLoadExecutor-6369-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1, trusted=true
[junit4] 2> 1502917 INFO (coreLoadExecutor-6369-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1c0742b
[junit4] 2> 1502917 INFO (coreLoadExecutor-6369-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1502917 INFO (coreLoadExecutor-6369-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedTermsComponentTest_43F6A4DD3FFEE7CC-001\tempDir-001\control\cores\collection1\data\]
[junit4] 2> 1502919 INFO (coreLoadExecutor-6369-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=437339375, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1503012 INFO (coreLoadExecutor-6369-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1503012 INFO (coreLoadExecutor-6369-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1503014 INFO (coreLoadExecutor-6369-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1503014 INFO (coreLoadExecutor-6369-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1503014 INFO (coreLoadExecutor-6369-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=49, maxMergeAtOnceExplicit=20, maxMergedSegmentMB=65.0625, floorSegmentMB=0.4609375, forceMergeDeletesPctAllowed=9.895432814338271, segmentsPerTier=41.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 1503014 INFO (coreLoadExecutor-6369-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@fb6106[collection1] main]
[junit4] 2> 1503015 INFO (coreLoadExecutor-6369-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1503103 INFO (coreLoadExecutor-6369-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1503164 INFO (coreLoadExecutor-6369-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1503164 INFO (coreLoadExecutor-6369-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1594823290412597248
[junit4] 2> 1503165 INFO (searcherExecutor-6370-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1503166 INFO (searcherExecutor-6370-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1503166 INFO (searcherExecutor-6370-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1503166 INFO (searcherExecutor-6370-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 1503166 INFO (searcherExecutor-6370-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1503166 INFO (searcherExecutor-6370-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1503166 INFO (searcherExecutor-6370-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1503166 INFO (searcherExecutor-6370-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1503167 INFO (searcherExecutor-6370-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1503167 INFO (searcherExecutor-6370-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@fb6106[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1503588 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedTermsComponentTest_43F6A4DD3FFEE7CC-001\tempDir-001\shard0\cores\collection1
[junit4] 2> 1503592 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-21T17:27:37-04:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 1503592 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1503593 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1503593 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 1503593 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@e8731b{/y,null,AVAILABLE}
[junit4] 2> 1503594 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@45ecf{SSL,[ssl, http/1.1]}{127.0.0.1:54691}
[junit4] 2> 1503594 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.Server Started @1511639ms
[junit4] 2> 1503594 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/y, hostPort=54691, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedTermsComponentTest_43F6A4DD3FFEE7CC-001\tempDir-001\shard0\cores}
[junit4] 2> 1503594 ERROR (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1503595 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.4.0
[junit4] 2> 1503595 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 1503595 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1503595 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-13T11:53:31.704Z
[junit4] 2> 1503596 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedTermsComponentTest_43F6A4DD3FFEE7CC-001\tempDir-001\shard0\solr.xml
[junit4] 2> 1503602 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1503602 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1503603 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@1c0742b, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1503671 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1c0742b
[junit4] 2> 1503677 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1c0742b
[junit4] 2> 1503677 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1c0742b
[junit4] 2> 1503680 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedTermsComponentTest_43F6A4DD3FFEE7CC-001\tempDir-001\shard0\cores
[junit4] 2> 1503680 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1503681 INFO (coreLoadExecutor-6380-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1503681 INFO (coreLoadExecutor-6380-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1503737 INFO (coreLoadExecutor-6380-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
[junit4] 2> 1503762 INFO (coreLoadExecutor-6380-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1503830 INFO (coreLoadExecutor-6380-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1503849 INFO (coreLoadExecutor-6380-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1, trusted=true
[junit4] 2> 1503850 INFO (coreLoadExecutor-6380-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1c0742b
[junit4] 2> 1503850 INFO (coreLoadExecutor-6380-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1503850 INFO (coreLoadExecutor-6380-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedTermsComponentTest_43F6A4DD3FFEE7CC-001\tempDir-001\shard0\cores\collection1\data\]
[junit4] 2> 1503851 INFO (coreLoadExecutor-6380-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=437339375, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1503931 INFO (coreLoadExecutor-6380-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1503931 INFO (coreLoadExecutor-6380-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1503932 INFO (coreLoadExecutor-6380-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1503932 INFO (coreLoadExecutor-6380-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1503933 INFO (coreLoadExecutor-6380-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=49, maxMergeAtOnceExplicit=20, maxMergedSegmentMB=65.0625, floorSegmentMB=0.4609375, forceMergeDeletesPctAllowed=9.895432814338271, segmentsPerTier=41.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 1503935 INFO (coreLoadExecutor-6380-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1fc21f[collection1] main]
[junit4] 2> 1503936 INFO (coreLoadExecutor-6380-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1503995 INFO (coreLoadExecutor-6380-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1504052 INFO (coreLoadExecutor-6380-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1504052 INFO (searcherExecutor-6381-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1504052 INFO (coreLoadExecutor-6380-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1594823291343732736
[junit4] 2> 1504052 INFO (searcherExecutor-6381-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1504052 INFO (searcherExecutor-6381-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1504052 INFO (searcherExecutor-6381-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 1504052 INFO (searcherExecutor-6381-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1504053 INFO (searcherExecutor-6381-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1504053 INFO (searcherExecutor-6381-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1504053 INFO (searcherExecutor-6381-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1504053 INFO (searcherExecutor-6381-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1504054 INFO (searcherExecutor-6381-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1fc21f[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1504056 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 1504083 INFO (qtp7259622-16885) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1594823291374141440)} 0 2
[junit4] 2> 1504112 INFO (qtp25077205-16906) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1594823291404550144)} 0 2
[junit4] 2> 1504113 INFO (qtp7259622-16884) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y path=/update params={wt=javabin&version=2}{add=[18 (1594823291407695872)]} 0 0
[junit4] 2> 1504116 INFO (qtp25077205-16905) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y path=/update params={wt=javabin&version=2}{add=[18 (1594823291409793024)]} 0 0
[junit4] 2> 1504117 INFO (qtp7259622-16885) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y path=/update params={wt=javabin&version=2}{add=[19 (1594823291410841600)]} 0 0
[junit4] 2> 1504122 INFO (qtp25077205-16905) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y path=/update params={wt=javabin&version=2}{add=[19 (1594823291416084480)]} 0 0
[junit4] 2> 1504122 INFO (qtp7259622-16884) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y path=/update params={wt=javabin&version=2}{add=[20 (1594823291417133056)]} 0 0
[junit4] 2> 1504123 INFO (qtp25077205-16906) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y path=/update params={wt=javabin&version=2}{add=[20 (1594823291418181632)]} 0 0
[junit4] 2> 1504123 INFO (qtp7259622-16885) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y path=/update params={wt=javabin&version=2}{add=[21 (1594823291418181632)]} 0 0
[junit4] 2> 1504124 INFO (qtp25077205-16905) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y path=/update params={wt=javabin&version=2}{add=[21 (1594823291419230208)]} 0 0
[junit4] 2> 1504124 INFO (qtp7259622-16884) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y path=/update params={wt=javabin&version=2}{add=[22 (1594823291419230208)]} 0 0
[junit4] 2> 1504125 INFO (qtp25077205-16906) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y path=/update params={wt=javabin&version=2}{add=[22 (1594823291420278784)]} 0 0
[junit4] 2> 1504126 INFO (qtp7259622-16885) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y path=/update params={wt=javabin&version=2}{add=[23 (1594823291421327360)]} 0 0
[junit4] 2> 1504126 INFO (qtp25077205-16905) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y path=/update params={wt=javabin&version=2}{add=[23 (1594823291421327360)]} 0 0
[junit4] 2> 1504127 INFO (qtp7259622-16884) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y path=/update params={wt=javabin&version=2}{add=[24 (1594823291422375936)]} 0 0
[junit4] 2> 1504128 INFO (qtp25077205-16906) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y path=/update params={wt=javabin&version=2}{add=[24 (1594823291422375936)]} 0 0
[junit4] 2> 1504128 INFO (qtp7259622-16885) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y path=/update params={wt=javabin&version=2}{add=[25 (1594823291423424512)]} 0 0
[junit4] 2> 1504128 INFO (qtp25077205-16905) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y path=/update params={wt=javabin&version=2}{add=[25 (1594823291423424512)]} 0 0
[junit4] 2> 1504129 INFO (qtp7259622-16884) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1594823291424473088,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1504129 INFO (qtp7259622-16884) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@bb37af commitCommandVersion:1594823291424473088
[junit4] 2> 1504138 INFO (qtp7259622-16884) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@15f8749[collection1] main]
[junit4] 2> 1504139 INFO (qtp7259622-16884) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1504140 INFO (searcherExecutor-6370-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@15f8749[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.4.0):c8)))}
[junit4] 2> 1504140 INFO (qtp7259622-16884) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 11
[junit4] 2> 1504141 INFO (qtp25077205-16906) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1594823291437056000,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1504141 INFO (qtp25077205-16906) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1dc81c2 commitCommandVersion:1594823291437056000
[junit4] 2> 1504154 INFO (qtp25077205-16906) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@f700d7[collection1] main]
[junit4] 2> 1504155 INFO (qtp25077205-16906) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1504156 INFO (searcherExecutor-6381-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@f700d7[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.4.0):c8)))}
[junit4] 2> 1504156 INFO (qtp25077205-16906) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 15
[junit4] 2> 1504157 INFO (qtp7259622-16885) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={distrib=false&qt=/terms&terms=true&terms.fl=b_t&wt=javabin&version=2&shards.qt=/terms} status=0 QTime=0
[junit4] 2> 1504191 INFO (qtp25077205-16907) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={df=text&distrib=false&qt=/terms&shards.purpose=1024&terms.sort=index&shard.url=[ff01::083]:33332/y|[ff01::213]:33332/y|https://127.0.0.1:54691/y/collection1&version=2&shards.qt=/terms&terms=true&terms.fl=b_t&terms.limit=-1&NOW=1520942012271&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 1504191 INFO (qtp25077205-16905) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={shards=[ff01::083]:33332/y|[ff01::213]:33332/y|https://127.0.0.1:54691/y/collection1&qt=/terms&terms=true&terms.fl=b_t&wt=javabin&version=2&shards.qt=/terms} status=0 QTime=29
[junit4] 2> 1504192 INFO (qtp7259622-16884) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={distrib=false&qt=/terms&terms=true&terms.fl=b_t&terms.limit=5&wt=javabin&version=2&shards.qt=/terms&terms.lower=s} status=0 QTime=0
[junit4] 2> 1504193 INFO (qtp25077205-16905) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={df=text&distrib=false&qt=/terms&shards.purpose=1024&terms.sort=index&shard.url=https://127.0.0.1:54691/y/collection1&version=2&shards.qt=/terms&terms=true&terms.fl=b_t&terms.limit=-1&NOW=1520942012302&isShard=true&wt=javabin&terms.lower=s} status=0 QTime=0
[junit4] 2> 1504193 INFO (qtp25077205-16903) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={shards=https://127.0.0.1:54691/y/collection1&qt=/terms&terms=true&terms.fl=b_t&terms.limit=5&wt=javabin&version=2&shards.qt=/terms&terms.lower=s} status=0 QTime=0
[junit4] 2> 1504194 INFO (qtp7259622-16885) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={terms.prefix=sn&distrib=false&qt=/terms&terms=true&terms.fl=b_t&terms.limit=5&wt=javabin&version=2&shards.qt=/terms&terms.lower=sn} status=0 QTime=0
[junit4] 2> 1504194 INFO (qtp25077205-16903) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={df=text&distrib=false&qt=/terms&shards.purpose=1024&terms.sort=index&shard.url=https://127.0.0.1:54691/y/collection1&version=2&shards.qt=/terms&terms.prefix=sn&terms=true&terms.fl=b_t&terms.limit=-1&NOW=1520942012303&isShard=true&wt=javabin&terms.lower=sn} status=0 QTime=0
[junit4] 2> 1504195 INFO (qtp25077205-16907) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={shards=https://127.0.0.1:54691/y/collection1&terms.prefix=sn&qt=/terms&terms=true&terms.fl=b_t&terms.limit=5&wt=javabin&version=2&shards.qt=/terms&terms.lower=sn} status=0 QTime=0
[junit4] 2> 1504195 INFO (qtp7259622-16884) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={terms.prefix=s&distrib=false&qt=/terms&terms=true&terms.fl=b_t&terms.limit=5&wt=javabin&version=2&terms.upper=sn&shards.qt=/terms&terms.lower=s} status=0 QTime=0
[junit4] 2> 1504196 INFO (qtp25077205-16907) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={df=text&distrib=false&qt=/terms&shards.purpose=1024&terms.sort=index&shard.url=https://127.0.0.1:54691/y/collection1&version=2&shards.qt=/terms&terms.prefix=s&terms=true&terms.fl=b_t&terms.limit=-1&NOW=1520942012304&isShard=true&wt=javabin&terms.upper=sn&terms.lower=s} status=0 QTime=0
[junit4] 2> 1504196 INFO (qtp25077205-16905) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={shards=https://127.0.0.1:54691/y/collection1&terms.prefix=s&qt=/terms&terms=true&terms.fl=b_t&terms.limit=5&wt=javabin&version=2&terms.upper=sn&shards.qt=/terms&terms.lower=s} status=0 QTime=0
[junit4] 2> 1504196 INFO (qtp7259622-16885) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={terms.prefix=s&distrib=false&qt=/terms&terms=true&terms.fl=b_t&terms.limit=5&terms.sort=index&wt=javabin&version=2&shards.qt=/terms&terms.lower=s} status=0 QTime=0
[junit4] 2> 1504197 INFO (qtp25077205-16905) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={df=text&distrib=false&qt=/terms&shards.purpose=1024&terms.sort=index&shard.url=[ff01::114]:33332/y|https://127.0.0.1:54691/y/collection1|[ff01::213]:33332/y&version=2&shards.qt=/terms&terms.prefix=s&terms=true&terms.fl=b_t&terms.limit=-1&NOW=1520942012305&isShard=true&wt=javabin&terms.lower=s} status=0 QTime=0
[junit4] 2> 1504200 INFO (qtp25077205-16903) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={shards=[ff01::114]:33332/y|https://127.0.0.1:54691/y/collection1|[ff01::213]:33332/y&terms.prefix=s&qt=/terms&terms=true&terms.fl=b_t&terms.limit=5&terms.sort=index&wt=javabin&version=2&shards.qt=/terms&terms.lower=s} status=0 QTime=3
[junit4] 2> 1504201 INFO (qtp7259622-16884) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={terms.prefix=s&distrib=false&qt=/terms&terms=true&terms.fl=b_t&terms.limit=5&terms.sort=index&wt=javabin&version=2&terms.upper=sn&shards.qt=/terms&terms.lower=s} status=0 QTime=0
[junit4] 2> 1504201 INFO (qtp25077205-16903) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={df=text&distrib=false&qt=/terms&shards.purpose=1024&terms.sort=index&shard.url=[ff01::213]:33332/y|[ff01::083]:33332/y|[ff01::114]:33332/y|https://127.0.0.1:54691/y/collection1&version=2&shards.qt=/terms&terms.prefix=s&terms=true&terms.fl=b_t&terms.limit=-1&NOW=1520942012310&isShard=true&wt=javabin&terms.upper=sn&terms.lower=s} status=0 QTime=0
[junit4] 2> 1504202 INFO (qtp25077205-16907) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={shards=[ff01::213]:33332/y|[ff01::083]:33332/y|[ff01::114]:33332/y|https://127.0.0.1:54691/y/collection1&terms.prefix=s&qt=/terms&terms=true&terms.fl=b_t&terms.limit=5&terms.sort=index&wt=javabin&version=2&terms.upper=sn&shards.qt=/terms&terms.lower=s} status=0 QTime=0
[junit4] 2> 1504202 INFO (qtp7259622-16885) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={distrib=false&qt=/terms&terms=true&terms.fl=b_t&terms.sort=index&wt=javabin&version=2&shards.qt=/terms} status=0 QTime=0
[junit4] 2> 1504203 INFO (qtp25077205-16907) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={df=text&distrib=false&qt=/terms&shards.purpose=1024&terms.sort=index&shard.url=https://127.0.0.1:54691/y/collection1&version=2&shards.qt=/terms&terms=true&terms.fl=b_t&terms.limit=-1&NOW=1520942012311&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 1504204 INFO (qtp25077205-16905) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={shards=https://127.0.0.1:54691/y/collection1&qt=/terms&terms=true&terms.fl=b_t&terms.sort=index&wt=javabin&version=2&shards.qt=/terms} status=0 QTime=1
[junit4] 2> 1504205 INFO (qtp7259622-16884) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={distrib=false&qt=/terms&terms=true&terms.fl=b_t&terms.list=snake,zebra,ant,bad&wt=javabin&version=2&shards.qt=/terms} status=0 QTime=0
[junit4] 2> 1504206 INFO (qtp25077205-16905) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={df=text&distrib=false&qt=/terms&shards.purpose=1024&terms.list=snake,zebra,ant,bad&terms.sort=index&shard.url=https://127.0.0.1:54691/y/collection1|[ff01::213]:33332/y&version=2&shards.qt=/terms&terms=true&terms.fl=b_t&terms.limit=-1&NOW=1520942012314&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 1504206 INFO (qtp25077205-16903) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={shards=https://127.0.0.1:54691/y/collection1|[ff01::213]:33332/y&qt=/terms&terms=true&terms.fl=b_t&terms.list=snake,zebra,ant,bad&wt=javabin&version=2&shards.qt=/terms} status=0 QTime=0
[junit4] 2> 1504206 INFO (qtp7259622-16885) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={distrib=false&qt=/terms&terms=true&terms.fl=foo_i&terms.list=2,3,1&wt=javabin&version=2&shards.qt=/terms} status=0 QTime=0
[junit4] 2> 1504207 INFO (qtp25077205-16903) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={df=text&distrib=false&qt=/terms&shards.purpose=1024&terms.list=2,3,1&terms.sort=index&shard.url=https://127.0.0.1:54691/y/collection1|[ff01::213]:33332/y&version=2&shards.qt=/terms&terms=true&terms.fl=foo_i&terms.limit=-1&NOW=1520942012315&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 1504207 INFO (qtp25077205-16907) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={shards=https://127.0.0.1:54691/y/collection1|[ff01::213]:33332/y&qt=/terms&terms=true&terms.fl=foo_i&terms.list=2,3,1&wt=javabin&version=2&shards.qt=/terms} status=0 QTime=0
[junit4] 2> 1504208 INFO (qtp7259622-16884) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={terms.stats=true&distrib=false&qt=/terms&terms=true&terms.fl=foo_i&terms.list=2,3,1&wt=javabin&version=2&shards.qt=/terms} status=0 QTime=0
[junit4] 2> 1504208 INFO (qtp25077205-16907) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={df=text&distrib=false&qt=/terms&shards.purpose=1024&terms.list=2,3,1&terms.sort=index&shard.url=https://127.0.0.1:54691/y/collection1&version=2&shards.qt=/terms&terms.stats=true&terms=true&terms.fl=foo_i&terms.limit=-1&NOW=1520942012317&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 1504209 INFO (qtp25077205-16905) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={shards=https://127.0.0.1:54691/y/collection1&terms.stats=true&qt=/terms&terms=true&terms.fl=foo_i&terms.list=2,3,1&wt=javabin&version=2&shards.qt=/terms} status=0 QTime=0
[junit4] 2> 1504209 INFO (qtp7259622-16885) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={distrib=false&qt=/terms&terms=true&terms.ttf=true&terms.fl=b_t&terms.list=snake,zebra&wt=javabin&version=2&shards.qt=/terms} status=0 QTime=0
[junit4] 2> 1504210 INFO (qtp25077205-16905) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={df=text&distrib=false&qt=/terms&shards.purpose=1024&terms.list=snake,zebra&terms.sort=index&shard.url=[ff01::083]:33332/y|[ff01::114]:33332/y|https://127.0.0.1:54691/y/collection1|[ff01::213]:33332/y&version=2&shards.qt=/terms&terms=true&terms.ttf=true&terms.fl=b_t&terms.limit=-1&NOW=1520942012318&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 1504210 INFO (qtp25077205-16903) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={shards=[ff01::083]:33332/y|[ff01::114]:33332/y|https://127.0.0.1:54691/y/collection1|[ff01::213]:33332/y&qt=/terms&terms=true&terms.ttf=true&terms.fl=b_t&terms.list=snake,zebra&wt=javabin&version=2&shards.qt=/terms} status=0 QTime=0
[junit4] 2> 1504210 INFO (qtp7259622-16884) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={distrib=false&qt=/terms&terms=true&terms.ttf=true&terms.fl=b_t&terms.fl=c_t&terms.list=snake,ant,zebra&wt=javabin&version=2&shards.qt=/terms} status=0 QTime=0
[junit4] 2> 1504211 INFO (qtp25077205-16903) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={df=text&distrib=false&qt=/terms&shards.purpose=1024&terms.list=snake,ant,zebra&terms.sort=index&shard.url=[ff01::114]:33332/y|https://127.0.0.1:54691/y/collection1|[ff01::213]:33332/y|[ff01::083]:33332/y&version=2&shards.qt=/terms&terms=true&terms.ttf=true&terms.fl=b_t&terms.fl=c_t&terms.limit=-1&NOW=1520942012320&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 1504211 INFO (qtp25077205-16907) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y path=/terms params={shards=[ff01::114]:33332/y|https://127.0.0.1:54691/y/collection1|[ff01::213]:33332/y|[ff01::083]:33332/y&qt=/terms&terms=true&terms.ttf=true&terms.fl=b_t&terms.fl=c_t&terms.list=snake,ant,zebra&wt=javabin&version=2&shards.qt=/terms} status=0 QTime=0
[junit4] 2> 1504211 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.SolrTestCaseJ4 ###Ending test
[junit4] 2> 1504212 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@14c449e{SSL,[ssl, http/1.1]}{127.0.0.1:0}
[junit4] 2> 1504212 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=3441405
[junit4] 2> 1504213 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1504213 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5b444a: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@11893b4
[junit4] 2> 1504216 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1504216 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@eb7419: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1295021
[junit4] 2> 1504218 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1504218 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@257d5e: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@116ccdc
[junit4] 2> 1504219 INFO (coreCloseExecutor-6386-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1652cc0
[junit4] 2> 1504219 INFO (coreCloseExecutor-6386-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=23407808
[junit4] 2> 1504219 INFO (coreCloseExecutor-6386-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@12c3c95: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@cc5fe
[junit4] 2> 1504227 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@62711{/y,null,UNAVAILABLE}
[junit4] 2> 1504227 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.session Stopped scavenging
[junit4] 2> 1504228 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@45ecf{SSL,[ssl, http/1.1]}{127.0.0.1:0}
[junit4] 2> 1504228 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=6055327
[junit4] 2> 1504228 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1504228 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3b6398: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@4651e1
[junit4] 2> 1504232 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1504232 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@96e0d2: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1295021
[junit4] 2> 1504235 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1504235 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5bc60a: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@116ccdc
[junit4] 2> 1504236 INFO (coreCloseExecutor-6388-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@187912c
[junit4] 2> 1504236 INFO (coreCloseExecutor-6388-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=25661740
[junit4] 2> 1504236 INFO (coreCloseExecutor-6388-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@349edc: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@13c1c3e
[junit4] 2> 1504245 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@e8731b{/y,null,UNAVAILABLE}
[junit4] 2> 1504245 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.session Stopped scavenging
[junit4] 2> 1504536 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-21T17:27:37-04:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 1504536 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1504536 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1504536 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 1504537 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1cfa618{/y,null,AVAILABLE}
[junit4] 2> 1504537 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@df4cfe{SSL,[ssl, http/1.1]}{127.0.0.1:54703}
[junit4] 2> 1504537 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.Server Started @1512582ms
[junit4] 2> 1504537 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/y, hostPort=54703, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedTermsComponentTest_43F6A4DD3FFEE7CC-001\tempDir-001\control\cores}
[junit4] 2> 1504538 ERROR (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1504538 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.4.0
[junit4] 2> 1504538 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 1504538 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1504538 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-13T11:53:32.647Z
[junit4] 2> 1504538 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedTermsComponentTest_43F6A4DD3FFEE7CC-001\tempDir-001\control\solr.xml
[junit4] 2> 1504545 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1504545 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1504545 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@1c0742b, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1504608 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1c0742b
[junit4] 2> 1504614 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1c0742b
[junit4] 2> 1504614 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1c0742b
[junit4] 2> 1504617 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedTermsComponentTest_43F6A4DD3FFEE7CC-001\tempDir-001\control\cores
[junit4] 2> 1504617 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1504626 INFO (coreLoadExecutor-6395-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1504627 INFO (coreLoadExecutor-6395-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1504677 INFO (coreLoadExecutor-6395-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
[junit4] 2> 1504692 INFO (coreLoadExecutor-6395-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1504768 INFO (coreLoadExecutor-6395-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1504776 INFO (coreLoadExecutor-6395-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1, trusted=true
[junit4] 2> 1504776 INFO (coreLoadExecutor-6395-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1c0742b
[junit4] 2> 1504776 INFO (coreLoadExecutor-6395-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1504776 INFO (coreLoadExecutor-6395-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedTermsComponentTest_43F6A4DD3FFEE7CC-001\tempDir-001\control\cores\collection1\data\]
[junit4] 2> 1504778 INFO (coreLoadExecutor-6395-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=437339375, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1504854 INFO (coreLoadExecutor-6395-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1504854 INFO (coreLoadExecutor-6395-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1504855 INFO (coreLoadExecutor-6395-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1504855 INFO (coreLoadExecutor-6395-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1504856 INFO (coreLoadExecutor-6395-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=49, maxMergeAtOnceExplicit=20, maxMergedSegmentMB=65.0625, floorSegmentMB=0.4609375, forceMergeDeletesPctAllowed=9.895432814338271, segmentsPerTier=41.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 1504856 INFO (coreLoadExecutor-6395-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1e8025a[collection1] main]
[junit4] 2> 1504856 INFO (coreLoadExecutor-6395-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1504858 INFO (coreLoadExecutor-6395-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1504876 INFO (coreLoadExecutor-6395-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1504876 INFO (searcherExecutor-6396-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1504876 INFO (coreLoadExecutor-6395-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1594823292207759360
[junit4] 2> 1504877 INFO (searcherExecutor-6396-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1504877 INFO (searcherExecutor-6396-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1504877 INFO (searcherExecutor-6396-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 1504877 INFO (searcherExecutor-6396-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1504877 INFO (searcherExecutor-6396-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1504877 INFO (searcherExecutor-6396-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1504878 INFO (searcherExecutor-6396-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1504878 INFO (searcherExecutor-6396-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1504878 INFO (searcherExecutor-6396-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1e8025a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1505153 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-21T17:27:37-04:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 1505153 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1505154 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1505154 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 1505154 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@da5801{/y,null,AVAILABLE}
[junit4] 2> 1505155 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@127ec3d{SSL,[ssl, http/1.1]}{127.0.0.1:54706}
[junit4] 2> 1505155 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.e.j.s.Server Started @1513199ms
[junit4] 2> 1505155 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/y, hostPort=54706, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedTermsComponentTest_43F6A4DD3FFEE7CC-001\tempDir-001\shard0\cores}
[junit4] 2> 1505155 ERROR (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1505155 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.4.0
[junit4] 2> 1505159 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 1505159 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1505159 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-13T11:53:33.268Z
[junit4] 2> 1505159 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedTermsComponentTest_43F6A4DD3FFEE7CC-001\tempDir-001\shard0\solr.xml
[junit4] 2> 1505165 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1505165 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1505165 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@1c0742b, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1505228 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1c0742b
[junit4] 2> 1505236 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1c0742b
[junit4] 2> 1505236 INFO (TEST-DistributedTermsComponentTest.test-seed#[43F6A4DD3FFEE7CC]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1c0742b
[junit4] 2> 150523
[...truncated too long message...]
top-level-ivy-settings.xml
resolve:
-check-git-state:
-git-cleanroot:
-copy-git-state:
git-autoclean:
ivy-fail:
resolve:
common.init:
compile-lucene-core:
-check-git-state:
-git-cleanroot:
-copy-git-state:
git-autoclean:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\top-level-ivy-settings.xml
resolve:
init:
-clover.disable:
-clover.load:
-clover.classpath:
-clover.setup:
clover:
compile-core:
init:
-clover.disable:
-clover.load:
-clover.classpath:
-clover.setup:
clover:
common.compile-core:
common-solr.compile-core:
compile-core:
compile-test-framework:
-check-git-state:
-git-cleanroot:
-copy-git-state:
git-autoclean:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\top-level-ivy-settings.xml
resolve:
init:
compile-lucene-core:
compile-codecs:
-check-git-state:
-git-cleanroot:
-copy-git-state:
git-autoclean:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\top-level-ivy-settings.xml
resolve:
common.init:
compile-lucene-core:
init:
-clover.disable:
-clover.load:
-clover.classpath:
-clover.setup:
clover:
compile-core:
-clover.disable:
-clover.load:
-clover.classpath:
-clover.setup:
clover:
common.compile-core:
compile-core:
common.compile-test:
[mkdir] Created dir: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\classes\test
[javac] Compiling 875 source files to C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\classes\test
[javac] Note: Some input files use or override a deprecated API.
[javac] Note: Recompile with -Xlint:deprecation for details.
[javac] Note: Some input files use unchecked or unsafe operations.
[javac] Note: Recompile with -Xlint:unchecked for details.
[javac] Creating empty C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\classes\test\org\apache\solr\cloud\autoscaling\sim\package-info.class
[copy] Copying 1 file to C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\classes\test
common-solr.compile-test:
compile-test:
BUILD SUCCESSFUL
Total time: 1 minute 56 seconds
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.DistributedTermsComponentTest" -Dtests.showOutput=onerror "-Dargs=-server -XX:+UseParallelGC" -Dtests.seed=43F6A4DD3FFEE7CC -Dtests.slow=true -Dtests.locale=ms -Dtests.timezone=Etc/GMT-9 -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
Buildfile: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\build.xml
-clover.disable:
ivy-configure:
[ivy:configure] :: Apache Ivy 2.4.0 - 20141213170938 :: http://ant.apache.org/ivy/ ::
[ivy:configure] :: loading settings :: file = C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\top-level-ivy-settings.xml
install-junit4-taskdef:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
resolve-groovy:
[ivy:cachepath] :: resolving dependencies :: org.codehaus.groovy#groovy-all-caller;working
[ivy:cachepath] confs: [default]
[ivy:cachepath] found org.codehaus.groovy#groovy-all;2.4.13 in public
[ivy:cachepath] :: resolution report :: resolve 56ms :: artifacts dl 1ms
---------------------------------------------------------------------
| | modules || artifacts |
| conf | number| search|dwnlded|evicted|| number|dwnlded|
---------------------------------------------------------------------
| default | 1 | 0 | 0 | 0 || 1 | 0 |
---------------------------------------------------------------------
-init-totals:
-test:
[mkdir] Created dir: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test
[junit4:pickseed] Seed property 'tests.seed' already defined: 43F6A4DD3FFEE7CC
[mkdir] Created dir: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\temp
[junit4] <JUnit4> says ????! Master seed: 43F6A4DD3FFEE7CC
[junit4] Your default console's encoding may not display certain unicode glyphs: windows-1252
[junit4] Executing 5 suites with 2 JVMs.
[junit4]
[junit4] Started J1 PID(6400@serv1-vm1).
[junit4] Started J0 PID(7216@serv1-vm1).
[junit4] Suite: org.apache.solr.handler.component.DistributedTermsComponentTest
[junit4] OK 29.5s J1 | DistributedTermsComponentTest.test
[junit4] Completed [1/5] on J1 in 40.54s, 1 test
[junit4]
[junit4] Suite: org.apache.solr.handler.component.DistributedTermsComponentTest
[junit4] OK 30.5s J0 | DistributedTermsComponentTest.test
[junit4] Completed [2/5] on J0 in 42.09s, 1 test
[junit4]
[junit4] Duplicate suite name used with XML reports: org.apache.solr.handler.component.DistributedTermsComponentTest. This may confuse tools that process XML reports. Set 'ignoreDuplicateSuites' to true to skip this message.
[junit4] Suite: org.apache.solr.handler.component.DistributedTermsComponentTest
[junit4] OK 15.8s J1 | DistributedTermsComponentTest.test
[junit4] Completed [3/5] on J1 in 16.61s, 1 test
[junit4]
[junit4] Suite: org.apache.solr.handler.component.DistributedTermsComponentTest
[junit4] OK 15.6s J0 | DistributedTermsComponentTest.test
[junit4] Completed [4/5] on J0 in 16.33s, 1 test
[junit4]
[junit4] Suite: org.apache.solr.handler.component.DistributedTermsComponentTest
[junit4] OK 7.92s J1 | DistributedTermsComponentTest.test
[junit4] Completed [5/5] on J1 in 8.53s, 1 test
[junit4]
[junit4] JVM J0: 1.40 .. 62.17 = 60.77s
[junit4] JVM J1: 1.36 .. 70.22 = 68.86s
[junit4] Execution time total: 1 minute 10 seconds
[junit4] Tests summary: 5 suites, 5 tests
[junit4] Could not remove temporary path: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0 (java.nio.file.DirectoryNotEmptyException: Remaining files: [C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp])
[junit4] Could not remove temporary path: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1 (java.nio.file.DirectoryNotEmptyException: Remaining files: [C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp])
[echo] 5 slowest tests:
[junit4:tophints] 567.50s | org.apache.solr.cloud.BasicDistributedZkTest
[junit4:tophints] 235.39s | org.apache.solr.cloud.autoscaling.TriggerIntegrationTest
[junit4:tophints] 214.06s | org.apache.solr.update.TestInPlaceUpdatesDistrib
[junit4:tophints] 185.55s | org.apache.solr.cloud.TestPullReplicaErrorHandling
[junit4:tophints] 143.68s | org.apache.solr.cloud.ZkFailoverTest
-check-totals:
test-nocompile:
BUILD SUCCESSFUL
Total time: 1 minute 14 seconds
[repro] Failures:
[repro] 0/5 failed: org.apache.lucene.store.TestNIOFSDirectory
[repro] 0/5 failed: org.apache.solr.handler.component.DistributedTermsComponentTest
[repro] 1/5 failed: org.apache.lucene.index.TestBackwardsCompatibility
[repro] 1/5 failed: org.apache.lucene.replicator.IndexAndTaxonomyReplicationClientTest
[repro] Exiting with code 1
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows>IF EXIST lucene\build move /y lucene\build lucene\build.repro
1 dir(s) moved.
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows>IF EXIST solr\build move /y solr\build solr\build.repro
1 dir(s) moved.
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows>IF EXIST lucene\build.orig move /y lucene\build.orig lucene\build
1 dir(s) moved.
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows>IF EXIST solr\build.orig move /y solr\build.orig solr\build
1 dir(s) moved.
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows>exit 0
Archiving artifacts
Setting ANT_1_8_2_HOME=C:\Users\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=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting ANT_1_8_2_HOME=C:\Users\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=4645553a55d574c760fe637418c91229db64f2bb, workspace=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows
[WARNINGS] Computing warning deltas based on reference build #500
Recording test results
Setting ANT_1_8_2_HOME=C:\Users\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=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
[JENKINS] Lucene-Solr-7.x-Windows (64bit/jdk-9.0.1) - Build # 502 -
Failure!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Windows/502/
Java: 64bit/jdk-9.0.1 -XX:+UseCompressedOops -XX:+UseG1GC
No tests ran.
Build Log:
[...truncated 13 lines...]
FATAL: Could not delete file C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build.repro\solr-core\classes\java\org\apache\solr\internal
java.io.IOException: Could not delete file C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build.repro\solr-core\classes\java\org\apache\solr\internal
at org.eclipse.jgit.util.FileUtils.delete(FileUtils.java:197)
at org.eclipse.jgit.util.FileUtils.delete(FileUtils.java:166)
at org.eclipse.jgit.util.FileUtils.delete(FileUtils.java:166)
at org.eclipse.jgit.util.FileUtils.delete(FileUtils.java:166)
at org.eclipse.jgit.util.FileUtils.delete(FileUtils.java:166)
at org.eclipse.jgit.util.FileUtils.delete(FileUtils.java:166)
at org.eclipse.jgit.util.FileUtils.delete(FileUtils.java:166)
at org.eclipse.jgit.util.FileUtils.delete(FileUtils.java:166)
at org.eclipse.jgit.api.CleanCommand.cleanPath(CleanCommand.java:176)
at org.eclipse.jgit.api.CleanCommand.call(CleanCommand.java:133)
Also: hudson.remoting.Channel$CallSiteStackTrace: Remote call to Windows VBOX
at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1737)
at hudson.remoting.UserResponse.retrieve(UserRequest.java:313)
at hudson.remoting.Channel.call(Channel.java:952)
at hudson.remoting.RemoteInvocationHandler.invoke(RemoteInvocationHandler.java:278)
at com.sun.proxy.$Proxy65.clean(Unknown Source)
at org.jenkinsci.plugins.gitclient.RemoteGitImpl.clean(RemoteGitImpl.java:450)
at hudson.plugins.git.extensions.impl.CleanBeforeCheckout.decorateFetchCommand(CleanBeforeCheckout.java:30)
at hudson.plugins.git.GitSCM.fetchFrom(GitSCM.java:858)
at hudson.plugins.git.GitSCM.retrieveChanges(GitSCM.java:1129)
at hudson.plugins.git.GitSCM.checkout(GitSCM.java:1160)
at hudson.scm.SCM.checkout(SCM.java:504)
at hudson.model.AbstractProject.checkout(AbstractProject.java:1208)
at hudson.model.AbstractBuild$AbstractBuildExecution.defaultCheckout(AbstractBuild.java:574)
at jenkins.scm.SCMCheckoutStrategy.checkout(SCMCheckoutStrategy.java:86)
at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:499)
at hudson.model.Run.execute(Run.java:1727)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:429)
Caused: org.eclipse.jgit.api.errors.JGitInternalException: Could not delete file C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build.repro\solr-core\classes\java\org\apache\solr\internal
at org.eclipse.jgit.api.CleanCommand.call(CleanCommand.java:136)
at org.jenkinsci.plugins.gitclient.JGitAPIImpl.clean(JGitAPIImpl.java:1290)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
at java.lang.reflect.Method.invoke(Unknown Source)
at hudson.remoting.RemoteInvocationHandler$RPCRequest.perform(RemoteInvocationHandler.java:927)
at hudson.remoting.RemoteInvocationHandler$RPCRequest.call(RemoteInvocationHandler.java:901)
at hudson.remoting.RemoteInvocationHandler$RPCRequest.call(RemoteInvocationHandler.java:850)
at hudson.remoting.UserRequest.perform(UserRequest.java:210)
at hudson.remoting.UserRequest.perform(UserRequest.java:53)
at hudson.remoting.Request$2.run(Request.java:364)
at hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:72)
at java.util.concurrent.FutureTask.run(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at java.lang.Thread.run(Unknown Source)
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
ERROR: Step ‘Publish JUnit test result report’ failed: Test reports were found but none of them are new. Did leafNodes run?
For example, C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build.repro\solr-core\test\TEST-org.apache.solr.handler.component.DistributedTermsComponentTest-2.xml is 9 hr 33 min old
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any