You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2015/12/14 23:07:40 UTC
[JENKINS] Lucene-Solr-trunk-Solaris (64bit/jdk1.8.0) - Build # 259
- Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Solaris/259/
Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseParallelGC
2 tests failed.
FAILED: org.apache.lucene.replicator.http.HttpReplicatorTest.testBasic
Error Message:
Connection reset
Stack Trace:
java.net.SocketException: Connection reset
at __randomizedtesting.SeedInfo.seed([78B30B3F007F8751:D349162ADFA3017F]:0)
at java.net.SocketInputStream.read(SocketInputStream.java:209)
at java.net.SocketInputStream.read(SocketInputStream.java:141)
at org.apache.http.impl.io.SessionInputBufferImpl.streamRead(SessionInputBufferImpl.java:139)
at org.apache.http.impl.io.SessionInputBufferImpl.fillBuffer(SessionInputBufferImpl.java:155)
at org.apache.http.impl.io.SessionInputBufferImpl.readLine(SessionInputBufferImpl.java:284)
at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140)
at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261)
at org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:165)
at org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:167)
at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272)
at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124)
at org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:271)
at org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:184)
at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:88)
at org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
at org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:184)
at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107)
at org.apache.lucene.replicator.http.HttpClientBase.executeGET(HttpClientBase.java:159)
at org.apache.lucene.replicator.http.HttpReplicator.checkForUpdate(HttpReplicator.java:51)
at org.apache.lucene.replicator.ReplicationClient.doUpdate(ReplicationClient.java:196)
at org.apache.lucene.replicator.ReplicationClient.updateNow(ReplicationClient.java:402)
at org.apache.lucene.replicator.http.HttpReplicatorTest.testBasic(HttpReplicatorTest.java:122)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:497)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
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:54)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at java.lang.Thread.run(Thread.java:745)
FAILED: org.apache.lucene.replicator.http.HttpReplicatorTest.testServerErrors
Error Message:
127.0.0.1:47381 failed to respond
Stack Trace:
org.apache.http.NoHttpResponseException: 127.0.0.1:47381 failed to respond
at __randomizedtesting.SeedInfo.seed([78B30B3F007F8751:6FD8A48094FF05C3]:0)
at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:143)
at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261)
at org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:165)
at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272)
at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124)
at org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:271)
at org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:184)
at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:88)
at org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
at org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:184)
at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107)
at org.apache.lucene.replicator.http.HttpClientBase.executeGET(HttpClientBase.java:159)
at org.apache.lucene.replicator.http.HttpReplicator.checkForUpdate(HttpReplicator.java:51)
at org.apache.lucene.replicator.ReplicationClient.doUpdate(ReplicationClient.java:196)
at org.apache.lucene.replicator.ReplicationClient.updateNow(ReplicationClient.java:402)
at org.apache.lucene.replicator.http.HttpReplicatorTest.testServerErrors(HttpReplicatorTest.java:155)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:497)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
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:54)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 7604 lines...]
[junit4] Suite: org.apache.lucene.replicator.http.HttpReplicatorTest
[junit4] 2> 2015-12-14 23:07:29.042:INFO::TEST-HttpReplicatorTest.testBasic-seed#[78B30B3F007F8751]: Logging initialized @2204ms
[junit4] 2> 2015-12-14 23:07:29.255:INFO:oejs.Server:TEST-HttpReplicatorTest.testBasic-seed#[78B30B3F007F8751]: jetty-9.3.6.v20151106
[junit4] 2> 2015-12-14 23:07:29.437:INFO:oejs.ServerConnector:TEST-HttpReplicatorTest.testBasic-seed#[78B30B3F007F8751]: Started ServerConnector@60b58bc8{HTTP/1.1,[http/1.1]}{127.0.0.1:60065}
[junit4] 2> 2015-12-14 23:07:29.440:INFO:oejs.Server:TEST-HttpReplicatorTest.testBasic-seed#[78B30B3F007F8751]: Started @2601ms
[junit4] 2> Ara 14, 2015 11:07:30 PM org.apache.http.impl.execchain.RetryExec execute
[junit4] 2> INFO: I/O exception (org.apache.http.NoHttpResponseException) caught when processing request to {}->http://127.0.0.1:60065: The target server failed to respond
[junit4] 2> Ara 14, 2015 11:07:30 PM org.apache.http.impl.execchain.RetryExec execute
[junit4] 2> INFO: Retrying request to {}->http://127.0.0.1:60065
[junit4] 2> Ara 14, 2015 11:07:30 PM org.apache.http.impl.execchain.RetryExec execute
[junit4] 2> INFO: I/O exception (java.net.SocketException) caught when processing request to {}->http://127.0.0.1:60065: Connection reset
[junit4] 2> Ara 14, 2015 11:07:30 PM org.apache.http.impl.execchain.RetryExec execute
[junit4] 2> INFO: Retrying request to {}->http://127.0.0.1:60065
[junit4] 2> Ara 14, 2015 11:07:30 PM org.apache.http.impl.execchain.RetryExec execute
[junit4] 2> INFO: I/O exception (java.net.SocketException) caught when processing request to {}->http://127.0.0.1:60065: Connection reset
[junit4] 2> Ara 14, 2015 11:07:30 PM org.apache.http.impl.execchain.RetryExec execute
[junit4] 2> INFO: Retrying request to {}->http://127.0.0.1:60065
[junit4] 2> 2015-12-14 23:07:30.704:INFO:oejs.ServerConnector:TEST-HttpReplicatorTest.testBasic-seed#[78B30B3F007F8751]: Stopped ServerConnector@60b58bc8{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=HttpReplicatorTest -Dtests.method=testBasic -Dtests.seed=78B30B3F007F8751 -Dtests.slow=true -Dtests.locale=tr_TR -Dtests.timezone=Africa/Porto-Novo -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 1.87s J0 | HttpReplicatorTest.testBasic <<<
[junit4] > Throwable #1: java.net.SocketException: Connection reset
[junit4] > at __randomizedtesting.SeedInfo.seed([78B30B3F007F8751:D349162ADFA3017F]:0)
[junit4] > at java.net.SocketInputStream.read(SocketInputStream.java:209)
[junit4] > at java.net.SocketInputStream.read(SocketInputStream.java:141)
[junit4] > at org.apache.http.impl.io.SessionInputBufferImpl.streamRead(SessionInputBufferImpl.java:139)
[junit4] > at org.apache.http.impl.io.SessionInputBufferImpl.fillBuffer(SessionInputBufferImpl.java:155)
[junit4] > at org.apache.http.impl.io.SessionInputBufferImpl.readLine(SessionInputBufferImpl.java:284)
[junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140)
[junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
[junit4] > at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261)
[junit4] > at org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:165)
[junit4] > at org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:167)
[junit4] > at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272)
[junit4] > at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124)
[junit4] > at org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:271)
[junit4] > at org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:184)
[junit4] > at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:88)
[junit4] > at org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
[junit4] > at org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:184)
[junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
[junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107)
[junit4] > at org.apache.lucene.replicator.http.HttpClientBase.executeGET(HttpClientBase.java:159)
[junit4] > at org.apache.lucene.replicator.http.HttpReplicator.checkForUpdate(HttpReplicator.java:51)
[junit4] > at org.apache.lucene.replicator.ReplicationClient.doUpdate(ReplicationClient.java:196)
[junit4] > at org.apache.lucene.replicator.ReplicationClient.updateNow(ReplicationClient.java:402)
[junit4] > at org.apache.lucene.replicator.http.HttpReplicatorTest.testBasic(HttpReplicatorTest.java:122)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 2015-12-14 23:07:30.792:INFO:oejs.Server:TEST-HttpReplicatorTest.testServerErrors-seed#[78B30B3F007F8751]: jetty-9.3.6.v20151106
[junit4] 2> 2015-12-14 23:07:30.793:INFO:oejs.ServerConnector:TEST-HttpReplicatorTest.testServerErrors-seed#[78B30B3F007F8751]: Started ServerConnector@1be3414b{HTTP/1.1,[http/1.1]}{127.0.0.1:47381}
[junit4] 2> 2015-12-14 23:07:30.794:INFO:oejs.Server:TEST-HttpReplicatorTest.testServerErrors-seed#[78B30B3F007F8751]: Started @3956ms
[junit4] 2> Ara 14, 2015 11:07:30 PM org.apache.http.impl.execchain.RetryExec execute
[junit4] 2> INFO: I/O exception (org.apache.http.NoHttpResponseException) caught when processing request to {}->http://127.0.0.1:47381: The target server failed to respond
[junit4] 2> Ara 14, 2015 11:07:30 PM org.apache.http.impl.execchain.RetryExec execute
[junit4] 2> INFO: Retrying request to {}->http://127.0.0.1:47381
[junit4] 2> Ara 14, 2015 11:07:30 PM org.apache.http.impl.execchain.RetryExec execute
[junit4] 2> INFO: I/O exception (org.apache.http.NoHttpResponseException) caught when processing request to {}->http://127.0.0.1:47381: The target server failed to respond
[junit4] 2> Ara 14, 2015 11:07:30 PM org.apache.http.impl.execchain.RetryExec execute
[junit4] 2> INFO: Retrying request to {}->http://127.0.0.1:47381
[junit4] 2> Ara 14, 2015 11:07:30 PM org.apache.http.impl.execchain.RetryExec execute
[junit4] 2> INFO: I/O exception (org.apache.http.NoHttpResponseException) caught when processing request to {}->http://127.0.0.1:47381: The target server failed to respond
[junit4] 2> Ara 14, 2015 11:07:30 PM org.apache.http.impl.execchain.RetryExec execute
[junit4] 2> INFO: Retrying request to {}->http://127.0.0.1:47381
[junit4] 2> Ara 14, 2015 11:07:30 PM org.apache.http.impl.execchain.RetryExec execute
[junit4] 2> INFO: I/O exception (org.apache.http.NoHttpResponseException) caught when processing request to {}->http://127.0.0.1:47381: The target server failed to respond
[junit4] 2> Ara 14, 2015 11:07:30 PM org.apache.http.impl.execchain.RetryExec execute
[junit4] 2> INFO: Retrying request to {}->http://127.0.0.1:47381
[junit4] 2> Ara 14, 2015 11:07:30 PM org.apache.http.impl.execchain.RetryExec execute
[junit4] 2> INFO: I/O exception (org.apache.http.NoHttpResponseException) caught when processing request to {}->http://127.0.0.1:47381: The target server failed to respond
[junit4] 2> Ara 14, 2015 11:07:30 PM org.apache.http.impl.execchain.RetryExec execute
[junit4] 2> INFO: Retrying request to {}->http://127.0.0.1:47381
[junit4] 2> Ara 14, 2015 11:07:30 PM org.apache.http.impl.execchain.RetryExec execute
[junit4] 2> INFO: I/O exception (org.apache.http.NoHttpResponseException) caught when processing request to {}->http://127.0.0.1:47381: The target server failed to respond
[junit4] 2> Ara 14, 2015 11:07:30 PM org.apache.http.impl.execchain.RetryExec execute
[junit4] 2> INFO: Retrying request to {}->http://127.0.0.1:47381
[junit4] 2> 2015-12-14 23:07:30.878:INFO:oejs.ServerConnector:TEST-HttpReplicatorTest.testServerErrors-seed#[78B30B3F007F8751]: Stopped ServerConnector@1be3414b{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=HttpReplicatorTest -Dtests.method=testServerErrors -Dtests.seed=78B30B3F007F8751 -Dtests.slow=true -Dtests.locale=tr_TR -Dtests.timezone=Africa/Porto-Novo -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.12s J0 | HttpReplicatorTest.testServerErrors <<<
[junit4] > Throwable #1: org.apache.http.NoHttpResponseException: 127.0.0.1:47381 failed to respond
[junit4] > at __randomizedtesting.SeedInfo.seed([78B30B3F007F8751:6FD8A48094FF05C3]:0)
[junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:143)
[junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
[junit4] > at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261)
[junit4] > at org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:165)
[junit4] > at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272)
[junit4] > at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124)
[junit4] > at org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:271)
[junit4] > at org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:184)
[junit4] > at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:88)
[junit4] > at org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
[junit4] > at org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:184)
[junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
[junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107)
[junit4] > at org.apache.lucene.replicator.http.HttpClientBase.executeGET(HttpClientBase.java:159)
[junit4] > at org.apache.lucene.replicator.http.HttpReplicator.checkForUpdate(HttpReplicator.java:51)
[junit4] > at org.apache.lucene.replicator.ReplicationClient.doUpdate(ReplicationClient.java:196)
[junit4] > at org.apache.lucene.replicator.ReplicationClient.updateNow(ReplicationClient.java:402)
[junit4] > at org.apache.lucene.replicator.http.HttpReplicatorTest.testServerErrors(HttpReplicatorTest.java:155)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> NOTE: leaving temporary files on disk at: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/lucene/build/replicator/test/J0/temp/lucene.replicator.http.HttpReplicatorTest_78B30B3F007F8751-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene60): {}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=false,coord=no): {}, locale=tr_TR, timezone=Africa/Porto-Novo
[junit4] 2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_66 (64-bit)/cpus=3,threads=1,free=74873144,total=115343360
[junit4] 2> NOTE: All tests run in this JVM: [HttpReplicatorTest]
[junit4] Completed [3/7 (1!)] on J0 in 2.54s, 2 tests, 2 errors <<< FAILURES!
[...truncated 23 lines...]
BUILD FAILED
/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/build.xml:784: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/build.xml:728: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/build.xml:59: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/lucene/build.xml:472: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/lucene/common-build.xml:2166: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/lucene/module-build.xml:58: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/lucene/common-build.xml:1436: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/lucene/common-build.xml:991: There were test failures: 7 suites, 31 tests, 2 errors [seed: 78B30B3F007F8751]
Total time: 19 minutes 17 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
[JENKINS] Lucene-Solr-trunk-Solaris (64bit/jdk1.8.0) - Build # 261
- Still Failing!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Solaris/261/
Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseSerialGC
4 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.core.TestCoreDiscovery
Error Message:
ERROR: SolrIndexSearcher opens=27 closes=26
Stack Trace:
java.lang.AssertionError: ERROR: SolrIndexSearcher opens=27 closes=26
at __randomizedtesting.SeedInfo.seed([45F43F257D825341]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.apache.solr.SolrTestCaseJ4.endTrackingSearchers(SolrTestCaseJ4.java:453)
at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:225)
at sun.reflect.GeneratedMethodAccessor19.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:497)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:834)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
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:54)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at java.lang.Thread.run(Thread.java:745)
FAILED: junit.framework.TestSuite.org.apache.solr.core.TestCoreDiscovery
Error Message:
1 thread leaked from SUITE scope at org.apache.solr.core.TestCoreDiscovery: 1) Thread[id=14668, name=searcherExecutor-6412-thread-1, state=WAITING, group=TGRP-TestCoreDiscovery] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:745)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.core.TestCoreDiscovery:
1) Thread[id=14668, name=searcherExecutor-6412-thread-1, state=WAITING, group=TGRP-TestCoreDiscovery]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
at __randomizedtesting.SeedInfo.seed([45F43F257D825341]:0)
FAILED: junit.framework.TestSuite.org.apache.solr.core.TestCoreDiscovery
Error Message:
There are still zombie threads that couldn't be terminated: 1) Thread[id=14668, name=searcherExecutor-6412-thread-1, state=WAITING, group=TGRP-TestCoreDiscovery] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:745)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
1) Thread[id=14668, name=searcherExecutor-6412-thread-1, state=WAITING, group=TGRP-TestCoreDiscovery]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
at __randomizedtesting.SeedInfo.seed([45F43F257D825341]:0)
FAILED: org.apache.solr.handler.TestReplicationHandler.doTestStressReplication
Error Message:
timed out waiting for collection1 startAt time to exceed: Tue Dec 15 18:41:37 MSK 2015
Stack Trace:
java.lang.AssertionError: timed out waiting for collection1 startAt time to exceed: Tue Dec 15 18:41:37 MSK 2015
at __randomizedtesting.SeedInfo.seed([45F43F257D825341:9E5F3FE378AA3AF2]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.apache.solr.handler.TestReplicationHandler.watchCoreStartAt(TestReplicationHandler.java:1419)
at org.apache.solr.handler.TestReplicationHandler.doTestStressReplication(TestReplicationHandler.java:771)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:497)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
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:54)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 10215 lines...]
[junit4] Suite: org.apache.solr.handler.TestReplicationHandler
[junit4] 2> Creating dataDir: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/init-core-data-001
[junit4] 2> 1864473 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testEmptyCommits
[junit4] 2> 1864474 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-001/collection1
[junit4] 2> 1864509 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.e.j.s.Server jetty-9.3.6.v20151106
[junit4] 2> 1864510 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@774784f0{/solr,null,AVAILABLE}
[junit4] 2> 1864529 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.e.j.s.ServerConnector Started ServerConnector@35cee0d2{HTTP/1.1,[http/1.1]}{127.0.0.1:49643}
[junit4] 2> 1864529 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.e.j.s.Server Started @1872509ms
[junit4] 2> 1864529 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-001/collection1/data, hostContext=/solr, hostPort=49643}
[junit4] 2> 1864529 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@659e0bfd
[junit4] 2> 1864529 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-001'
[junit4] 2> 1864530 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1864530 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 1864530 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-001/solr.xml
[junit4] 2> 1864543 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-001/.
[junit4] 2> 1864543 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.c.CoreContainer New CoreContainer 814676950
[junit4] 2> 1864543 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-001]
[junit4] 2> 1864543 WARN (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.c.CoreContainer Couldn't add files from /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-001/lib to classpath: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-001/lib
[junit4] 2> 1864544 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
[junit4] 2> 1864545 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1864545 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1864545 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1864546 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 1864546 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 1864546 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-001/.
[junit4] 2> 1864547 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data/}
[junit4] 2> 1864548 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.c.CorePropertiesLocator Found core collection1 in /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-001/./collection1
[junit4] 2> 1864548 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
[junit4] 2> 1864549 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.s.SolrDispatchFilter user.dir=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1
[junit4] 2> 1864549 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 1864550 INFO (coreLoadExecutor-5255-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-001/collection1'
[junit4] 2> 1864550 INFO (coreLoadExecutor-5255-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1864550 INFO (coreLoadExecutor-5255-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 1864557 INFO (coreLoadExecutor-5255-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 1864559 INFO (coreLoadExecutor-5255-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 1864563 INFO (coreLoadExecutor-5255-thread-1) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1864566 INFO (coreLoadExecutor-5255-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1864568 INFO (coreLoadExecutor-5255-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 1864569 INFO (coreLoadExecutor-5255-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-001/collection1'
[junit4] 2> 1864570 INFO (coreLoadExecutor-5255-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-001/./collection1
[junit4] 2> 1864570 INFO (coreLoadExecutor-5255-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1864570 INFO (coreLoadExecutor-5255-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-001/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-001/./collection1/data/]
[junit4] 2> 1864570 INFO (coreLoadExecutor-5255-thread-1) [ x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
[junit4] 2> 1864570 INFO (coreLoadExecutor-5255-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-001/./collection1/data
[junit4] 2> 1864570 INFO (coreLoadExecutor-5255-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-001/./collection1/data/index/
[junit4] 2> 1864570 WARN (coreLoadExecutor-5255-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-001/./collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 1864570 INFO (coreLoadExecutor-5255-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-001/./collection1/data/index
[junit4] 2> 1864571 INFO (coreLoadExecutor-5255-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=22, maxMergeAtOnceExplicit=26, maxMergedSegmentMB=35.31640625, floorSegmentMB=1.3564453125, forceMergeDeletesPctAllowed=11.3188745513442, segmentsPerTier=27.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 1864571 INFO (coreLoadExecutor-5255-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@68dd2dcc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5bd9491),segFN=segments_1,generation=1}
[junit4] 2> 1864571 INFO (coreLoadExecutor-5255-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 1864572 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-001/./collection1/data/
[junit4] 2> 1864595 INFO (coreLoadExecutor-5255-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1864598 INFO (coreLoadExecutor-5255-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1864605 INFO (coreLoadExecutor-5255-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1864605 INFO (coreLoadExecutor-5255-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1864606 INFO (coreLoadExecutor-5255-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1864608 INFO (coreLoadExecutor-5255-thread-1) [ x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy
[junit4] 2> 1864608 INFO (coreLoadExecutor-5255-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,lazy,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,defaults,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
[junit4] 2> 1864608 INFO (coreLoadExecutor-5255-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 1864609 INFO (coreLoadExecutor-5255-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1864609 INFO (coreLoadExecutor-5255-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1864609 INFO (coreLoadExecutor-5255-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=613440346, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1864609 INFO (coreLoadExecutor-5255-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@68dd2dcc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5bd9491),segFN=segments_1,generation=1}
[junit4] 2> 1864609 INFO (coreLoadExecutor-5255-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 1864609 INFO (coreLoadExecutor-5255-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@63728d0[collection1] main
[junit4] 2> 1864610 INFO (coreLoadExecutor-5255-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-001/collection1/conf
[junit4] 2> 1864610 INFO (coreLoadExecutor-5255-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-001/collection1/conf}
[junit4] 2> 1864610 INFO (coreLoadExecutor-5255-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-001/collection1/conf
[junit4] 2> 1864610 INFO (coreLoadExecutor-5255-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 1864610 INFO (coreLoadExecutor-5255-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 1864610 INFO (coreLoadExecutor-5255-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1864610 INFO (coreLoadExecutor-5255-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 1864610 INFO (searcherExecutor-5256-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@63728d0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1865054 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/collection1
[junit4] 2> 1865057 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.e.j.s.Server jetty-9.3.6.v20151106
[junit4] 2> 1865061 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@f484285{/solr,null,AVAILABLE}
[junit4] 2> 1865062 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.e.j.s.ServerConnector Started ServerConnector@7c54739e{HTTP/1.1,[http/1.1]}{127.0.0.1:51195}
[junit4] 2> 1865062 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.e.j.s.Server Started @1873042ms
[junit4] 2> 1865062 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/collection1/data, hostContext=/solr, hostPort=51195}
[junit4] 2> 1865062 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@659e0bfd
[junit4] 2> 1865062 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002'
[junit4] 2> 1865062 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1865062 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 1865063 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/solr.xml
[junit4] 2> 1865066 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/.
[junit4] 2> 1865066 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.c.CoreContainer New CoreContainer 1163977227
[junit4] 2> 1865066 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002]
[junit4] 2> 1865066 WARN (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.c.CoreContainer Couldn't add files from /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/lib to classpath: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/lib
[junit4] 2> 1865066 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
[junit4] 2> 1865067 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1865068 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1865068 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1865068 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 1865068 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 1865069 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/.
[junit4] 2> 1865070 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data/}
[junit4] 2> 1865070 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.c.CorePropertiesLocator Found core collection1 in /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/./collection1
[junit4] 2> 1865070 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
[junit4] 2> 1865071 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.s.SolrDispatchFilter user.dir=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1
[junit4] 2> 1865071 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 1865073 INFO (coreLoadExecutor-5265-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/collection1'
[junit4] 2> 1865074 INFO (coreLoadExecutor-5265-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1865074 INFO (coreLoadExecutor-5265-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 1865078 INFO (coreLoadExecutor-5265-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 1865080 INFO (coreLoadExecutor-5265-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 1865084 INFO (coreLoadExecutor-5265-thread-1) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1865086 INFO (coreLoadExecutor-5265-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1865088 INFO (coreLoadExecutor-5265-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 1865089 INFO (coreLoadExecutor-5265-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/collection1'
[junit4] 2> 1865089 INFO (coreLoadExecutor-5265-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/./collection1
[junit4] 2> 1865089 INFO (coreLoadExecutor-5265-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1865089 INFO (coreLoadExecutor-5265-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/./collection1/data/]
[junit4] 2> 1865089 INFO (coreLoadExecutor-5265-thread-1) [ x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
[junit4] 2> 1865090 INFO (coreLoadExecutor-5265-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/./collection1/data
[junit4] 2> 1865090 INFO (coreLoadExecutor-5265-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/./collection1/data/index/
[junit4] 2> 1865090 WARN (coreLoadExecutor-5265-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/./collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 1865090 INFO (coreLoadExecutor-5265-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/./collection1/data/index
[junit4] 2> 1865090 INFO (coreLoadExecutor-5265-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=22, maxMergeAtOnceExplicit=26, maxMergedSegmentMB=35.31640625, floorSegmentMB=1.3564453125, forceMergeDeletesPctAllowed=11.3188745513442, segmentsPerTier=27.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 1865091 INFO (coreLoadExecutor-5265-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@3cf8626a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7385f567),segFN=segments_1,generation=1}
[junit4] 2> 1865091 INFO (coreLoadExecutor-5265-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 1865091 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/./collection1/data/
[junit4] 2> 1865093 INFO (coreLoadExecutor-5265-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1865094 INFO (coreLoadExecutor-5265-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1865095 INFO (coreLoadExecutor-5265-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1865096 INFO (coreLoadExecutor-5265-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1865097 INFO (coreLoadExecutor-5265-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1865098 INFO (coreLoadExecutor-5265-thread-1) [ x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy
[junit4] 2> 1865098 INFO (coreLoadExecutor-5265-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,lazy,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,defaults,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
[junit4] 2> 1865098 INFO (coreLoadExecutor-5265-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 1865098 INFO (coreLoadExecutor-5265-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1865098 INFO (coreLoadExecutor-5265-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1865099 INFO (coreLoadExecutor-5265-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=613440346, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1865099 INFO (coreLoadExecutor-5265-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@3cf8626a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7385f567),segFN=segments_1,generation=1}
[junit4] 2> 1865100 INFO (coreLoadExecutor-5265-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 1865100 INFO (coreLoadExecutor-5265-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@3d079b9e[collection1] main
[junit4] 2> 1865100 INFO (coreLoadExecutor-5265-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/collection1/conf
[junit4] 2> 1865100 INFO (coreLoadExecutor-5265-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/collection1/conf}
[junit4] 2> 1865100 INFO (coreLoadExecutor-5265-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/collection1/conf
[junit4] 2> 1865100 INFO (coreLoadExecutor-5265-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 1865101 INFO (coreLoadExecutor-5265-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
[junit4] 2> 1865101 INFO (coreLoadExecutor-5265-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 1865102 INFO (searcherExecutor-5266-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3d079b9e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1865576 INFO (qtp1300959840-12694) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> 1865579 INFO (qtp1300959840-12695) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[1]} 0 0
[junit4] 2> 1865581 INFO (qtp1300959840-12696) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1865583 INFO (qtp1300959840-12696) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@68dd2dcc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5bd9491),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@68dd2dcc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5bd9491),segFN=segments_2,generation=2}
[junit4] 2> 1865583 INFO (qtp1300959840-12696) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 2
[junit4] 2> 1865585 INFO (qtp1300959840-12696) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@48a44ca7[collection1] main
[junit4] 2> 1865585 INFO (qtp1300959840-12696) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1865585 INFO (searcherExecutor-5256-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@48a44ca7[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C1)))}
[junit4] 2> 1865585 INFO (qtp1300959840-12696) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={commit=true&wt=javabin&version=2}{commit=} 0 3
[junit4] 2> 1865594 WARN (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix
[junit4] 2> 1865596 INFO (qtp1300959840-12698) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
[junit4] 2> 1865596 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Master's generation: 2
[junit4] 2> 1865597 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Slave's generation: 1
[junit4] 2> 1865597 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Starting replication process
[junit4] 2> 1865598 WARN (qtp1300959840-12692) [ x:collection1] o.a.s.h.ReplicationHandler Could not read checksum from index file: _0_MockRandom_0.sd
[junit4] 2> java.lang.ArrayIndexOutOfBoundsException
[junit4] 2> 1865601 INFO (qtp1300959840-12692) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&wt=javabin&version=2&command=filelist} status=0 QTime=3
[junit4] 2> 1865602 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Number of files in latest index in master: 11
[junit4] 2> 1865602 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/./collection1/data/index.20151215184131452
[junit4] 2> 1865602 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
[junit4] 2> 1865602 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=13, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5999591403033244]
[junit4] 2> 1865603 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@3cf8626a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7385f567),segFN=segments_1,generation=1}
[junit4] 2> 1865604 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 1865604 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1865604 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@3cf8626a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7385f567),segFN=segments_1,generation=1}
[junit4] 2> 1865604 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 1865604 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
[junit4] 2> 1865604 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Starting download (fullCopy=false) to MockDirectoryWrapper(RAMDirectory@7a19b45e lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@11382706)
[junit4] 2> 1865606 INFO (qtp1300959840-12691) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.si&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865613 INFO (qtp1300959840-12694) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0_MockRandom_0.tix&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865616 INFO (qtp1300959840-12695) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0_MockRandom_0.doc&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865619 INFO (qtp1300959840-12696) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.nvd&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865621 INFO (qtp1300959840-12697) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0_MockRandom_0.tbk&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865623 INFO (qtp1300959840-12698) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0_MockRandom_0.sd&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865626 INFO (qtp1300959840-12692) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.fdx&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865629 INFO (qtp1300959840-12691) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.fdt&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865631 INFO (qtp1300959840-12694) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.fnm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865633 INFO (qtp1300959840-12695) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.nvm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865635 INFO (qtp1300959840-12696) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=segments_2&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865636 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Total time taken for download (fullCopy=false,bytesDownloaded=1594) : 0 secs (null bytes/sec) to MockDirectoryWrapper(RAMDirectory@7a19b45e lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@11382706)
[junit4] 2> 1865638 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=23, maxMergeAtOnceExplicit=29, maxMergedSegmentMB=31.6005859375, floorSegmentMB=1.2138671875, forceMergeDeletesPctAllowed=6.390960140636153, segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 1865638 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@3cf8626a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7385f567),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@3cf8626a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7385f567),segFN=segments_2,generation=2}
[junit4] 2> 1865639 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 2
[junit4] 2> 1865639 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1865639 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@6075da2d[collection1] main
[junit4] 2> 1865640 INFO (searcherExecutor-5266-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6075da2d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C1)))}
[junit4] 2> 1865640 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/./collection1/data/index.20151215184131452 [CachedDir<<refCount=0;path=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/./collection1/data/index.20151215184131452;done=true>>]
[junit4] 2> 1865640 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/./collection1/data/index.20151215184131452
[junit4] 2> 1865640 INFO (qtp2125443004-12712) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={wait=true&masterUrl=http://127.0.0.1:49643/solr/collection1/replication&command=fetchindex} status=0 QTime=49
[junit4] 2> 1865646 INFO (qtp2125443004-12714) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=name:empty1&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=3
[junit4] 2> 1865646 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 1 docs
[junit4] 2> 1865648 INFO (qtp1300959840-12697) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=0
[junit4] 2> 1865651 INFO (qtp1300959840-12698) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=0
[junit4] 2> 1865658 INFO (qtp1300959840-12692) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={slave=false&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=0
[junit4] 2> 1865659 INFO (qtp2125443004-12716) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=5
[junit4] 2> 1865661 INFO (qtp1300959840-12691) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=assertVersions&qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
[junit4] 2> 1865664 INFO (qtp2125443004-12711) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=assertVersions&qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
[junit4] 2> 1865666 INFO (qtp1300959840-12694) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1865666 INFO (qtp1300959840-12694) [ x:collection1] o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 1865667 INFO (qtp1300959840-12694) [ x:collection1] o.a.s.c.SolrCore SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
[junit4] 2> 1865667 INFO (qtp1300959840-12694) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1865667 INFO (qtp1300959840-12694) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={commit=true&wt=javabin&version=2}{commit=} 0 1
[junit4] 2> 1865669 WARN (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix
[junit4] 2> 1865671 INFO (qtp1300959840-12695) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
[junit4] 2> 1865671 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Slave in sync with master.
[junit4] 2> 1865672 INFO (qtp2125443004-12715) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={wait=true&masterUrl=http://127.0.0.1:49643/solr/collection1/replication&command=fetchindex} status=0 QTime=4
[junit4] 2> 1865676 INFO (qtp1300959840-12695) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[2]} 0 0
[junit4] 2> 1865678 INFO (qtp1300959840-12697) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1865683 INFO (qtp1300959840-12698) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
[junit4] 2> 1865684 INFO (indexFetcher-5270-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Slave in sync with master.
[junit4] 2> 1865684 INFO (qtp1300959840-12697) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@68dd2dcc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5bd9491),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@68dd2dcc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5bd9491),segFN=segments_3,generation=3}
[junit4] 2> 1865685 INFO (qtp1300959840-12697) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 3
[junit4] 2> 1865685 INFO (qtp1300959840-12697) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@33d8f46d[collection1] main
[junit4] 2> 1865685 INFO (qtp1300959840-12697) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1865685 INFO (searcherExecutor-5256-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@33d8f46d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C1) Uninverting(_1(6.0.0):C1)))}
[junit4] 2> 1865685 INFO (qtp1300959840-12697) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={commit=true&wt=javabin&version=2}{commit=} 0 7
[junit4] 2> 1865687 WARN (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix
[junit4] 2> 1865690 INFO (qtp1300959840-12692) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
[junit4] 2> 1865691 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Master's generation: 3
[junit4] 2> 1865691 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Slave's generation: 2
[junit4] 2> 1865691 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Starting replication process
[junit4] 2> 1865693 WARN (qtp1300959840-12691) [ x:collection1] o.a.s.h.ReplicationHandler Could not read checksum from index file: _0_MockRandom_0.sd
[junit4] 2> java.lang.ArrayIndexOutOfBoundsException
[junit4] 2> 1865693 WARN (qtp1300959840-12691) [ x:collection1] o.a.s.h.ReplicationHandler Could not read checksum from index file: _1_MockRandom_0.sd
[junit4] 2> java.lang.ArrayIndexOutOfBoundsException
[junit4] 2> 1865693 INFO (qtp1300959840-12691) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&wt=javabin&version=2&command=filelist} status=0 QTime=1
[junit4] 2> 1865694 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Number of files in latest index in master: 20
[junit4] 2> 1865695 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/./collection1/data/index.20151215184131545
[junit4] 2> 1865695 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
[junit4] 2> 1865695 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=13, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5999591403033244]
[junit4] 2> 1865696 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@3cf8626a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7385f567),segFN=segments_2,generation=2}
[junit4] 2> 1865696 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 2
[junit4] 2> 1865697 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1865697 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@3cf8626a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7385f567),segFN=segments_2,generation=2}
[junit4] 2> 1865697 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 2
[junit4] 2> 1865697 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
[junit4] 2> 1865697 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Starting download (fullCopy=false) to MockDirectoryWrapper(RAMDirectory@6dda9a5e lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6b2ad8bc)
[junit4] 2> 1865697 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.si because it already exists
[junit4] 2> 1865697 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0_MockRandom_0.tix because it already exists
[junit4] 2> 1865697 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0_MockRandom_0.doc because it already exists
[junit4] 2> 1865697 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.nvd because it already exists
[junit4] 2> 1865697 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0_MockRandom_0.tbk because it already exists
[junit4] 2> 1865699 INFO (qtp1300959840-12694) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_0_MockRandom_0.sd&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865700 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.fdx because it already exists
[junit4] 2> 1865700 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.fdt because it already exists
[junit4] 2> 1865701 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.fnm because it already exists
[junit4] 2> 1865701 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.nvm because it already exists
[junit4] 2> 1865703 INFO (qtp1300959840-12696) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1_MockRandom_0.doc&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865705 INFO (qtp1300959840-12695) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1_MockRandom_0.sd&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865709 INFO (qtp1300959840-12698) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.si&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865712 INFO (qtp1300959840-12697) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.nvd&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865715 INFO (qtp1300959840-12692) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.fdx&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865717 INFO (qtp1300959840-12691) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.fnm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865719 INFO (qtp1300959840-12694) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.nvm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865722 INFO (qtp1300959840-12696) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1_MockRandom_0.tfp&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865725 INFO (qtp1300959840-12695) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.fdt&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865729 INFO (qtp1300959840-12698) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=segments_3&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865730 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Total time taken for download (fullCopy=false,bytesDownloaded=1571) : 0 secs (null bytes/sec) to MockDirectoryWrapper(RAMDirectory@6dda9a5e lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6b2ad8bc)
[junit4] 2> 1865731 WARN (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Cannot complete replication attempt because file already exists:_0_MockRandom_0.sd
[junit4] 2> 1865731 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=23, maxMergeAtOnceExplicit=29, maxMergedSegmentMB=31.6005859375, floorSegmentMB=1.2138671875, forceMergeDeletesPctAllowed=6.390960140636153, segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 1865731 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@3cf8626a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7385f567),segFN=segments_2,generation=2}
[junit4] 2> 1865731 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 2
[junit4] 2> 1865733 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1865733 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/./collection1/data/index.20151215184131545 [CachedDir<<refCount=0;path=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/./collection1/data/index.20151215184131545;done=true>>]
[junit4] 2> 1865733 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/./collection1/data/index.20151215184131545
[junit4] 2> 1865733 WARN (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Replication attempt was not successful - trying a full index replication reloadCore=false
[junit4] 2> 1865735 INFO (qtp1300959840-12697) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
[junit4] 2> 1865735 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Master's generation: 3
[junit4] 2> 1865735 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Slave's generation: 2
[junit4] 2> 1865735 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Starting replication process
[junit4] 2> 1865743 WARN (qtp1300959840-12692) [ x:collection1] o.a.s.h.ReplicationHandler Could not read checksum from index file: _0_MockRandom_0.sd
[junit4] 2> java.lang.ArrayIndexOutOfBoundsException
[junit4] 2> 1865744 WARN (qtp1300959840-12692) [ x:collection1] o.a.s.h.ReplicationHandler Could not read checksum from index file: _1_MockRandom_0.sd
[junit4] 2> java.lang.ArrayIndexOutOfBoundsException
[junit4] 2> 1865744 INFO (qtp1300959840-12692) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&wt=javabin&version=2&command=filelist} status=0 QTime=1
[junit4] 2> 1865745 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Number of files in latest index in master: 20
[junit4] 2> 1865745 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/./collection1/data/index.20151215184131595
[junit4] 2> 1865745 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Starting download (fullCopy=true) to MockDirectoryWrapper(RAMDirectory@658b3481 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1c5308db)
[junit4] 2> 1865747 INFO (qtp1300959840-12691) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_0.si&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865750 INFO (qtp1300959840-12694) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_0_MockRandom_0.tix&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865753 INFO (qtp1300959840-12696) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_0_MockRandom_0.doc&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865757 INFO (qtp1300959840-12695) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_0.nvd&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865775 INFO (qtp1300959840-12698) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_0_MockRandom_0.tbk&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865778 INFO (qtp1300959840-12697) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_0_MockRandom_0.sd&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865781 INFO (qtp1300959840-12692) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_0.fdx&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865784 INFO (qtp1300959840-12691) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_0.fdt&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865787 INFO (qtp1300959840-12694) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_0.fnm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865789 INFO (qtp1300959840-12696) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_0.nvm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865793 INFO (qtp1300959840-12695) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1_MockRandom_0.doc&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865796 INFO (qtp1300959840-12698) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1_MockRandom_0.sd&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865799 INFO (qtp1300959840-12697) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.si&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865803 INFO (qtp1300959840-12692) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.nvd&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865805 INFO (qtp1300959840-12691) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.fdx&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865808 INFO (qtp1300959840-12694) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.fnm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865811 INFO (qtp1300959840-12696) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.nvm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865814 INFO (qtp1300959840-12695) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1_MockRandom_0.tfp&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865816 INFO (qtp1300959840-12698) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.fdt&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865819 INFO (qtp1300959840-12697) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=segments_3&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1865819 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Total time taken for download (fullCopy=true,bytesDownloaded=2991) : 0 secs (null bytes/sec) to MockDirectoryWrapper(RAMDirectory@658b3481 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1c5308db)
[junit4] 2> 1865820 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher New index installed. Updating index properties... index=index.20151215184131595
[junit4] 2> 1865820 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher removing old index directory MockDirectoryWrapper(RAMDirectory@3cf8626a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7385f567)
[junit4] 2> 1865820 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
[junit4] 2> 1865821 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/./collection1/data/index/ new=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/./collection1/data/index.20151215184131595
[junit4] 2> 1865821 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=37, maxMergeAtOnceExplicit=46, maxMergedSegmentMB=57.8359375, floorSegmentMB=0.7958984375, forceMergeDeletesPctAllowed=10.603727199166821, segmentsPerTier=43.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 1865821 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@658b3481 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1c5308db),segFN=segments_3,generation=3}
[junit4] 2> 1865821 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 3
[junit4] 2> 1865821 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1865822 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@7143a26e[collection1] main
[junit4] 2> 1865822 INFO (searcherExecutor-5266-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7143a26e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C1) Uninverting(_1(6.0.0):C1)))}
[junit4] 2> 1865823 INFO (qtp2125443004-12709) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={wait=true&masterUrl=http://127.0.0.1:49643/solr/collection1/replication&command=fetchindex} status=0 QTime=136
[junit4] 2> 1865823 INFO (qtp2125443004-12709) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/./collection1/data/index [CachedDir<<refCount=0;path=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/./collection1/data/index;done=true>>]
[junit4] 2> 1865823 INFO (qtp2125443004-12709) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_45F43F257D825341-001/solr-instance-002/./collection1/data/index
[junit4] 2> 1865825 INFO (qtp2125443004-12712) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=name:empty2&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=0
[junit4] 2> 1865825 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[45F43F257D825341]) [ ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 1 docs
[junit4] 2> 1865827 INFO (qtp1300959840-12692) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=0
[junit4] 2> 1865830 INFO (qtp1300959840-12691) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=0
[junit4] 2> 1865834 INFO (qtp1300959840-12694) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={slave=false&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=0
[junit4] 2> 1865835 INFO (qtp2125443004-12714) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=2
[junit4] 2> 1865836 INFO (qtp1300959840-12696) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=assertVersions&qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
[junit4] 2> 1865838 INFO (qtp2125443004-12716) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=assertVersions&qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
[junit4] 2> 1865841 INFO (qtp1300959840-12695) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[3]} 0 0
[junit4] 2> 1865843 INFO (qtp1300959840-12698) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1865845 INFO (qtp1300959840-12698) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=3
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@68dd2dcc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5bd9491),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@68dd2dcc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5bd9491),segFN=segments_3,generation=3}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@68dd2dcc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5bd9491),segFN=segments_4,generation=4}
[junit4] 2> 1865845 INFO (qtp1300959840-12698) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 4
[junit4] 2> 1865845 INFO (qtp1300959840-12698) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@37f7c654[collection1] realtime
[junit4] 2> 1865845 INFO (qtp1300959840-12698) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1865845 INFO (qtp1300959840-12698) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={openSearcher=false&commit=true&wt=javabin&version=2}{commit=} 0 2
[junit4] 2> 1865847 WARN (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix
[junit4] 2> 1865850 INFO (qtp1300959840-12697) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
[junit4] 2> 1865850 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Master's generation: 4
[junit4] 2> 1865850 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Slave's generation: 3
[junit4] 2> 1865850 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Starting replication process
[junit4] 2> 1865852 WARN (qtp1300959840-12697) [ x:collection1] o.a.s.h.ReplicationHandler Could not read checksum from index file: _0_MockRandom_0.sd
[junit4] 2> java.lang.ArrayIndexOutOfBoundsException
[junit4] 2> 1865852 WARN (qtp1300959840-12697) [ x:collection1] o.a.s.h.ReplicationHandler Could not read checksum from index file: _1_MockRandom_0.sd
[junit4] 2> java.lang.ArrayIndexOutOfBoundsException
[junit4] 2> 1865852 WARN (qtp1300959840-12697) [ x:collection1] o.a.s.h.ReplicationHandler Could not read checksum from index file: _2_MockRandom_0.sd
[junit4] 2> java.lang.ArrayIndexOutOfBoundsException
[junit4] 2> 1865853 INFO (qtp1300959840-12697) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&wt=javabin&version=2&command=filelist} status=0 QTime=1
[junit4] 2> 1865853 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Number of files in latest index in master: 30
[junit4] 2> 1865853 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-
[...truncated too long message...]
ing.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: Starting to interrupt leaked threads:
[junit4] 2> 1) Thread[id=14668, name=searcherExecutor-6412-thread-1, state=WAITING, group=TGRP-TestCoreDiscovery]
[junit4] 2> Dec 15, 2015 3:47:25 PM com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> SEVERE: There are still zombie threads that couldn't be terminated:
[junit4] 2> 1) Thread[id=14668, name=searcherExecutor-6412-thread-1, state=WAITING, group=TGRP-TestCoreDiscovery]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] 2> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene60): {}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=false,coord=yes): {}, locale=en_SG, timezone=America/Guadeloupe
[junit4] 2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_66 (64-bit)/cpus=3,threads=2,free=154661776,total=407138304
[junit4] 2> NOTE: All tests run in this JVM: [TestDefaultStatsCache, SegmentsInfoRequestHandlerTest, SuggestComponentTest, TestBlendedInfixSuggestions, RequestHandlersTest, CachingDirectoryFactoryTest, HighlighterConfigTest, DistributedQueueTest, BufferStoreTest, DistribDocExpirationUpdateProcessorTest, SpatialHeatmapFacetsTest, FileBasedSpellCheckerTest, TestFastWriter, SortByFunctionTest, SimpleMLTQParserTest, TestCollationField, TestNonDefinedSimilarityFactory, TestConfigSetProperties, TestCustomSort, OutputWriterTest, TestDistribDocBasedVersion, TestJoin, SearchHandlerTest, FullSolrCloudDistribCmdsTest, HighlighterMaxOffsetTest, SpellCheckCollatorTest, TestScoreJoinQPNoScore, TestSolrQueryResponse, TermVectorComponentDistributedTest, TermVectorComponentTest, TestRandomFaceting, TestRTimerTree, SpellCheckComponentTest, TestSolrQueryParser, TestFoldingMultitermQuery, TestLRUStatsCache, CopyFieldTest, TestJsonFacets, TestPerFieldSimilarityWithDefaultOverride, SolrInfoMBeanTest, FullHLLTest, StatsComponentTest, HdfsCollectionsAPIDistributedZkTest, TestFiltering, DirectSolrConnectionTest, SSLMigrationTest, TestUtils, TestReRankQParserPlugin, TestLMJelinekMercerSimilarityFactory, TestNRTOpen, CollectionsAPIDistributedZkTest, LeaderFailoverAfterPartitionTest, TestRawResponseWriter, TestReload, RequestLoggingTest, BinaryUpdateRequestHandlerTest, TestRestManager, DistributedIntervalFacetingTest, MultiTermTest, TestValueSourceCache, TestCrossCoreJoin, ResponseLogComponentTest, SolrIndexSplitterTest, TestConfigSetsAPI, CurrencyFieldOpenExchangeTest, RestartWhileUpdatingTest, TestSQLHandler, AtomicUpdatesTest, TestInfoStreamLogging, LeaderInitiatedRecoveryOnShardRestartTest, TestIndexingPerformance, RuleEngineTest, HdfsChaosMonkeyNothingIsSafeTest, TestSolrQueryParserDefaultOperatorResource, CollectionsAPIAsyncDistributedZkTest, TestMiniSolrCloudClusterBase, InfoHandlerTest, TestSolrCoreProperties, TestRebalanceLeaders, NotRequiredUniqueKeyTest, ZkStateReaderTest, TestQueryUtils, TestSimpleTrackingShardHandler, OverseerRolesTest, SolrCmdDistributorTest, TestSchemaResource, NoCacheHeaderTest, EchoParamsTest, DeleteShardTest, SolrCloudExampleTest, AsyncMigrateRouteKeyTest, TestChildDocTransformer, OverriddenZkACLAndCredentialsProvidersTest, TestDefaultSearchFieldResource, HdfsSyncSliceTest, OverseerTaskQueueTest, TestRTGBase, TestShardHandlerFactory, QueryParsingTest, BJQParserTest, HdfsUnloadDistributedZkTest, TestSystemIdResolver, BlockCacheTest, TestStressRecovery, CacheHeaderTest, CdcrReplicationDistributedZkTest, TestPHPSerializedResponseWriter, TestCharFilters, ShowFileRequestHandlerTest, TestClassNameShortening, TestRandomMergePolicy, TestAuthenticationFramework, TestRequestForwarding, TestManagedResource, TestConfigReload, HdfsLockFactoryTest, TestExceedMaxTermLength, SuggesterTest, PKIAuthenticationIntegrationTest, DistanceUnitsTest, SpatialRPTFieldTypeTest, DistributedExpandComponentTest, ShardSplitTest, SpellingQueryConverterTest, ParsingFieldUpdateProcessorsTest, TestReversedWildcardFilterFactory, RemoteQueryErrorTest, TestStressUserVersions, TestPKIAuthenticationPlugin, AnalysisErrorHandlingTest, TestExpandComponent, TestReqParamsAPI, TestMiniSolrCloudClusterSSL, DistanceFunctionTest, DistributedSuggestComponentTest, DataDrivenBlockJoinTest, DistributedMLTComponentTest, TestShortCircuitedRequests, TestFuzzyAnalyzedSuggestions, ShardRoutingCustomTest, BasicDistributedZkTest, ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test, UnloadDistributedZkTest, OpenCloseCoreStressTest, OverseerTest, LeaderElectionIntegrationTest, BasicZkTest, TestReplicationHandler, ClusterStateUpdateTest, ZkSolrClientTest, TestZkChroot, ZkCLITest, AutoCommitTest, TestDistributedGrouping, TestHashPartitioner, TestRangeQuery, TestCoreContainer, TestSolr4Spatial, TestGroupingSearch, QueryElevationComponentTest, BasicFunctionalityTest, DirectUpdateHandlerTest, TestIndexSearcher, TestCoreDiscovery]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestCoreDiscovery -Dtests.seed=45F43F257D825341 -Dtests.slow=true -Dtests.locale=en_SG -Dtests.timezone=America/Guadeloupe -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J1 | TestCoreDiscovery (suite) <<<
[junit4] > Throwable #1: java.lang.AssertionError: ERROR: SolrIndexSearcher opens=27 closes=26
[junit4] > at __randomizedtesting.SeedInfo.seed([45F43F257D825341]:0)
[junit4] > at org.apache.solr.SolrTestCaseJ4.endTrackingSearchers(SolrTestCaseJ4.java:453)
[junit4] > at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:225)
[junit4] > at java.lang.Thread.run(Thread.java:745)Throwable #2: com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.core.TestCoreDiscovery:
[junit4] > 1) Thread[id=14668, name=searcherExecutor-6412-thread-1, state=WAITING, group=TGRP-TestCoreDiscovery]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] > at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > at __randomizedtesting.SeedInfo.seed([45F43F257D825341]:0)Throwable #3: com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
[junit4] > 1) Thread[id=14668, name=searcherExecutor-6412-thread-1, state=WAITING, group=TGRP-TestCoreDiscovery]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] > at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > at __randomizedtesting.SeedInfo.seed([45F43F257D825341]:0)
[junit4] Completed [404/566 (2!)] on J1 in 145.86s, 12 tests, 1 failure, 2 errors <<< FAILURES!
[...truncated 502 lines...]
BUILD FAILED
/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/build.xml:784: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/build.xml:728: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/build.xml:59: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build.xml:233: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/common-build.xml:516: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/lucene/common-build.xml:1436: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/lucene/common-build.xml:991: There were test failures: 566 suites (8 ignored), 2253 tests, 3 suite-level errors, 1 failure, 526 ignored (65 assumptions) [seed: 45F43F257D825341]
Total time: 60 minutes 2 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
[JENKINS] Lucene-Solr-trunk-Solaris (64bit/jdk1.8.0) - Build # 260
- Still Failing!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Solaris/260/
Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseSerialGC
1 tests failed.
FAILED: org.apache.solr.handler.component.SpellCheckComponentTest.test
Error Message:
List size mismatch @ spellcheck/suggestions
Stack Trace:
java.lang.RuntimeException: List size mismatch @ spellcheck/suggestions
at __randomizedtesting.SeedInfo.seed([F21F170FB37E96B2:7A4B28D51D82FB4A]:0)
at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:837)
at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:784)
at org.apache.solr.handler.component.SpellCheckComponentTest.test(SpellCheckComponentTest.java:96)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:497)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
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:54)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 10096 lines...]
[junit4] Suite: org.apache.solr.handler.component.SpellCheckComponentTest
[junit4] 2> Creating dataDir: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.component.SpellCheckComponentTest_F21F170FB37E96B2-001/init-core-data-001
[junit4] 2> 1600525 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
[junit4] 2> 1600525 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 1600525 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/core/src/test-files/solr/collection1'
[junit4] 2> 1600525 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1600525 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/core/src/test-files/solr
[junit4] 2> 1600526 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 1600526 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 1600546 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 1600549 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 1600555 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig-spellcheckcomponent.xml
[junit4] 2> 1600559 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 1600631 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1600635 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.s.IndexSchema default search field in schema is text
[junit4] 2> 1600636 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 1600639 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 1600641 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 1600642 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1600642 WARN (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE
[junit4] 2> 1600642 WARN (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING
[junit4] 2> 1600642 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1600642 WARN (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE
[junit4] 2> 1600642 WARN (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING
[junit4] 2> 1600642 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1600643 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/core/src/test-files/solr
[junit4] 2> 1600643 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/core/src/test-files/solr'
[junit4] 2> 1600643 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1600643 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/core/src/test-files/solr
[junit4] 2> 1600643 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.c.CoreContainer New CoreContainer 1826888957
[junit4] 2> 1600643 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/core/src/test-files/solr]
[junit4] 2> 1600643 WARN (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.c.CoreContainer Couldn't add files from /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/core/src/test-files/solr/lib to classpath: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/core/src/test-files/solr/lib
[junit4] 2> 1600643 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
[junit4] 2> 1600647 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true
[junit4] 2> 1600648 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1600648 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1600648 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 1600648 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 1600649 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig-spellcheckcomponent.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, collection=collection1, dataDir=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.component.SpellCheckComponentTest_F21F170FB37E96B2-001/init-core-data-001, shard=shard1}
[junit4] 2> 1600649 INFO (coreLoadExecutor-5665-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/core/src/test-files/solr/collection1'
[junit4] 2> 1600649 INFO (coreLoadExecutor-5665-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1600649 INFO (coreLoadExecutor-5665-thread-1) [ ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/core/src/test-files/solr
[junit4] 2> 1600650 INFO (coreLoadExecutor-5665-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 1600650 INFO (coreLoadExecutor-5665-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 1600667 INFO (coreLoadExecutor-5665-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 1600670 INFO (coreLoadExecutor-5665-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 1600676 INFO (coreLoadExecutor-5665-thread-1) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig-spellcheckcomponent.xml
[junit4] 2> 1600680 INFO (coreLoadExecutor-5665-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1600749 INFO (coreLoadExecutor-5665-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1600753 INFO (coreLoadExecutor-5665-thread-1) [ ] o.a.s.s.IndexSchema default search field in schema is text
[junit4] 2> 1600754 INFO (coreLoadExecutor-5665-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 1600756 INFO (coreLoadExecutor-5665-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 1600757 INFO (coreLoadExecutor-5665-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 1600759 INFO (coreLoadExecutor-5665-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1600759 WARN (coreLoadExecutor-5665-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE
[junit4] 2> 1600759 WARN (coreLoadExecutor-5665-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING
[junit4] 2> 1600759 INFO (coreLoadExecutor-5665-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1600759 WARN (coreLoadExecutor-5665-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE
[junit4] 2> 1600759 WARN (coreLoadExecutor-5665-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING
[junit4] 2> 1600761 INFO (coreLoadExecutor-5665-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/core/src/test-files/solr/collection1'
[junit4] 2> 1600761 INFO (coreLoadExecutor-5665-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/core/src/test-files/solr/collection1
[junit4] 2> 1600761 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1600761 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/core/src/test-files/solr/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.component.SpellCheckComponentTest_F21F170FB37E96B2-001/init-core-data-001/]
[junit4] 2> 1600761 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
[junit4] 2> 1600762 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.component.SpellCheckComponentTest_F21F170FB37E96B2-001/init-core-data-001
[junit4] 2> 1600762 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.component.SpellCheckComponentTest_F21F170FB37E96B2-001/init-core-data-001/index/
[junit4] 2> 1600762 WARN (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.component.SpellCheckComponentTest_F21F170FB37E96B2-001/init-core-data-001/index' doesn't exist. Creating new index...
[junit4] 2> 1600762 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.component.SpellCheckComponentTest_F21F170FB37E96B2-001/init-core-data-001/index
[junit4] 2> 1600762 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=742665275, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1600763 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@675c5cd0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@185c3c12; maxCacheMB=0.4423828125 maxMergeSizeMB=0.3994140625)),segFN=segments_1,generation=1}
[junit4] 2> 1600763 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 1600763 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.component.SpellCheckComponentTest_F21F170FB37E96B2-001/init-core-data-001/
[junit4] 2> 1600765 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1600766 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1600767 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1600767 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1600768 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1600769 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,spellCheckCompRH,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,spellCheckCompRH1,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,/update/json,/admin/threads,/admin/ping,/update,/admin/file
[junit4] 2> 1600770 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 1600770 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1600770 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1600770 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=49, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.2110504146460797]
[junit4] 2> 1600771 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@675c5cd0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@185c3c12; maxCacheMB=0.4423828125 maxMergeSizeMB=0.3994140625)),segFN=segments_1,generation=1}
[junit4] 2> 1600771 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 1600771 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@5294582b[collection1] main
[junit4] 2> 1600771 WARN (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 1600771 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
[junit4] 2> 1600771 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 1600771 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 1600771 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1600826 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: default
[junit4] 2> 1600857 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: default_teststop
[junit4] 2> 1600858 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=solr.DirectSolrSpellChecker,minQueryLength=3,maxQueryFrequency=100.0,field=teststop}
[junit4] 2> 1600858 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct_lowerfilt,classname=solr.DirectSolrSpellChecker,minQueryLength=3,maxQueryFrequency=100.0,field=lowerfilt}
[junit4] 2> 1600891 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: threshold
[junit4] 2> 1600891 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=threshold_direct,classname=solr.DirectSolrSpellChecker,field=lowerfilt,spellcheckIndexDir=spellcheckerThreshold,buildOnCommit=true,thresholdTokenFrequency=0.29}
[junit4] 2> 1600891 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: threshold_direct
[junit4] 2> 1600924 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: multipleFields
[junit4] 2> 1601019 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: freq
[junit4] 2> 1601061 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: fqcn
[junit4] 2> 1601061 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1601061 INFO (coreLoadExecutor-5665-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 1601061 INFO (searcherExecutor-5666-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1601062 INFO (searcherExecutor-5666-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default_teststop
[junit4] 2> 1601063 INFO (searcherExecutor-5666-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1601063 INFO (searcherExecutor-5666-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct_lowerfilt
[junit4] 2> 1601063 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 1601063 INFO (searcherExecutor-5666-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1601063 INFO (searcherExecutor-5666-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold
[junit4] 2> 1601064 INFO (searcherExecutor-5666-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold_direct
[junit4] 2> 1601064 INFO (searcherExecutor-5666-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 1601066 INFO (TEST-SpellCheckComponentTest.test-seed#[F21F170FB37E96B2]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 1601066 INFO (TEST-SpellCheckComponentTest.test-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 0
[junit4] 2> 1601067 INFO (TEST-SpellCheckComponentTest.test-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1601068 INFO (TEST-SpellCheckComponentTest.test-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1601068 INFO (TEST-SpellCheckComponentTest.test-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1601068 INFO (TEST-SpellCheckComponentTest.test-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 1601068 INFO (TEST-SpellCheckComponentTest.test-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 1601069 INFO (TEST-SpellCheckComponentTest.test-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0
[junit4] 2> 1601069 INFO (TEST-SpellCheckComponentTest.test-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 0
[junit4] 2> 1601069 INFO (TEST-SpellCheckComponentTest.test-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0
[junit4] 2> 1601069 INFO (TEST-SpellCheckComponentTest.test-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 0
[junit4] 2> 1601069 INFO (TEST-SpellCheckComponentTest.test-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1601072 INFO (TEST-SpellCheckComponentTest.test-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@675c5cd0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@185c3c12; maxCacheMB=0.4423828125 maxMergeSizeMB=0.3994140625)),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@675c5cd0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@185c3c12; maxCacheMB=0.4423828125 maxMergeSizeMB=0.3994140625)),segFN=segments_2,generation=2}
[junit4] 2> 1601072 INFO (TEST-SpellCheckComponentTest.test-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 2
[junit4] 2> 1601072 WARN (TEST-SpellCheckComponentTest.test-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.SolrCore [collection1] PERFORMANCE WARNING: Overlapping onDeckSearchers=2
[junit4] 2> 1601073 INFO (TEST-SpellCheckComponentTest.test-seed#[F21F170FB37E96B2]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@6c8c853f[collection1] main
[junit4] 2> 1601073 INFO (TEST-SpellCheckComponentTest.test-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1601077 INFO (searcherExecutor-5666-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1601078 INFO (searcherExecutor-5666-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1601078 INFO (searcherExecutor-5666-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1601078 INFO (searcherExecutor-5666-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1601079 INFO (searcherExecutor-5666-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1601079 INFO (searcherExecutor-5666-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5294582b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1601079 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1601079 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default_teststop
[junit4] 2> 1601079 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1601079 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct_lowerfilt
[junit4] 2> 1601079 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1601080 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold
[junit4] 2> 1601080 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold_direct
[junit4] 2> 1601080 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 1601080 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1601080 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1601081 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1601081 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1601082 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1601082 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6c8c853f[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C10)))}
[junit4] 2> 1601082 INFO (TEST-SpellCheckComponentTest.test-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 12
[junit4] 2> 1601083 INFO (TEST-SpellCheckComponentTest.test-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=documemt&qt=spellCheckCompRH&spellcheck=true&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 1601083 ERROR (TEST-SpellCheckComponentTest.test-seed#[F21F170FB37E96B2]) [ ] o.a.s.SolrTestCaseJ4 query failed JSON validation. error=List size mismatch @ spellcheck/suggestions
[junit4] 2> expected =/spellcheck=={'suggestions':['documemt',{'numFound':1,'startOffset':0,'endOffset':8,'suggestion':['document']}]}
[junit4] 2> response = {
[junit4] 2> "responseHeader":{
[junit4] 2> "status":0,
[junit4] 2> "QTime":0},
[junit4] 2> "response":{"numFound":0,"start":0,"docs":[]
[junit4] 2> },
[junit4] 2> "spellcheck":{
[junit4] 2> "suggestions":[]}}
[junit4] 2>
[junit4] 2> request = q=documemt&qt=spellCheckCompRH&spellcheck=true&wt=xml
[junit4] 2> 1601084 INFO (TEST-SpellCheckComponentTest.test-seed#[F21F170FB37E96B2]) [ ] o.a.s.SolrTestCaseJ4 ###Ending test
[junit4] 2> 1601084 INFO (TEST-SpellCheckComponentTest.test-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1601084 INFO (TEST-SpellCheckComponentTest.test-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0
[junit4] 2> 1601084 INFO (TEST-SpellCheckComponentTest.test-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1601084 INFO (TEST-SpellCheckComponentTest.test-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@675c5cd0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@185c3c12; maxCacheMB=0.4423828125 maxMergeSizeMB=0.3994140625)),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@675c5cd0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@185c3c12; maxCacheMB=0.4423828125 maxMergeSizeMB=0.3994140625)),segFN=segments_3,generation=3}
[junit4] 2> 1601084 INFO (TEST-SpellCheckComponentTest.test-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 3
[junit4] 2> 1601085 INFO (TEST-SpellCheckComponentTest.test-seed#[F21F170FB37E96B2]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@272b07a4[collection1] main
[junit4] 2> 1601085 INFO (TEST-SpellCheckComponentTest.test-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1601085 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1601119 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1601155 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1601210 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1601210 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1601266 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1601290 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1601320 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@272b07a4[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1601321 INFO (TEST-SpellCheckComponentTest.test-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 236
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SpellCheckComponentTest -Dtests.method=test -Dtests.seed=F21F170FB37E96B2 -Dtests.slow=true -Dtests.locale=sl -Dtests.timezone=Europe/Belfast -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.26s J1 | SpellCheckComponentTest.test <<<
[junit4] > Throwable #1: java.lang.RuntimeException: List size mismatch @ spellcheck/suggestions
[junit4] > at __randomizedtesting.SeedInfo.seed([F21F170FB37E96B2:7A4B28D51D82FB4A]:0)
[junit4] > at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:837)
[junit4] > at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:784)
[junit4] > at org.apache.solr.handler.component.SpellCheckComponentTest.test(SpellCheckComponentTest.java:96)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 1601325 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[F21F170FB37E96B2]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testRelativeIndexDirLocation
[junit4] 2> 1601325 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 0
[junit4] 2> 1601326 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1601326 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1601326 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1601327 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 1601327 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 1601327 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0
[junit4] 2> 1601327 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 0
[junit4] 2> 1601327 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0
[junit4] 2> 1601328 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 0
[junit4] 2> 1601328 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1601329 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@675c5cd0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@185c3c12; maxCacheMB=0.4423828125 maxMergeSizeMB=0.3994140625)),segFN=segments_3,generation=3}
[junit4] 2> commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@675c5cd0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@185c3c12; maxCacheMB=0.4423828125 maxMergeSizeMB=0.3994140625)),segFN=segments_4,generation=4}
[junit4] 2> 1601329 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 4
[junit4] 2> 1601330 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[F21F170FB37E96B2]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@5a733aac[collection1] main
[junit4] 2> 1601330 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1601330 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1601455 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1601489 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1601531 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1601531 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1601605 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1601680 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1601721 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5a733aac[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.0.0):C10)))}
[junit4] 2> 1601721 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 393
[junit4] 2> 1601722 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[F21F170FB37E96B2]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testRelativeIndexDirLocation
[junit4] 2> 1601722 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1601722 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0
[junit4] 2> 1601722 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1601722 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@675c5cd0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@185c3c12; maxCacheMB=0.4423828125 maxMergeSizeMB=0.3994140625)),segFN=segments_4,generation=4}
[junit4] 2> commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@675c5cd0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@185c3c12; maxCacheMB=0.4423828125 maxMergeSizeMB=0.3994140625)),segFN=segments_5,generation=5}
[junit4] 2> 1601723 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 5
[junit4] 2> 1601723 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[F21F170FB37E96B2]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@c45e73a[collection1] main
[junit4] 2> 1601723 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1601723 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1601734 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1601757 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1601778 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1601778 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1601798 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1601812 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1601837 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@c45e73a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1601838 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 115
[junit4] 2> 1601844 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testRebuildOnCommit
[junit4] 2> 1601845 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 0
[junit4] 2> 1601845 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1601845 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1601845 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1601846 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 1601846 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 1601846 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0
[junit4] 2> 1601846 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 0
[junit4] 2> 1601847 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0
[junit4] 2> 1601847 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 0
[junit4] 2> 1601847 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1601848 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@675c5cd0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@185c3c12; maxCacheMB=0.4423828125 maxMergeSizeMB=0.3994140625)),segFN=segments_5,generation=5}
[junit4] 2> commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@675c5cd0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@185c3c12; maxCacheMB=0.4423828125 maxMergeSizeMB=0.3994140625)),segFN=segments_6,generation=6}
[junit4] 2> 1601848 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 6
[junit4] 2> 1601849 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@21741b3d[collection1] main
[junit4] 2> 1601849 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1601849 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1601902 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1601914 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1601953 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1601953 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1602008 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1602079 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1602159 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@21741b3d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(6.0.0):C10)))}
[junit4] 2> 1602160 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 312
[junit4] 2> 1602161 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=lowerfilt:lucenejavt&qt=spellCheckCompRH&spellcheck=true&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 1602161 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[11231]} 0 0
[junit4] 2> 1602161 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1602163 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@675c5cd0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@185c3c12; maxCacheMB=0.4423828125 maxMergeSizeMB=0.3994140625)),segFN=segments_6,generation=6}
[junit4] 2> commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@675c5cd0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@185c3c12; maxCacheMB=0.4423828125 maxMergeSizeMB=0.3994140625)),segFN=segments_7,generation=7}
[junit4] 2> 1602163 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 7
[junit4] 2> 1602163 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@1c8fd136[collection1] main
[junit4] 2> 1602163 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1602164 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1602217 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1602240 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1602279 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1602279 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1602353 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1602415 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1602503 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1c8fd136[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(6.0.0):C10) Uninverting(_3(6.0.0):C1)))}
[junit4] 2> 1602504 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 342
[junit4] 2> 1602504 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=lowerfilt:lucenejavt&qt=spellCheckCompRH&spellcheck=true&wt=xml} hits=0 status=0 QTime=344
[junit4] 2> 1602505 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testRebuildOnCommit
[junit4] 2> 1602505 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1602505 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0
[junit4] 2> 1602505 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1602505 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@675c5cd0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@185c3c12; maxCacheMB=0.4423828125 maxMergeSizeMB=0.3994140625)),segFN=segments_7,generation=7}
[junit4] 2> commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@675c5cd0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@185c3c12; maxCacheMB=0.4423828125 maxMergeSizeMB=0.3994140625)),segFN=segments_8,generation=8}
[junit4] 2> 1602505 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 8
[junit4] 2> 1602506 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@3edc641d[collection1] main
[junit4] 2> 1602506 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1602506 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1602528 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1602553 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1602567 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1602567 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1602584 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1602599 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1602620 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3edc641d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1602621 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 115
[junit4] 2> 1602628 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[F21F170FB37E96B2]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testNumericQuery
[junit4] 2> 1602629 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 0
[junit4] 2> 1602629 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1602629 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1602630 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1602630 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 1602630 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 1602630 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0
[junit4] 2> 1602630 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 0
[junit4] 2> 1602631 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0
[junit4] 2> 1602631 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 0
[junit4] 2> 1602631 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1602632 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@675c5cd0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@185c3c12; maxCacheMB=0.4423828125 maxMergeSizeMB=0.3994140625)),segFN=segments_8,generation=8}
[junit4] 2> commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@675c5cd0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@185c3c12; maxCacheMB=0.4423828125 maxMergeSizeMB=0.3994140625)),segFN=segments_9,generation=9}
[junit4] 2> 1602632 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 9
[junit4] 2> 1602633 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[F21F170FB37E96B2]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@227a40e[collection1] main
[junit4] 2> 1602633 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1602633 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1602682 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1602695 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1602766 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1602766 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1602809 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1602890 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1602974 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@227a40e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(6.0.0):C10)))}
[junit4] 2> 1602974 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 343
[junit4] 2> 1602975 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=12346&qt=spellCheckCompRH&spellcheck=true&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 1602975 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[F21F170FB37E96B2]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testNumericQuery
[junit4] 2> 1602975 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1602975 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0
[junit4] 2> 1602975 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1602976 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@675c5cd0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@185c3c12; maxCacheMB=0.4423828125 maxMergeSizeMB=0.3994140625)),segFN=segments_9,generation=9}
[junit4] 2> commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@675c5cd0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@185c3c12; maxCacheMB=0.4423828125 maxMergeSizeMB=0.3994140625)),segFN=segments_a,generation=10}
[junit4] 2> 1602976 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 10
[junit4] 2> 1602976 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[F21F170FB37E96B2]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@762ba205[collection1] main
[junit4] 2> 1602976 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1602976 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1602995 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1603023 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1603043 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1603043 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1603064 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1603099 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1603141 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@762ba205[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1603141 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 166
[junit4] 2> 1603144 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[F21F170FB37E96B2]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testPerDictionary
[junit4] 2> 1603144 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 0
[junit4] 2> 1603145 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1603145 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1603145 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1603145 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 1603146 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 1603146 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0
[junit4] 2> 1603146 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 0
[junit4] 2> 1603146 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0
[junit4] 2> 1603146 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 0
[junit4] 2> 1603147 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1603148 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@675c5cd0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@185c3c12; maxCacheMB=0.4423828125 maxMergeSizeMB=0.3994140625)),segFN=segments_a,generation=10}
[junit4] 2> commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@675c5cd0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@185c3c12; maxCacheMB=0.4423828125 maxMergeSizeMB=0.3994140625)),segFN=segments_b,generation=11}
[junit4] 2> 1603148 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 11
[junit4] 2> 1603149 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[F21F170FB37E96B2]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@16a04e46[collection1] main
[junit4] 2> 1603149 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1603153 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1603213 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1603233 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1603310 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1603311 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1603381 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1603441 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1603533 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@16a04e46[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(6.0.0):C10)))}
[junit4] 2> 1603534 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 387
[junit4] 2> 1603535 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=documemt&qt=spellCheckCompRH&spellcheck.dictionary=perDict&json.nl=map&spellcheck..perDict.foo=bar&spellcheck=true&spellcheck..perDict.bar=foo&wt=xml&spellcheck.build=true} hits=0 status=0 QTime=0
[junit4] 2> 1603535 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[F21F170FB37E96B2]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testPerDictionary
[junit4] 2> 1603535 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1603535 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0
[junit4] 2> 1603535 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1603535 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@675c5cd0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@185c3c12; maxCacheMB=0.4423828125 maxMergeSizeMB=0.3994140625)),segFN=segments_b,generation=11}
[junit4] 2> commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@675c5cd0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@185c3c12; maxCacheMB=0.4423828125 maxMergeSizeMB=0.3994140625)),segFN=segments_c,generation=12}
[junit4] 2> 1603535 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 12
[junit4] 2> 1603536 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[F21F170FB37E96B2]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@2f21aa75[collection1] main
[junit4] 2> 1603536 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1603536 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1603550 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1603560 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1603570 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1603570 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1603593 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1603604 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1603622 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2f21aa75[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1603622 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 86
[junit4] 2> 1603624 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testReloadOnStart
[junit4] 2> 1603625 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 0
[junit4] 2> 1603625 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1603625 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1603625 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1603626 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 1603626 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 1603626 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0
[junit4] 2> 1603626 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 0
[junit4] 2> 1603626 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0
[junit4] 2> 1603627 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 0
[junit4] 2> 1603627 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1603628 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@675c5cd0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@185c3c12; maxCacheMB=0.4423828125 maxMergeSizeMB=0.3994140625)),segFN=segments_c,generation=12}
[junit4] 2> commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@675c5cd0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@185c3c12; maxCacheMB=0.4423828125 maxMergeSizeMB=0.3994140625)),segFN=segments_d,generation=13}
[junit4] 2> 1603629 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 13
[junit4] 2> 1603629 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@75c002d[collection1] main
[junit4] 2> 1603629 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1603631 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1603736 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1603768 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1603820 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1603820 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1603863 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1603925 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1603984 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@75c002d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_6(6.0.0):C10)))}
[junit4] 2> 1603984 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 357
[junit4] 2> 1603985 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 0
[junit4] 2> 1603985 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1603987 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@675c5cd0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@185c3c12; maxCacheMB=0.4423828125 maxMergeSizeMB=0.3994140625)),segFN=segments_d,generation=13}
[junit4] 2> commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@675c5cd0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@185c3c12; maxCacheMB=0.4423828125 maxMergeSizeMB=0.3994140625)),segFN=segments_e,generation=14}
[junit4] 2> 1603987 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 14
[junit4] 2> 1603987 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@7124418e[collection1] main
[junit4] 2> 1603987 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1603987 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1604062 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1604082 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1604119 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1604119 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1604166 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1604223 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1604290 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7124418e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_6(6.0.0):C10/1:delGen=1) Uninverting(_7(6.0.0):C1)))}
[junit4] 2> 1604290 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 305
[junit4] 2> 1604346 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&spellcheck.q=ttle&qt=spellCheckCompRH&spellcheck.dictionary=default&spellcheck=true&wt=xml&spellcheck.build=true} hits=10 status=0 QTime=55
[junit4] 2> 1604348 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1604354 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testReloadOnStart
[junit4] 2> 1604354 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1604354 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0
[junit4] 2> 1604354 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1604354 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@675c5cd0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@185c3c12; maxCacheMB=0.4423828125 maxMergeSizeMB=0.3994140625)),segFN=segments_e,generation=14}
[junit4] 2> commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@675c5cd0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@185c3c12; maxCacheMB=0.4423828125 maxMergeSizeMB=0.3994140625)),segFN=segments_f,generation=15}
[junit4] 2> 1604354 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 15
[junit4] 2> 1604355 INFO (TEST-SpellCheckComponentTest.testReloadOnStart-seed#[F21F170FB37E96B2]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@342f6cca[collection1] main
[junit4] 2> 1604
[...truncated too long message...]
or-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1606890 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1606911 INFO (searcherExecutor-5666-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1542c2b1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1606911 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[F21F170FB37E96B2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 95
[junit4] 2> 1606911 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 1606911 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1826888957
[junit4] 2> 1606912 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@4f25d7ae
[junit4] 2> 1606912 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ x:collection1] o.a.s.u.DirectUpdateHandler2 closing DirectUpdateHandler2{commits=22,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=102,cumulative_deletesById=0,cumulative_deletesByQuery=10,cumulative_errors=0}
[junit4] 2> 1606912 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 1606912 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 1606912 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
[junit4] 2> 1606912 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
[junit4] 2> 1606912 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 1606912 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.component.SpellCheckComponentTest_F21F170FB37E96B2-001/init-core-data-001/index [CachedDir<<refCount=0;path=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.component.SpellCheckComponentTest_F21F170FB37E96B2-001/init-core-data-001/index;done=false>>]
[junit4] 2> 1606912 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.component.SpellCheckComponentTest_F21F170FB37E96B2-001/init-core-data-001/index
[junit4] 2> 1606912 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.component.SpellCheckComponentTest_F21F170FB37E96B2-001/init-core-data-001 [CachedDir<<refCount=0;path=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.component.SpellCheckComponentTest_F21F170FB37E96B2-001/init-core-data-001;done=false>>]
[junit4] 2> 1606912 INFO (SUITE-SpellCheckComponentTest-seed#[F21F170FB37E96B2]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.component.SpellCheckComponentTest_F21F170FB37E96B2-001/init-core-data-001
[junit4] 2> NOTE: leaving temporary files on disk at: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.handler.component.SpellCheckComponentTest_F21F170FB37E96B2-001
[junit4] 2> NOTE: test params are: codec=CheapBastard, sim=ClassicSimilarity, locale=sl, timezone=Europe/Belfast
[junit4] 2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_66 (64-bit)/cpus=3,threads=1,free=133883472,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [TestConfigReload, ShardRoutingCustomTest, TestSolr4Spatial2, TestBlendedInfixSuggestions, TestReloadDeadlock, MultiTermTest, TestFilteredDocIdSet, IndexSchemaRuntimeFieldTest, VersionInfoTest, TestUtils, ConvertedLegacyTest, TestCloudManagedSchema, DateMathParserTest, SpellPossibilityIteratorTest, TestManagedSchemaFieldResource, UniqFieldsUpdateProcessorFactoryTest, TestFoldingMultitermQuery, LeaderInitiatedRecoveryOnShardRestartTest, ZkNodePropsTest, TestFastOutputStream, TermVectorComponentDistributedTest, CoreAdminRequestStatusTest, NoCacheHeaderTest, HdfsBasicDistributedZk2Test, TestSha256AuthenticationProvider, TestSimpleTrackingShardHandler, OverseerRolesTest, TestConfigSetsAPI, TestQuerySenderListener, TestCloudPivotFacet, TestAddFieldRealTimeGet, FileUtilsTest, BitVectorTest, DistributedFacetPivotSmallTest, TestFuzzyAnalyzedSuggestions, SpellingQueryConverterTest, ConfigSetsAPITest, TestIndexSearcher, BufferStoreTest, TestDistributedMissingSort, TestSolrIndexConfig, DocValuesMissingTest, TestOrdValues, TestRTimerTree, DistributedQueryComponentCustomSortTest, CurrencyFieldOpenExchangeTest, TestDynamicFieldResource, TestReversedWildcardFilterFactory, NotRequiredUniqueKeyTest, TestSchemaResource, DistribDocExpirationUpdateProcessorTest, SolrCmdDistributorTest, CdcrReplicationDistributedZkTest, ChangedSchemaMergeTest, FieldAnalysisRequestHandlerTest, TestOmitPositions, ShardSplitTest, TestSolrQueryResponse, QueryParsingTest, HdfsChaosMonkeyNothingIsSafeTest, CollectionsAPIAsyncDistributedZkTest, TestManagedSchema, TestCSVResponseWriter, ResponseLogComponentTest, TestRealTimeGet, BJQParserTest, TestRecovery, TestShardHandlerFactory, TestReqParamsAPI, TestInitQParser, HighlighterMaxOffsetTest, DirectSolrConnectionTest, TestReload, SimpleMLTQParserTest, TestAtomicUpdateErrorCases, TestRestManager, TestAuthenticationFramework, TestScoreJoinQPNoScore, TestSolrConfigHandlerConcurrent, BlockCacheTest, TestConfigSetProperties, SegmentsInfoRequestHandlerTest, DistributedSuggestComponentTest, TestDistributedGrouping, TestBM25SimilarityFactory, TestRebalanceLeaders, CollectionStateFormat2Test, TestQueryUtils, TestCollationField, ZkStateReaderTest, TestStressRecovery, DateFieldTest, TestQueryTypes, DeleteLastCustomShardedReplicaTest, DistributedQueueTest, WordBreakSolrSpellCheckerTest, TestRequestForwarding, SolrInfoMBeanTest, LeaderElectionIntegrationTest, StatsComponentTest, TestSolrQueryParserDefaultOperatorResource, ConjunctionSolrSpellCheckerTest, TestDefaultStatsCache, TestFieldTypeResource, AtomicUpdatesTest, TestManagedResource, TestPKIAuthenticationPlugin, TestConfigOverlay, RankQueryTest, TestSolr4Spatial, TestMissingGroups, TestCustomSort, TestRandomCollapseQParserPlugin, TestFiltering, BasicFunctionalityTest, TestTrie, BinaryUpdateRequestHandlerTest, SolrCoreCheckLockOnStartupTest, SolrCloudExampleTest, TestFreeTextSuggestions, CursorMarkTest, TestNamedUpdateProcessors, TestSchemaVersionResource, TestPHPSerializedResponseWriter, AssignTest, TestClassNameShortening, BigEndianAscendingWordDeserializerTest, DistributedFacetPivotLongTailTest, ZkSolrClientTest, TestBinaryField, BadIndexSchemaTest, RestartWhileUpdatingTest, TestCloudSchemaless, TestReRankQParserPlugin, TestMiniSolrCloudClusterBase, SSLMigrationTest, DistanceFunctionTest, SearchHandlerTest, ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test, CollectionsAPIDistributedZkTest, OpenCloseCoreStressTest, OverseerTest, BasicZkTest, FullSolrCloudDistribCmdsTest, ClusterStateUpdateTest, TestRandomFaceting, TestZkChroot, TestRandomDVFaceting, AutoCommitTest, TestHashPartitioner, DistributedSpellCheckComponentTest, HardAutoCommitTest, TestRangeQuery, TestCoreContainer, SpellCheckComponentTest]
[junit4] Completed [307/566 (1!)] on J1 in 6.41s, 10 tests, 1 error <<< FAILURES!
[...truncated 842 lines...]
BUILD FAILED
/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/build.xml:784: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/build.xml:728: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/build.xml:59: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build.xml:233: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/common-build.xml:516: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/lucene/common-build.xml:1436: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/lucene/common-build.xml:991: There were test failures: 566 suites (8 ignored), 2247 tests, 1 error, 84 ignored (69 assumptions) [seed: F21F170FB37E96B2]
Total time: 68 minutes 12 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any