Build: http://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/17206/ Java: 32bit/jdk-9-ea+125 -server -XX:+UseG1GC
3 tests failed. FAILED: org.apache.solr.cloud.ForceLeaderTest.testReplicasInLIRNoLeader Error Message: No live SolrServers available to handle this request:[http://127.0.0.1:37305/forceleader_test_collection_shard1_replica2] Stack Trace: org.apache.solr.client.solrj.impl.CloudSolrClient$RouteException: No live SolrServers available to handle this request:[http://127.0.0.1:37305/forceleader_test_collection_shard1_replica2] at __randomizedtesting.SeedInfo.seed([FD60286B08398AC3:1BF71CAB31BB73A2]:0) at org.apache.solr.client.solrj.impl.CloudSolrClient.directUpdate(CloudSolrClient.java:739) at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1151) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:1040) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:976) at org.apache.solr.cloud.AbstractFullDistribZkTestBase.sendDocsWithRetry(AbstractFullDistribZkTestBase.java:753) at org.apache.solr.cloud.AbstractFullDistribZkTestBase.sendDocsWithRetry(AbstractFullDistribZkTestBase.java:741) at org.apache.solr.cloud.ForceLeaderTest.sendDoc(ForceLeaderTest.java:424) at org.apache.solr.cloud.ForceLeaderTest.testReplicasInLIRNoLeader(ForceLeaderTest.java:131) at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method) at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62) at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:533) 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.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:985) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java: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:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at java.lang.Thread.run(java.base@9-ea/Thread.java:843) Caused by: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:37305/forceleader_test_collection_shard1_replica2] at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:393) at org.apache.solr.client.solrj.impl.CloudSolrClient.lambda$directUpdate$0(CloudSolrClient.java:714) at java.util.concurrent.FutureTask.run(java.base@9-ea/FutureTask.java:266) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229) at java.util.concurrent.ThreadPoolExecutor.runWorker(java.base@9-ea/ThreadPoolExecutor.java:1158) at java.util.concurrent.ThreadPoolExecutor$Worker.run(java.base@9-ea/ThreadPoolExecutor.java:632) ... 1 more Caused by: org.apache.solr.client.solrj.SolrServerException: Server refused connection at: http://127.0.0.1:37305/forceleader_test_collection_shard1_replica2 at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:613) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:259) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:413) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:382) ... 6 more Caused by: org.apache.http.conn.HttpHostConnectException: Connect to 127.0.0.1:37305 [/127.0.0.1] failed: Connection refused at org.apache.http.impl.conn.DefaultHttpClientConnectionOperator.connect(DefaultHttpClientConnectionOperator.java:151) at org.apache.http.impl.conn.PoolingHttpClientConnectionManager.connect(PoolingHttpClientConnectionManager.java:353) at org.apache.http.impl.execchain.MainClientExec.establishRoute(MainClientExec.java:380) at org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:236) 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:55) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:511) ... 10 more Caused by: java.net.ConnectException: Connection refused at java.net.PlainSocketImpl.socketConnect(java.base@9-ea/Native Method) at java.net.AbstractPlainSocketImpl.doConnect(java.base@9-ea/AbstractPlainSocketImpl.java:400) at java.net.AbstractPlainSocketImpl.connectToAddress(java.base@9-ea/AbstractPlainSocketImpl.java:243) at java.net.AbstractPlainSocketImpl.connect(java.base@9-ea/AbstractPlainSocketImpl.java:225) at java.net.SocksSocketImpl.connect(java.base@9-ea/SocksSocketImpl.java:402) at java.net.Socket.connect(java.base@9-ea/Socket.java:591) at org.apache.http.conn.socket.PlainConnectionSocketFactory.connectSocket(PlainConnectionSocketFactory.java:74) at org.apache.http.impl.conn.DefaultHttpClientConnectionOperator.connect(DefaultHttpClientConnectionOperator.java:134) ... 20 more FAILED: org.apache.solr.handler.TestReplicationHandler.doTestIndexAndConfigAliasReplication Error Message: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-026/./collection1/data/index.20160710134029107, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-026/./collection1/data, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-026/./collection1/data/index.20160710134029034] expected:<2> but was:<3> Stack Trace: java.lang.AssertionError: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-026/./collection1/data/index.20160710134029107, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-026/./collection1/data, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-026/./collection1/data/index.20160710134029034] expected:<2> but was:<3> at __randomizedtesting.SeedInfo.seed([FD60286B08398AC3:A13C633CED12525]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.failNotEquals(Assert.java:647) at org.junit.Assert.assertEquals(Assert.java:128) at org.junit.Assert.assertEquals(Assert.java:472) at org.apache.solr.handler.TestReplicationHandler.checkForSingleIndex(TestReplicationHandler.java:900) at org.apache.solr.handler.TestReplicationHandler.doTestIndexAndConfigAliasReplication(TestReplicationHandler.java:1332) at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method) at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62) at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:533) 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:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java: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:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at java.lang.Thread.run(java.base@9-ea/Thread.java:843) FAILED: org.apache.solr.update.AutoCommitTest.testCommitWithin Error Message: Exception during query Stack Trace: java.lang.RuntimeException: Exception during query at __randomizedtesting.SeedInfo.seed([FD60286B08398AC3:47B247138B1764D6]:0) at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:782) at org.apache.solr.update.AutoCommitTest.testCommitWithin(AutoCommitTest.java:325) at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method) at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62) at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:533) 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:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java: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:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at java.lang.Thread.run(java.base@9-ea/Thread.java:843) Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=//result[@numFound=1] xml response was: <?xml version="1.0" encoding="UTF-8"?> <response> <lst name="responseHeader"><int name="status">0</int><int name="QTime">0</int></lst><result name="response" numFound="0" start="0"></result> </response> request was:q=id:529&qt=standard&start=0&rows=20&version=2.2 at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:775) ... 40 more Build Log: [...truncated 11064 lines...] [junit4] Suite: org.apache.solr.handler.TestReplicationHandler [junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/init-core-data-001 [junit4] 2> 430996 INFO (SUITE-TestReplicationHandler-seed#[FD60286B08398AC3]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=None) [junit4] 2> 430997 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.SolrTestCaseJ4 ###Starting doTestDetails [junit4] 2> 430997 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-001/collection1 [junit4] 2> 431000 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314 [junit4] 2> 431000 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@12a6a9e{/solr,null,AVAILABLE} [junit4] 2> 431001 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.e.j.s.ServerConnector Started ServerConnector@14daf88{HTTP/1.1,[http/1.1]}{127.0.0.1:38134} [junit4] 2> 431001 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.e.j.s.Server Started @433413ms [junit4] 2> 431001 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-001/collection1/data, hostPort=38134} [junit4] 2> 431002 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): jdk.internal.loader.ClassLoaders$AppClassLoader@340fab [junit4] 2> 431002 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-001' [junit4] 2> 431002 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 431002 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 431002 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-001/solr.xml [junit4] 2> 431005 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-001/. [junit4] 2> 431005 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.c.CoreContainer New CoreContainer 16375221 [junit4] 2> 431005 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-001] [junit4] 2> 431005 WARN (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.c.CoreContainer Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-001/lib to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-001/lib [junit4] 2> 431006 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] 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, [junit4] 2> 431007 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.u.UpdateShardHandler Created UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&maxConnections=100000&maxConnectionsPerHost=100000 [junit4] 2> 431007 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 431007 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 431007 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 431007 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 431008 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-001/. [junit4] 2> 431008 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {schema=schema.xml, dataDir=data/, loadOnStartup=true, transient=false, name=collection1, config=solrconfig.xml, configSetProperties=configsetprops.json} [junit4] 2> 431008 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.c.CorePropertiesLocator Found core collection1 in /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-001/./collection1 [junit4] 2> 431008 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions [junit4] 2> 431009 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-001/collection1' [junit4] 2> 431009 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.s.SolrDispatchFilter user.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0 [junit4] 2> 431009 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 431009 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 431009 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 431012 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 431014 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 431018 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml [junit4] 2> 431020 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 431021 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 431021 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-001/collection1' [junit4] 2> 431021 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-001/./collection1 [junit4] 2> 431021 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 431022 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-001/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-001/./collection1/data/] [junit4] 2> 431022 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1 [junit4] 2> 431022 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.c.CachingDirectoryFactory return new directory for /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-001/./collection1/data [junit4] 2> 431022 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.c.SolrCore New index directory detected: old=null new=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-001/./collection1/data/index/ [junit4] 2> 431022 WARN (coreLoadExecutor-1207-thread-1) [ ] o.a.s.c.SolrCore [collection1] Solr index directory '/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-001/./collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 431022 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.c.CachingDirectoryFactory return new directory for /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-001/./collection1/data/index [junit4] 2> 431022 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=48, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 431023 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1e61d97 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8dcf37),segFN=segments_1,generation=1} [junit4] 2> 431023 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 431023 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ ] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-001/./collection1/data/ [junit4] 2> 431024 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 431025 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 431025 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 431026 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 431026 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 431027 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy [junit4] 2> 431027 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,lazy,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/update/csv,/sql,/graph,/admin/segments,/admin/system,/replication,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file,/terms [junit4] 2> 431027 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 431028 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 431028 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 431028 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=28, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.513154715080084] [junit4] 2> 431028 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1e61d97 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8dcf37),segFN=segments_1,generation=1} [junit4] 2> 431028 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 431028 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@942811[collection1] main] [junit4] 2> 431028 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-001/collection1/conf [junit4] 2> 431028 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-001/collection1/conf} [junit4] 2> 431028 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-001/collection1/conf [junit4] 2> 431028 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 431028 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml,xslt/dummy.xsl [junit4] 2> 431028 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 431029 INFO (searcherExecutor-1208-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@942811[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 431029 INFO (coreLoadExecutor-1207-thread-1) [ ] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 431511 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002/collection1 [junit4] 2> 431514 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314 [junit4] 2> 431515 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@82e3da{/solr,null,AVAILABLE} [junit4] 2> 431515 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.e.j.s.ServerConnector Started ServerConnector@1b04155{HTTP/1.1,[http/1.1]}{127.0.0.1:33788} [junit4] 2> 431515 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.e.j.s.Server Started @433927ms [junit4] 2> 431515 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002/collection1/data, hostPort=33788} [junit4] 2> 431515 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): jdk.internal.loader.ClassLoaders$AppClassLoader@340fab [junit4] 2> 431516 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002' [junit4] 2> 431516 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 431516 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 431516 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002/solr.xml [junit4] 2> 431519 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002/. [junit4] 2> 431519 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.c.CoreContainer New CoreContainer 20127096 [junit4] 2> 431519 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002] [junit4] 2> 431519 WARN (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.c.CoreContainer Couldn't add files from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002/lib to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002/lib [junit4] 2> 431520 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] 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, [junit4] 2> 431521 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.u.UpdateShardHandler Created UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&maxConnections=100000&maxConnectionsPerHost=100000 [junit4] 2> 431521 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 431521 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 431521 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 431521 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 431522 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002/. [junit4] 2> 431522 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {schema=schema.xml, dataDir=data/, loadOnStartup=true, transient=false, name=collection1, config=solrconfig.xml, configSetProperties=configsetprops.json} [junit4] 2> 431522 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.c.CorePropertiesLocator Found core collection1 in /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002/./collection1 [junit4] 2> 431522 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions [junit4] 2> 431523 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002/collection1' [junit4] 2> 431523 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.s.SolrDispatchFilter user.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0 [junit4] 2> 431523 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[FD60286B08398AC3]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 431523 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 431523 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 431527 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 431529 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 431536 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml [junit4] 2> 431538 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 431539 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 431540 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002/collection1' [junit4] 2> 431540 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002/./collection1 [junit4] 2> 431540 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 431541 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002/./collection1/data/] [junit4] 2> 431541 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1 [junit4] 2> 431541 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.c.CachingDirectoryFactory return new directory for /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002/./collection1/data [junit4] 2> 431541 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.c.SolrCore New index directory detected: old=null new=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002/./collection1/data/index/ [junit4] 2> 431541 WARN (coreLoadExecutor-1217-thread-1) [ ] o.a.s.c.SolrCore [collection1] Solr index directory '/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002/./collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 431541 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.c.CachingDirectoryFactory return new directory for /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002/./collection1/data/index [junit4] 2> 431542 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=48, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 431542 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11538b6 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@d9823e),segFN=segments_1,generation=1} [junit4] 2> 431542 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 431542 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ ] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002/./collection1/data/ [junit4] 2> 431544 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 431545 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 431546 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 431547 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 431547 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 431548 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy [junit4] 2> 431548 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,lazy,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/update/csv,/sql,/graph,/admin/segments,/admin/system,/replication,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file,/terms [junit4] 2> 431548 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 431548 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 431548 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 431548 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=28, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.513154715080084] [junit4] 2> 431548 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11538b6 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@d9823e),segFN=segments_1,generation=1} [junit4] 2> 431548 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 431548 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1a2c9d1[collection1] main] [junit4] 2> 431548 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002/collection1/conf [junit4] 2> 431548 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002/collection1/conf} [junit4] 2> 431549 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002/collection1/conf [junit4] 2> 431549 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 431553 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms [junit4] 2> 431553 INFO (searcherExecutor-1218-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1a2c9d1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 431553 INFO (coreLoadExecutor-1217-thread-1) [ ] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 431556 INFO (qtp28872823-2453) [ ] 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> 432027 INFO (qtp28872823-2455) [ ] 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> 432027 INFO (qtp28872823-2448) [ ] 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> 432029 INFO (qtp28872823-2454) [ ] 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> 432029 INFO (qtp30875431-2472) [ ] 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> 432031 INFO (qtp28872823-2453) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[0]} 0 0 [junit4] 2> 432031 INFO (qtp28872823-2455) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 432032 INFO (qtp28872823-2455) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1e61d97 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8dcf37),segFN=segments_1,generation=1} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1e61d97 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8dcf37),segFN=segments_2,generation=2} [junit4] 2> 432033 INFO (qtp28872823-2455) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 2 [junit4] 2> 432033 INFO (qtp28872823-2455) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@102be2[collection1] main] [junit4] 2> 432033 INFO (qtp28872823-2455) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 432033 INFO (searcherExecutor-1208-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@102be2[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C1)))} [junit4] 2> 432033 INFO (qtp28872823-2455) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 2 [junit4] 2> 432036 WARN (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix [junit4] 2> 432037 INFO (qtp28872823-2449) [ ] 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> 432037 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Master's generation: 2 [junit4] 2> 432037 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Slave's generation: 1 [junit4] 2> 432037 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Starting replication process [junit4] 2> 432043 INFO (qtp28872823-2454) [ ] 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=5 [junit4] 2> 432043 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Number of files in latest index in master: 10 [junit4] 2> 432043 INFO (explicit-fetchindex-cmd) [ ] o.a.s.c.CachingDirectoryFactory return new directory for /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002/./collection1/data/index.20160710133947362 [junit4] 2> 432044 INFO (explicit-fetchindex-cmd) [ ] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1 [junit4] 2> 432044 INFO (explicit-fetchindex-cmd) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=40, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 432045 INFO (explicit-fetchindex-cmd) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11538b6 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@d9823e),segFN=segments_1,generation=1} [junit4] 2> 432045 INFO (explicit-fetchindex-cmd) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 432045 INFO (explicit-fetchindex-cmd) [ ] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used. [junit4] 2> 432045 INFO (explicit-fetchindex-cmd) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11538b6 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@d9823e),segFN=segments_1,generation=1} [junit4] 2> 432045 INFO (explicit-fetchindex-cmd) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 432045 INFO (explicit-fetchindex-cmd) [ ] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1 [junit4] 2> 432045 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Starting download (fullCopy=false) to MockDirectoryWrapper(RAMDirectory@b409fc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@35cac9) [junit4] 2> 432046 INFO (qtp28872823-2453) [ ] 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> 432048 INFO (qtp28872823-2455) [ ] 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> 432049 INFO (qtp28872823-2449) [ ] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.tip&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 432050 INFO (qtp28872823-2454) [ ] 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> 432050 INFO (qtp28872823-2453) [ ] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.doc&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 432051 INFO (qtp28872823-2455) [ ] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.tim&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 432052 INFO (qtp28872823-2449) [ ] 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> 432053 INFO (qtp28872823-2454) [ ] 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> 432053 INFO (qtp28872823-2453) [ ] 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> 432054 INFO (qtp28872823-2455) [ ] 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> 432054 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Total time taken for download (fullCopy=false,bytesDownloaded=1405) : 0 secs (null bytes/sec) to MockDirectoryWrapper(RAMDirectory@b409fc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@35cac9) [junit4] 2> 432055 INFO (explicit-fetchindex-cmd) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=49, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.3390512210738675] [junit4] 2> 432056 INFO (explicit-fetchindex-cmd) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11538b6 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@d9823e),segFN=segments_1,generation=1} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11538b6 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@d9823e),segFN=segments_2,generation=2} [junit4] 2> 432056 INFO (explicit-fetchindex-cmd) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 2 [junit4] 2> 432056 INFO (explicit-fetchindex-cmd) [ ] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used. [junit4] 2> 432056 INFO (explicit-fetchindex-cmd) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@983ea5[collection1] main] [junit4] 2> 432056 INFO (searcherExecutor-1218-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@983ea5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C1)))} [junit4] 2> 432056 INFO (explicit-fetchindex-cmd) [ ] o.a.s.c.CachingDirectoryFactory looking to close /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002/./collection1/data/index.20160710133947362 [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002/./collection1/data/index.20160710133947362;done=true>>] [junit4] 2> 432056 INFO (explicit-fetchindex-cmd) [ ] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=false [junit4] 2> 432056 INFO (explicit-fetchindex-cmd) [ ] o.a.s.c.CachingDirectoryFactory Closing directory: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002/./collection1/data/index.20160710133947362 [junit4] 2> 432057 INFO (qtp30875431-2474) [ ] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={wait=true&masterUrl=http://127.0.0.1:38134/solr/collection1/replication&command=fetchindex} status=0 QTime=21 [junit4] 2> 432060 INFO (qtp28872823-2449) [ ] 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> 432060 INFO (qtp30875431-2473) [ ] 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> 432062 INFO (qtp28872823-2448) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[1]} 0 1 [junit4] 2> 432062 INFO (qtp28872823-2453) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 432064 INFO (qtp28872823-2453) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=3 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1e61d97 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8dcf37),segFN=segments_1,generation=1} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1e61d97 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8dcf37),segFN=segments_2,generation=2} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1e61d97 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8dcf37),segFN=segments_3,generation=3} [junit4] 2> 432064 INFO (qtp28872823-2453) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 3 [junit4] 2> 432064 INFO (qtp28872823-2453) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1adb44c[collection1] main] [junit4] 2> 432081 INFO (qtp28872823-2453) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 432082 INFO (searcherExecutor-1208-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1adb44c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C1) Uninverting(_1(7.0.0):C1)))} [junit4] 2> 432082 INFO (qtp28872823-2453) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 19 [junit4] 2> 432084 WARN (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix [junit4] 2> 432085 INFO (qtp28872823-2454) [ ] 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> 432086 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Master's generation: 3 [junit4] 2> 432086 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Slave's generation: 2 [junit4] 2> 432086 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Starting replication process [junit4] 2> 432088 INFO (qtp28872823-2449) [ ] 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> 432088 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Number of files in latest index in master: 19 [junit4] 2> 432089 INFO (explicit-fetchindex-cmd) [ ] o.a.s.c.CachingDirectoryFactory return new directory for /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002/./collection1/data/index.20160710133947407 [junit4] 2> 432089 INFO (explicit-fetchindex-cmd) [ ] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1 [junit4] 2> 432090 INFO (explicit-fetchindex-cmd) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=40, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 432090 INFO (explicit-fetchindex-cmd) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11538b6 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@d9823e),segFN=segments_2,generation=2} [junit4] 2> 432090 INFO (explicit-fetchindex-cmd) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 2 [junit4] 2> 432090 INFO (explicit-fetchindex-cmd) [ ] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used. [junit4] 2> 432090 INFO (explicit-fetchindex-cmd) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11538b6 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@d9823e),segFN=segments_2,generation=2} [junit4] 2> 432090 INFO (explicit-fetchindex-cmd) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 2 [junit4] 2> 432090 INFO (explicit-fetchindex-cmd) [ ] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1 [junit4] 2> 432091 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Starting download (fullCopy=false) to MockDirectoryWrapper(RAMDirectory@11d6c3f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@16b3281) [junit4] 2> 432091 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Skipping download for _0.si because it already exists [junit4] 2> 432091 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Skipping download for _0.nvd because it already exists [junit4] 2> 432091 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Skipping download for _0.tip because it already exists [junit4] 2> 432091 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Skipping download for _0.fdx because it already exists [junit4] 2> 432091 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Skipping download for _0.doc because it already exists [junit4] 2> 432091 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Skipping download for _0.tim because it already exists [junit4] 2> 432091 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Skipping download for _0.fdt because it already exists [junit4] 2> 432091 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Skipping download for _0.fnm because it already exists [junit4] 2> 432091 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Skipping download for _0.nvm because it already exists [junit4] 2> 432091 INFO (qtp28872823-2448) [ ] 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> 432092 INFO (qtp28872823-2453) [ ] 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> 432093 INFO (qtp28872823-2454) [ ] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.doc&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 432094 INFO (qtp28872823-2449) [ ] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.tim&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 432095 INFO (qtp28872823-2448) [ ] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.tip&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 432096 INFO (qtp28872823-2453) [ ] 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> 432097 INFO (qtp28872823-2454) [ ] 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> 432097 INFO (qtp28872823-2449) [ ] 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> 432098 INFO (qtp28872823-2448) [ ] 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> 432099 INFO (qtp28872823-2453) [ ] 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> 432099 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Total time taken for download (fullCopy=false,bytesDownloaded=1471) : 0 secs (null bytes/sec) to MockDirectoryWrapper(RAMDirectory@11d6c3f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@16b3281) [junit4] 2> 432101 WARN (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Exception while updating statistics [junit4] 2> java.io.IOException: file "replication.properties" was already written to [junit4] 2> at org.apache.lucene.store.MockDirectoryWrapper.createOutput(MockDirectoryWrapper.java:640) [junit4] 2> at org.apache.solr.handler.IndexFetcher.logReplicationTimeAndConfFiles(IndexFetcher.java:683) [junit4] 2> at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:495) [junit4] 2> at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:265) [junit4] 2> at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:393) [junit4] 2> at org.apache.solr.handler.ReplicationHandler$1.run(ReplicationHandler.java:281) [junit4] 2> 432101 INFO (explicit-fetchindex-cmd) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=49, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.3390512210738675] [junit4] 2> 432102 INFO (explicit-fetchindex-cmd) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11538b6 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@d9823e),segFN=segments_2,generation=2} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11538b6 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@d9823e),segFN=segments_3,generation=3} [junit4] 2> 432102 INFO (explicit-fetchindex-cmd) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 3 [junit4] 2> 432102 INFO (explicit-fetchindex-cmd) [ ] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used. [junit4] 2> 432103 INFO (explicit-fetchindex-cmd) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1b57d8d[collection1] main] [junit4] 2> 432103 INFO (searcherExecutor-1218-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1b57d8d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C1) Uninverting(_1(7.0.0):C1)))} [junit4] 2> 432103 INFO (explicit-fetchindex-cmd) [ ] o.a.s.c.CachingDirectoryFactory looking to close /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002/./collection1/data/index.20160710133947407 [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002/./collection1/data/index.20160710133947407;done=true>>] [junit4] 2> 432103 INFO (explicit-fetchindex-cmd) [ ] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=false [junit4] 2> 432103 INFO (explicit-fetchindex-cmd) [ ] o.a.s.c.CachingDirectoryFactory Closing directory: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002/./collection1/data/index.20160710133947407 [junit4] 2> 432103 INFO (qtp30875431-2467) [ ] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={wait=true&masterUrl=http://127.0.0.1:38134/solr/collection1/replication&command=fetchindex} status=0 QTime=19 [junit4] 2> 432105 INFO (qtp28872823-2454) [ ] 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> 432105 INFO (qtp30875431-2472) [ ] 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> 432107 INFO (qtp28872823-2455) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[2]} 0 0 [junit4] 2> 432108 INFO (qtp28872823-2448) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 432110 INFO (qtp28872823-2448) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=4 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1e61d97 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8dcf37),segFN=segments_1,generation=1} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1e61d97 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8dcf37),segFN=segments_2,generation=2} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1e61d97 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8dcf37),segFN=segments_3,generation=3} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1e61d97 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8dcf37),segFN=segments_4,generation=4} [junit4] 2> 432110 INFO (qtp28872823-2448) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 4 [junit4] 2> 432110 INFO (qtp28872823-2448) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@18e4046[collection1] main] [junit4] 2> 432111 INFO (qtp28872823-2448) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 432114 INFO (searcherExecutor-1208-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@18e4046[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C1) Uninverting(_1(7.0.0):C1) Uninverting(_2(7.0.0):C1)))} [junit4] 2> 432115 INFO (qtp28872823-2448) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 6 [junit4] 2> 432116 WARN (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix [junit4] 2> 432117 INFO (qtp28872823-2449) [ ] 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> 432117 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Master's generation: 4 [junit4] 2> 432117 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Slave's generation: 3 [junit4] 2> 432117 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Starting replication process [junit4] 2> 432118 INFO (qtp28872823-2454) [ ] 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=0 [junit4] 2> 432118 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Number of files in latest index in master: 28 [junit4] 2> 432118 INFO (explicit-fetchindex-cmd) [ ] o.a.s.c.CachingDirectoryFactory return new directory for /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FD60286B08398AC3-001/solr-instance-002/./collection1/data/index.20160710133947437 [junit4] 2> 432120 INFO (explicit-fetchindex-cmd) [ ] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1 [junit4] 2> 432120 INFO (explicit-fetchindex-cmd) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=40, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 432121 INFO (explicit-fetchindex-cmd) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11538b6 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@d9823e),segFN=segments_3,generation=3} [junit4] 2> 432121 INFO (explicit-fetchindex-cmd) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 3 [junit4] 2> 432121 INFO (explicit-fetchindex-cmd) [ ] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used. [junit4] 2> 432121 INFO (explicit-fetchindex-cmd) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11538b6 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@d9823e),segFN=segments_3,generation=3} [junit4] 2> 432121 INFO (explicit-fetchindex-cmd) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 3 [junit4] 2> 432121 INFO (explicit-fetchindex-cmd) [ ] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1 [junit4] 2> 432121 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Starting download (fullCopy=false) to MockDirectoryWrapper(RAMDirectory@21705a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3bbed) [junit4] 2> 432121 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Skipping download for _0.si because it already exists [junit4] 2> 432121 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Skipping download for _0.nvd because it already exists [junit4] 2> 432122 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Skipping download for _0.tip because it already exists [junit4] 2> 432122 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Skipping download for _0.fdx because it already exists [junit4] 2> 432122 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Skipping download for _0.doc because it already exists [junit4] 2> 432122 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Skipping download for _0.tim because it already exists [junit4] 2> 432122 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Skipping download for _0.fdt because it already exists [junit4] 2> 432122 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Skipping download for _0.fnm because it already exists [junit4] 2> 432122 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Skipping download for _0.nvm because it already exists [junit4] 2> 432122 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Skipping download for _1.si because it already exists [junit4] 2> 432122 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Skipping download for _1.nvd because it already exists [junit4] 2> 432122 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Skipping download for _1.doc because it already exists [junit4] 2> 432122 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Skipping download for _1.tim because it already exists [junit4] 2> 432122 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Skipping download for _1.tip because it already exists [junit4] 2> 432122 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Skipping download for _1.fdx because it already exists [junit4] 2> 432122 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Skipping download for _1.fnm because it already exists [junit4] 2> 432122 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Skipping download for _1.nvm because it already exists [junit4] 2> 432122 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Skipping download for _1.fdt because it already exists [junit4] 2> 432123 INFO (qtp28872823-2455) [ ] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2.nvd&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 432123 INFO (qtp28872823-2448) [ ] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2.si&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 432124 INFO (qtp28872823-2449) [ ] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2.tip&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 432125 INFO (qtp28872823-2449) [ ] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2.fdt&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 432126 INFO (qtp28872823-2455) [ ] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2.fnm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 432126 INFO (qtp28872823-2448) [ ] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2.nvm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 432127 INFO (qtp28872823-2454) [ ] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2.fdx&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 432128 INFO (qtp28872823-2449) [ ] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2.doc&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 432129 INFO (qtp28872823-2455) [ ] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2.tim&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 432129 INFO (qtp28872823-2448) [ ] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=segments_4&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 432130 INFO (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Total time taken for download (fullCopy=false,bytesDownloaded=1537) : 0 secs (null bytes/sec) to MockDirectoryWrapper(RAMDirectory@21705a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3bbed) [junit4] 2> 432132 WARN (explicit-fetchindex-cmd) [ ] o.a.s.h.IndexFetcher Exception while updating statistics [junit4] 2> java.io.IOException: file "replication.properties" was already written to [junit4] 2> at org.apache.lucene.store.MockDirectoryWrapper.createOutput(MockDirectoryWrapper.java:640) [junit4] 2> at org.apache.solr.handler.IndexFetcher.logReplicationTimeAndConfFiles(IndexFetcher.java:683) [junit4] 2> at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:495) [junit4] 2> at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:265) [junit4] 2> at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:393) [junit4] 2> at org.apache.solr.handler.ReplicationHandler$1.run(ReplicationHandler.java:281) [junit4] 2> 432132 INFO (explicit-fetchindex-cmd) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=49, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.3390512210738675] [junit4] 2> 432133 INFO (explicit-fetchindex-cmd) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11538b6 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@d9823e),segFN=segments_3,generation=3} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11538b6 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@d9823e),segFN=segments_4,generation=4} [junit4] 2> 432133 INFO (explicit-fetchindex-cmd) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 4 [junit4] 2> 432133 INFO (explicit-fetchindex-cmd) [ ] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used. [junit4] 2> 432133 INFO (explicit-fetchindex-cmd) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@2cac3[collection1] main] [junit4] 2> 432133 INFO (searcherExecutor-1218-thread-1) [ ] o.a. [...truncated too long message...] n1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(7.0.0):C15)))} [junit4] 2> 1119239 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[FD60286B08398AC3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[15 (1539464625947410432)]} 0 255 [junit4] 2> 1119239 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[FD60286B08398AC3]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:14&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0 [junit4] 2> 1119240 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[FD60286B08398AC3]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:15&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0 [junit4] 2> 1119240 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[FD60286B08398AC3]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testMaxDocs [junit4] 2> 1119240 INFO (SUITE-AutoCommitTest-seed#[FD60286B08398AC3]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> 1119240 INFO (SUITE-AutoCommitTest-seed#[FD60286B08398AC3]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=20027161 [junit4] 2> 1119241 INFO (coreCloseExecutor-3980-thread-1) [ ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@f4beff [junit4] 2> 1119241 INFO (coreCloseExecutor-3980-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommit maxDocs=14,soft autocommits=1,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=16,adds=1,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=16,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0} [junit4] 2> 1119241 INFO (coreCloseExecutor-3980-thread-1) [ ] o.a.s.u.SolrCoreState Closing SolrCoreState [junit4] 2> 1119241 INFO (coreCloseExecutor-3980-thread-1) [ ] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter [junit4] 2> 1119241 INFO (coreCloseExecutor-3980-thread-1) [ ] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser [junit4] 2> 1119241 INFO (coreCloseExecutor-3980-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close. [junit4] 2> 1119246 INFO (coreCloseExecutor-3980-thread-1) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@386f35 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@a9f8ae),segFN=segments_3,generation=3} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@386f35 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@a9f8ae),segFN=segments_4,generation=4} [junit4] 2> 1119246 INFO (coreCloseExecutor-3980-thread-1) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 4 [junit4] 2> 1119247 INFO (coreCloseExecutor-3980-thread-1) [ ] o.a.s.c.SolrCore [collection1] Closing main searcher on request. [junit4] 2> 1119255 INFO (coreCloseExecutor-3980-thread-1) [ ] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked [junit4] 2> 1119255 INFO (coreCloseExecutor-3980-thread-1) [ ] o.a.s.c.CachingDirectoryFactory looking to close /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_FD60286B08398AC3-001/init-core-data-001 [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_FD60286B08398AC3-001/init-core-data-001;done=false>>] [junit4] 2> 1119255 INFO (coreCloseExecutor-3980-thread-1) [ ] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true [junit4] 2> 1119255 INFO (coreCloseExecutor-3980-thread-1) [ ] o.a.s.c.CachingDirectoryFactory Closing directory: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_FD60286B08398AC3-001/init-core-data-001 [junit4] 2> 1119255 INFO (coreCloseExecutor-3980-thread-1) [ ] o.a.s.c.CachingDirectoryFactory looking to close /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_FD60286B08398AC3-001/init-core-data-001/index [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_FD60286B08398AC3-001/init-core-data-001/index;done=false>>] [junit4] 2> 1119255 INFO (coreCloseExecutor-3980-thread-1) [ ] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true [junit4] 2> 1119255 INFO (coreCloseExecutor-3980-thread-1) [ ] o.a.s.c.CachingDirectoryFactory Closing directory: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_FD60286B08398AC3-001/init-core-data-001/index [junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_FD60286B08398AC3-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene62): {range_facet_l_dv=PostingsFormat(name=MockRandom), _version_=BlockTreeOrds(blocksize=128), field_t=PostingsFormat(name=MockRandom), multiDefault=Lucene50(blocksize=128), subject=Lucene50(blocksize=128), intDefault=BlockTreeOrds(blocksize=128), id=PostingsFormat(name=MockRandom), range_facet_i_dv=Lucene50(blocksize=128), text=PostingsFormat(name=Asserting), range_facet_l=Lucene50(blocksize=128), timestamp=Lucene50(blocksize=128)}, docValues:{range_facet_l_dv=DocValuesFormat(name=Direct), range_facet_i_dv=DocValuesFormat(name=Memory), timestamp=DocValuesFormat(name=Memory)}, maxPointsInLeafNode=1463, maxMBSortInHeap=5.3217856765263, sim=RandomSimilarity(queryNorm=true): {}, locale=ii, timezone=Etc/GMT-8 [junit4] 2> NOTE: Linux 4.4.0-28-generic i386/Oracle Corporation 9-ea (32-bit)/cpus=12,threads=1,free=387397960,total=529530880 [junit4] 2> NOTE: All tests run in this JVM: [TestFastLRUCache, TestBinaryResponseWriter, PKIAuthenticationIntegrationTest, SolrInfoMBeanTest, UniqFieldsUpdateProcessorFactoryTest, MBeansHandlerTest, TestFieldCacheWithThreads, ShardRoutingCustomTest, TestMinMaxOnMultiValuedField, TestHashPartitioner, BasicFunctionalityTest, SpellingQueryConverterTest, HighlighterMaxOffsetTest, TlogReplayBufferedWhileIndexingTest, AliasIntegrationTest, CSVRequestHandlerTest, SparseHLLTest, SpellCheckComponentTest, SpellCheckCollatorTest, SolrCmdDistributorTest, TestNamedUpdateProcessors, ZkCLITest, TestSubQueryTransformerCrossCore, DistributedQueryComponentCustomSortTest, TestConfigSetImmutable, SolrIndexConfigTest, TestComplexPhraseQParserPlugin, TestSolrDeletionPolicy2, CheckHdfsIndexTest, TestManagedResourceStorage, TestLFUCache, TestRecoveryHdfs, ConvertedLegacyTest, SchemaVersionSpecificBehaviorTest, ChaosMonkeyNothingIsSafeTest, DistanceUnitsTest, MergeStrategyTest, TestFieldResource, SortByFunctionTest, ConfigSetsAPITest, TestShardHandlerFactory, LoggingHandlerTest, HdfsSyncSliceTest, CollectionReloadTest, OpenCloseCoreStressTest, AnalyticsMergeStrategyTest, NumericFieldsTest, TestSimpleQParserPlugin, IndexBasedSpellCheckerTest, HdfsBasicDistributedZk2Test, TestFieldCacheSort, TestSortingResponseWriter, ZkControllerTest, ClusterStateUpdateTest, TestSolrXml, DocValuesTest, DistributedTermsComponentTest, TestClusterStateMutator, TestQuerySenderListener, CollectionsAPIAsyncDistributedZkTest, TestRebalanceLeaders, HttpPartitionTest, TestInitQParser, SharedFSAutoReplicaFailoverTest, CollectionsAPIDistributedZkTest, VersionInfoTest, TestDefaultStatsCache, TestSolrFieldCacheMBean, DOMUtilTest, HdfsDirectoryTest, TestFiltering, DistributedIntervalFacetingTest, DistributedQueueTest, WordBreakSolrSpellCheckerTest, UpdateRequestProcessorFactoryTest, TestNoOpRegenerator, TestSolrCoreProperties, FastVectorHighlighterTest, HdfsRecoverLeaseTest, QueryResultKeyTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestAddFieldRealTimeGet, TestExactStatsCache, SolrPluginUtilsTest, SoftAutoCommitTest, BlockJoinFacetSimpleTest, TestSolrConfigHandlerCloud, TestSurroundQueryParser, TestPivotHelperCode, SuggestComponentTest, MultiTermTest, TestQueryUtils, CoreAdminRequestStatusTest, DirectoryFactoryTest, TestCodecSupport, FacetPivotSmallTest, CustomCollectionTest, TermVectorComponentTest, SimpleMLTQParserTest, BlobRepositoryCloudTest, ZkSolrClientTest, AutoCommitTest] [junit4] Completed [320/620 (3!)] on J1 in 5.65s, 3 tests, 1 error <<< FAILURES! [...truncated 948 lines...] BUILD FAILED /home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:740: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:684: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:59: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build.xml:233: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/common-build.xml:530: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:1443: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:984: There were test failures: 620 suites (10 ignored), 2635 tests, 2 errors, 1 failure, 136 ignored (88 assumptions) [seed: FD60286B08398AC3] Total time: 64 minutes 34 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
--------------------------------------------------------------------- To unsubscribe, e-mail: [email protected] For additional commands, e-mail: [email protected]
