You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2016/08/19 20:11:26 UTC
[JENKINS] Lucene-Solr-master-Linux (32bit/jdk1.8.0_102) - Build #
17614 - Unstable!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/17614/
Java: 32bit/jdk1.8.0_102 -server -XX:+UseG1GC
2 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.handler.TestReplicationHandler
Error Message:
ObjectTracker found 1 object(s) that were not released!!! [NRTCachingDirectory]
Stack Trace:
java.lang.AssertionError: ObjectTracker found 1 object(s) that were not released!!! [NRTCachingDirectory]
at __randomizedtesting.SeedInfo.seed([DF93681792975EDE]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertNull(Assert.java:551)
at org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:257)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:834)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java: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(Thread.java:745)
FAILED: org.apache.solr.cloud.LeaderFailoverAfterPartitionTest.test
Error Message:
No live SolrServers available to handle this request:[http://127.0.0.1:41203/e_t/c8n_1x3_lf_shard1_replica3]
Stack Trace:
org.apache.solr.client.solrj.impl.CloudSolrClient$RouteException: No live SolrServers available to handle this request:[http://127.0.0.1:41203/e_t/c8n_1x3_lf_shard1_replica3]
at __randomizedtesting.SeedInfo.seed([DF93681792975EDE:57C757CD3C6B3326]:0)
at org.apache.solr.client.solrj.impl.CloudSolrClient.directUpdate(CloudSolrClient.java:760)
at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1172)
at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:1061)
at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:997)
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.LeaderFailoverAfterPartitionTest.testRf3WithLeaderFailover(LeaderFailoverAfterPartitionTest.java:178)
at org.apache.solr.cloud.LeaderFailoverAfterPartitionTest.test(LeaderFailoverAfterPartitionTest.java:57)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java: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(Thread.java:745)
Caused by: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:41203/e_t/c8n_1x3_lf_shard1_replica3]
at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:392)
at org.apache.solr.client.solrj.impl.CloudSolrClient.lambda$directUpdate$0(CloudSolrClient.java:735)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
... 1 more
Caused by: org.apache.solr.client.solrj.SolrServerException: Server refused connection at: http://127.0.0.1:41203/e_t/c8n_1x3_lf_shard1_replica3
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:615)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:261)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:250)
at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:413)
at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:381)
... 6 more
Caused by: org.apache.http.conn.HttpHostConnectException: Connect to 127.0.0.1:41203 [/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:513)
... 10 more
Caused by: java.net.ConnectException: Connection refused
at java.net.PlainSocketImpl.socketConnect(Native Method)
at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:350)
at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206)
at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188)
at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)
at java.net.Socket.connect(Socket.java:589)
at org.apache.http.conn.socket.PlainConnectionSocketFactory.connectSocket(PlainConnectionSocketFactory.java:74)
at org.apache.http.impl.conn.DefaultHttpClientConnectionOperator.connect(DefaultHttpClientConnectionOperator.java:134)
... 20 more
Build Log:
[...truncated 11511 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_DF93681792975EDE-001/init-core-data-001
[junit4] 2> 893397 INFO (SUITE-TestReplicationHandler-seed#[DF93681792975EDE]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=None)
[junit4] 2> 893398 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.SolrTestCaseJ4 ###Starting doTestReplicateAfterStartup
[junit4] 2> 893399 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] 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_DF93681792975EDE-001/solr-instance-001/collection1
[junit4] 2> 893404 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 893404 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6ae4b3{/solr,null,AVAILABLE}
[junit4] 2> 893405 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.e.j.s.ServerConnector Started ServerConnector@166c878{HTTP/1.1,[http/1.1]}{127.0.0.1:40596}
[junit4] 2> 893405 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.e.j.s.Server Started @895505ms
[junit4] 2> 893405 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_DF93681792975EDE-001/solr-instance-001/collection1/data, hostContext=/solr, hostPort=40596}
[junit4] 2> 893406 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@1d16e93
[junit4] 2> 893406 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] 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_DF93681792975EDE-001/solr-instance-001'
[junit4] 2> 893406 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 893406 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 893406 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] 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_DF93681792975EDE-001/solr-instance-001/solr.xml
[junit4] 2> 893409 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] 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_DF93681792975EDE-001/solr-instance-001/.
[junit4] 2> 893409 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.c.CoreContainer New CoreContainer 24804070
[junit4] 2> 893409 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] 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_DF93681792975EDE-001/solr-instance-001]
[junit4] 2> 893410 WARN (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] 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_DF93681792975EDE-001/solr-instance-001/lib to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_DF93681792975EDE-001/solr-instance-001/lib
[junit4] 2> 893410 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] 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> 893412 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.u.UpdateShardHandler Created UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&maxConnections=100000&maxConnectionsPerHost=100000
[junit4] 2> 893412 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 893412 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 893412 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 893412 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 893412 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] 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_DF93681792975EDE-001/solr-instance-001/.
[junit4] 2> 893413 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data/}
[junit4] 2> 893413 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] 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_DF93681792975EDE-001/solr-instance-001/./collection1
[junit4] 2> 893413 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
[junit4] 2> 893413 INFO (coreLoadExecutor-2437-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_DF93681792975EDE-001/solr-instance-001/collection1'
[junit4] 2> 893413 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.s.SolrDispatchFilter user.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0
[junit4] 2> 893415 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 893415 INFO (coreLoadExecutor-2437-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 893415 INFO (coreLoadExecutor-2437-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 893421 INFO (coreLoadExecutor-2437-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 893423 INFO (coreLoadExecutor-2437-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 893445 INFO (coreLoadExecutor-2437-thread-1) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 893447 INFO (coreLoadExecutor-2437-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 893449 INFO (coreLoadExecutor-2437-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 893451 INFO (coreLoadExecutor-2437-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_DF93681792975EDE-001/solr-instance-001/collection1'
[junit4] 2> 893451 INFO (coreLoadExecutor-2437-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_DF93681792975EDE-001/solr-instance-001/./collection1
[junit4] 2> 893451 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 893452 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-001/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_DF93681792975EDE-001/solr-instance-001/./collection1/data/]
[junit4] 2> 893452 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
[junit4] 2> 893452 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-001/./collection1/data/snapshot_metadata
[junit4] 2> 893452 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] o.a.s.c.s.SolrSnapshotMetaDataManager Loading from snapshot metadata file...
[junit4] 2> 893453 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-001/./collection1/data
[junit4] 2> 893453 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-001/./collection1/data/index/
[junit4] 2> 893453 WARN (coreLoadExecutor-2437-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-001/./collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 893453 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-001/./collection1/data/index
[junit4] 2> 893453 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=14, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 893454 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@131d79c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1432685),segFN=segments_1,generation=1}
[junit4] 2> 893454 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 893454 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x: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_DF93681792975EDE-001/solr-instance-001/./collection1/data/
[junit4] 2> 893455 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 893457 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 893458 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 893459 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 893459 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 893460 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy
[junit4] 2> 893460 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] 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> 893460 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 893461 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 893461 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 893461 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=16, maxMergeAtOnceExplicit=15, maxMergedSegmentMB=25.49609375, floorSegmentMB=2.1806640625, forceMergeDeletesPctAllowed=29.81533062984282, segmentsPerTier=49.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 893461 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@131d79c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1432685),segFN=segments_1,generation=1}
[junit4] 2> 893461 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 893461 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@11cdf6b[collection1] main]
[junit4] 2> 893461 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-001/collection1/conf
[junit4] 2> 893461 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-001/collection1/conf}
[junit4] 2> 893461 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-001/collection1/conf
[junit4] 2> 893462 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 893463 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 893463 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 893463 INFO (searcherExecutor-2438-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@11cdf6b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 893463 INFO (coreLoadExecutor-2437-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 893916 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] 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_DF93681792975EDE-001/solr-instance-002/collection1
[junit4] 2> 893919 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 893919 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@17865ca{/solr,null,AVAILABLE}
[junit4] 2> 893920 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.e.j.s.ServerConnector Started ServerConnector@c0b333{HTTP/1.1,[http/1.1]}{127.0.0.1:46726}
[junit4] 2> 893920 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.e.j.s.Server Started @896019ms
[junit4] 2> 893920 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_DF93681792975EDE-001/solr-instance-002/collection1/data, hostContext=/solr, hostPort=46726}
[junit4] 2> 893920 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@1d16e93
[junit4] 2> 893920 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] 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_DF93681792975EDE-001/solr-instance-002'
[junit4] 2> 893920 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 893920 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 893920 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] 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_DF93681792975EDE-001/solr-instance-002/solr.xml
[junit4] 2> 893923 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] 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_DF93681792975EDE-001/solr-instance-002/.
[junit4] 2> 893923 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.c.CoreContainer New CoreContainer 22787291
[junit4] 2> 893924 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] 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_DF93681792975EDE-001/solr-instance-002]
[junit4] 2> 893924 WARN (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] 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_DF93681792975EDE-001/solr-instance-002/lib to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_DF93681792975EDE-001/solr-instance-002/lib
[junit4] 2> 893924 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] 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> 893925 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.u.UpdateShardHandler Created UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&maxConnections=100000&maxConnectionsPerHost=100000
[junit4] 2> 893925 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 893926 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 893926 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 893926 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 893927 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] 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_DF93681792975EDE-001/solr-instance-002/.
[junit4] 2> 893927 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data/}
[junit4] 2> 893928 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] 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_DF93681792975EDE-001/solr-instance-002/./collection1
[junit4] 2> 893928 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
[junit4] 2> 893928 INFO (coreLoadExecutor-2447-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_DF93681792975EDE-001/solr-instance-002/collection1'
[junit4] 2> 893928 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.s.SolrDispatchFilter user.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0
[junit4] 2> 893928 INFO (coreLoadExecutor-2447-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 893928 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 893928 INFO (coreLoadExecutor-2447-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 893933 INFO (coreLoadExecutor-2447-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 893935 INFO (coreLoadExecutor-2447-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 893940 INFO (coreLoadExecutor-2447-thread-1) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 893943 INFO (coreLoadExecutor-2447-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 893944 INFO (coreLoadExecutor-2447-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 893945 INFO (coreLoadExecutor-2447-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_DF93681792975EDE-001/solr-instance-002/collection1'
[junit4] 2> 893945 INFO (coreLoadExecutor-2447-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_DF93681792975EDE-001/solr-instance-002/./collection1
[junit4] 2> 893945 INFO (coreLoadExecutor-2447-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 893945 INFO (coreLoadExecutor-2447-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-002/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_DF93681792975EDE-001/solr-instance-002/./collection1/data/]
[junit4] 2> 893945 INFO (coreLoadExecutor-2447-thread-1) [ x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
[junit4] 2> 893946 INFO (coreLoadExecutor-2447-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-002/./collection1/data/snapshot_metadata
[junit4] 2> 893946 INFO (coreLoadExecutor-2447-thread-1) [ x:collection1] o.a.s.c.s.SolrSnapshotMetaDataManager Loading from snapshot metadata file...
[junit4] 2> 893946 INFO (coreLoadExecutor-2447-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-002/./collection1/data
[junit4] 2> 893946 INFO (coreLoadExecutor-2447-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-002/./collection1/data/index/
[junit4] 2> 893946 WARN (coreLoadExecutor-2447-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-002/./collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 893946 INFO (coreLoadExecutor-2447-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-002/./collection1/data/index
[junit4] 2> 893946 INFO (coreLoadExecutor-2447-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=14, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 893947 INFO (coreLoadExecutor-2447-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1ecf99c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1190587),segFN=segments_1,generation=1}
[junit4] 2> 893947 INFO (coreLoadExecutor-2447-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 893947 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x: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_DF93681792975EDE-001/solr-instance-002/./collection1/data/
[junit4] 2> 893948 INFO (coreLoadExecutor-2447-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 893949 INFO (coreLoadExecutor-2447-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 893949 INFO (coreLoadExecutor-2447-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 893950 INFO (coreLoadExecutor-2447-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 893950 INFO (coreLoadExecutor-2447-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 893951 INFO (coreLoadExecutor-2447-thread-1) [ x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy
[junit4] 2> 893951 INFO (coreLoadExecutor-2447-thread-1) [ x:collection1] 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> 893951 INFO (coreLoadExecutor-2447-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 893951 INFO (coreLoadExecutor-2447-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 893951 INFO (coreLoadExecutor-2447-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 893951 INFO (coreLoadExecutor-2447-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=16, maxMergeAtOnceExplicit=15, maxMergedSegmentMB=25.49609375, floorSegmentMB=2.1806640625, forceMergeDeletesPctAllowed=29.81533062984282, segmentsPerTier=49.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 893951 INFO (coreLoadExecutor-2447-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1ecf99c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1190587),segFN=segments_1,generation=1}
[junit4] 2> 893951 INFO (coreLoadExecutor-2447-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 893951 INFO (coreLoadExecutor-2447-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@13717e7[collection1] main]
[junit4] 2> 893951 INFO (coreLoadExecutor-2447-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-002/collection1/conf
[junit4] 2> 893951 INFO (coreLoadExecutor-2447-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-002/collection1/conf}
[junit4] 2> 893952 INFO (coreLoadExecutor-2447-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-002/collection1/conf
[junit4] 2> 893952 INFO (coreLoadExecutor-2447-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 893953 INFO (coreLoadExecutor-2447-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
[junit4] 2> 893953 INFO (searcherExecutor-2448-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@13717e7[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 893953 INFO (coreLoadExecutor-2447-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 893954 INFO (qtp32326944-5568) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
[junit4] 2> 894430 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.e.j.s.ServerConnector Stopped ServerConnector@c0b333{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 894430 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=22787291
[junit4] 2> 894430 INFO (coreCloseExecutor-2453-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@beab35
[junit4] 2> 894430 INFO (coreCloseExecutor-2453-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 894431 INFO (coreCloseExecutor-2453-thread-1) [ x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 894431 INFO (coreCloseExecutor-2453-thread-1) [ x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 894431 INFO (coreCloseExecutor-2453-thread-1) [ x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
[junit4] 2> 894431 INFO (coreCloseExecutor-2453-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
[junit4] 2> 894431 INFO (coreCloseExecutor-2453-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 3 directories currently being tracked
[junit4] 2> 894432 INFO (coreCloseExecutor-2453-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-002/./collection1/data/snapshot_metadata [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_DF93681792975EDE-001/solr-instance-002/./collection1/data/snapshot_metadata;done=false>>]
[junit4] 2> 894432 INFO (coreCloseExecutor-2453-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 894432 INFO (coreCloseExecutor-2453-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_DF93681792975EDE-001/solr-instance-002/./collection1/data/snapshot_metadata
[junit4] 2> 894432 INFO (coreCloseExecutor-2453-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-002/./collection1/data [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_DF93681792975EDE-001/solr-instance-002/./collection1/data;done=false>>]
[junit4] 2> 894432 INFO (coreCloseExecutor-2453-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 894432 INFO (coreCloseExecutor-2453-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_DF93681792975EDE-001/solr-instance-002/./collection1/data
[junit4] 2> 894432 INFO (coreCloseExecutor-2453-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-002/./collection1/data/index [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_DF93681792975EDE-001/solr-instance-002/./collection1/data/index;done=false>>]
[junit4] 2> 894432 INFO (coreCloseExecutor-2453-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 894432 INFO (coreCloseExecutor-2453-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_DF93681792975EDE-001/solr-instance-002/./collection1/data/index
[junit4] 2> 894432 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@17865ca{/solr,null,UNAVAILABLE}
[junit4] 2> 894433 INFO (qtp32326944-5568) [ x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 894434 INFO (qtp32326944-5568) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{deleteByQuery=*:*} 0 1
[junit4] 2> 894435 INFO (qtp32326944-5569) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 894435 INFO (qtp32326944-5569) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@131d79c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1432685),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@131d79c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1432685),segFN=segments_2,generation=2}
[junit4] 2> 894435 INFO (qtp32326944-5569) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 2
[junit4] 2> 894436 INFO (qtp32326944-5569) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@117cca9[collection1] main]
[junit4] 2> 894436 INFO (qtp32326944-5569) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 894436 INFO (searcherExecutor-2438-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@117cca9[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 894436 INFO (qtp32326944-5569) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 1
[junit4] 2> 894440 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.e.j.s.ServerConnector Stopped ServerConnector@166c878{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 894440 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=24804070
[junit4] 2> 894441 INFO (coreCloseExecutor-2455-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@14c3fd5
[junit4] 2> 894441 INFO (coreCloseExecutor-2455-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0}
[junit4] 2> 894441 INFO (coreCloseExecutor-2455-thread-1) [ x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 894441 INFO (coreCloseExecutor-2455-thread-1) [ x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 894441 INFO (coreCloseExecutor-2455-thread-1) [ x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
[junit4] 2> 894441 INFO (coreCloseExecutor-2455-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
[junit4] 2> 894441 INFO (coreCloseExecutor-2455-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 3 directories currently being tracked
[junit4] 2> 894441 INFO (coreCloseExecutor-2455-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-001/./collection1/data/index [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_DF93681792975EDE-001/solr-instance-001/./collection1/data/index;done=false>>]
[junit4] 2> 894441 INFO (coreCloseExecutor-2455-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 894441 INFO (coreCloseExecutor-2455-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_DF93681792975EDE-001/solr-instance-001/./collection1/data/index
[junit4] 2> 894441 INFO (coreCloseExecutor-2455-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-001/./collection1/data/snapshot_metadata [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_DF93681792975EDE-001/solr-instance-001/./collection1/data/snapshot_metadata;done=false>>]
[junit4] 2> 894441 INFO (coreCloseExecutor-2455-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 894441 INFO (coreCloseExecutor-2455-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_DF93681792975EDE-001/solr-instance-001/./collection1/data/snapshot_metadata
[junit4] 2> 894441 INFO (coreCloseExecutor-2455-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-001/./collection1/data [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_DF93681792975EDE-001/solr-instance-001/./collection1/data;done=false>>]
[junit4] 2> 894442 INFO (coreCloseExecutor-2455-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 894442 INFO (coreCloseExecutor-2455-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_DF93681792975EDE-001/solr-instance-001/./collection1/data
[junit4] 2> 894442 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@6ae4b3{/solr,null,UNAVAILABLE}
[junit4] 2> 894443 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 894444 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1e06848{/solr,null,AVAILABLE}
[junit4] 2> 894444 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.e.j.s.ServerConnector Started ServerConnector@b7a1a1{HTTP/1.1,[http/1.1]}{127.0.0.1:45440}
[junit4] 2> 894444 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.e.j.s.Server Started @896544ms
[junit4] 2> 894444 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_DF93681792975EDE-001/solr-instance-001/collection1/data, hostContext=/solr, hostPort=45440}
[junit4] 2> 894445 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@1d16e93
[junit4] 2> 894445 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] 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_DF93681792975EDE-001/solr-instance-001'
[junit4] 2> 894445 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 894445 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 894445 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] 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_DF93681792975EDE-001/solr-instance-001/solr.xml
[junit4] 2> 894449 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] 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_DF93681792975EDE-001/solr-instance-001/.
[junit4] 2> 894449 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.c.CoreContainer New CoreContainer 18529551
[junit4] 2> 894449 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] 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_DF93681792975EDE-001/solr-instance-001]
[junit4] 2> 894449 WARN (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] 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_DF93681792975EDE-001/solr-instance-001/lib to classpath: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_DF93681792975EDE-001/solr-instance-001/lib
[junit4] 2> 894449 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] 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> 894451 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.u.UpdateShardHandler Created UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&maxConnections=100000&maxConnectionsPerHost=100000
[junit4] 2> 894451 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 894451 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 894451 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 894451 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 894451 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] 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_DF93681792975EDE-001/solr-instance-001/.
[junit4] 2> 894452 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data/}
[junit4] 2> 894452 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] 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_DF93681792975EDE-001/solr-instance-001/./collection1
[junit4] 2> 894452 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
[junit4] 2> 894452 INFO (coreLoadExecutor-2462-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_DF93681792975EDE-001/solr-instance-001/collection1'
[junit4] 2> 894452 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.s.SolrDispatchFilter user.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0
[junit4] 2> 894452 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[DF93681792975EDE]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 894452 INFO (coreLoadExecutor-2462-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 894452 INFO (coreLoadExecutor-2462-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 894456 INFO (coreLoadExecutor-2462-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 894458 INFO (coreLoadExecutor-2462-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 894461 INFO (coreLoadExecutor-2462-thread-1) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 894464 INFO (coreLoadExecutor-2462-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 894465 INFO (coreLoadExecutor-2462-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 894466 INFO (coreLoadExecutor-2462-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_DF93681792975EDE-001/solr-instance-001/collection1'
[junit4] 2> 894466 INFO (coreLoadExecutor-2462-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_DF93681792975EDE-001/solr-instance-001/./collection1
[junit4] 2> 894466 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 894466 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-001/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_DF93681792975EDE-001/solr-instance-001/./collection1/data/]
[junit4] 2> 894466 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
[junit4] 2> 894466 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-001/./collection1/data/snapshot_metadata
[junit4] 2> 894466 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] o.a.s.c.s.SolrSnapshotMetaDataManager Loading from snapshot metadata file...
[junit4] 2> 894467 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-001/./collection1/data
[junit4] 2> 894467 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-001/./collection1/data/index/
[junit4] 2> 894467 WARN (coreLoadExecutor-2462-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-001/./collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 894467 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-001/./collection1/data/index
[junit4] 2> 894467 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=14, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 894467 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1517615 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1492841),segFN=segments_1,generation=1}
[junit4] 2> 894467 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 894468 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x: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_DF93681792975EDE-001/solr-instance-001/./collection1/data/
[junit4] 2> 894468 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 894469 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 894470 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 894471 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 894471 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 894472 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy
[junit4] 2> 894472 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] 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> 894472 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 894472 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 894472 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 894472 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=16, maxMergeAtOnceExplicit=15, maxMergedSegmentMB=25.49609375, floorSegmentMB=2.1806640625, forceMergeDeletesPctAllowed=29.81533062984282, segmentsPerTier=49.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 894472 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1517615 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1492841),segFN=segments_1,generation=1}
[junit4] 2> 894472 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 894472 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@68f29e[collection1] main]
[junit4] 2> 894473 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-001/collection1/conf
[junit4] 2> 894473 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-001/collection1/conf}
[junit4] 2> 894473 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] 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_DF93681792975EDE-001/solr-instance-001/collection1/conf
[junit4] 2> 894473 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 894473 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml
[junit4] 2> 894473 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 894473 INFO (searcherExecutor-2463-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@68f29e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 894473 INFO (coreLoadExecutor-2462-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 894955 INFO (qtp8581994-5606) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[0]} 0 1
[junit4] 2> 894956 INFO (qtp8581994-5607) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[1]} 0 0
[junit4] 2> 894956 INFO (qtp8581994-5608) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[2]} 0 0
[junit4] 2> 894956 INFO (qtp8581994-5601) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[3]} 0 0
[junit4] 2> 894956 INFO (qtp8581994-5606) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[4]} 0 0
[junit4] 2> 894956 INFO (qtp8581994-5607) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[5]} 0 0
[junit4] 2> 894957 INFO (qtp8581994-5608) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[6]} 0 0
[junit4] 2> 894957 INFO (qtp8581994-5601) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[7]} 0 0
[junit4] 2> 894957 INFO (qtp8581994-5606) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[8]} 0 0
[junit4] 2> 894957 INFO (qtp8581994-5607) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[9]} 0 0
[junit4] 2> 894958 INFO (qtp8581994-5608) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[10]} 0 0
[junit4] 2> 894958 INFO (qtp8581994-5601) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[11]} 0 0
[junit4] 2> 894958 INFO (qtp8581994-5606) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[12]} 0 0
[junit4] 2> 894959 INFO (qtp8581994-5607) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[13]} 0 0
[junit4] 2> 894959 INFO (qtp8581994-5608) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[14]} 0 0
[junit4] 2> 894959 INFO (qtp8581994-5601) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[15]} 0 0
[junit4] 2> 894959 INFO (qtp8581994-5606) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[16]} 0 0
[junit4] 2> 894959 INFO (qtp8581994-5607) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[17]} 0 0
[junit4] 2> 894960 INFO (qtp8581994-5608) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[18]} 0 0
[junit4] 2> 894960 INFO (qtp8581994-5601) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[19]} 0 0
[junit4] 2> 894960 INFO (qtp8581994-5606) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[20]} 0 0
[junit4] 2> 894960 INFO (qtp8581994-5607) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[21]} 0 0
[junit4] 2> 894961 INFO (qtp8581994-5608) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[22]} 0 0
[junit4] 2> 894961 INFO (qtp8581994-5601) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[23]} 0 0
[junit4] 2> 894961 INFO (qtp8581994-5606) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[24]} 0 0
[junit4] 2> 894961 INFO (qtp8581994-5607) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[25]} 0 0
[junit4] 2> 894961 INFO (qtp8581994-5608) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[26]} 0 0
[junit4] 2> 894962 INFO (qtp8581994-5601) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[27]} 0 0
[junit4] 2> 894962 INFO (qtp8581994-5606) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[28]} 0 0
[junit4] 2> 894963 INFO (qtp8581994-5607) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[29]} 0 0
[junit4] 2> 894963 INFO (qtp8581994-5608) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[30]} 0 0
[junit4] 2> 894963 INFO (qtp8581994-5601) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[31]} 0 0
[junit4] 2> 894963 INFO (qtp8581994-5606) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[32]} 0 0
[junit4] 2> 894963 INFO (qtp8581994-5607) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[33]} 0 0
[junit4] 2> 894964 INFO (qtp8581994-5608) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[34]} 0 0
[junit4] 2> 894964 INFO (qtp8581994-5601) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[35]} 0 0
[junit4] 2> 894964 INFO (qtp8581994-5606) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[36]} 0 0
[junit4] 2> 894964 INFO (qtp8581994-5607) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[37]} 0 0
[junit4] 2> 894964 INFO (qtp8581994-5608) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[38]} 0 0
[junit4] 2> 894965 INFO (qtp8581994-5601) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[39]} 0 0
[junit4] 2> 894965 INFO (qtp8581994-5606) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[40]} 0 0
[junit4] 2> 894965 INFO (qtp8581994-5607) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[41]} 0 0
[junit4] 2> 894965 INFO (qtp8581994-5608) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[42]} 0 0
[junit4] 2> 894965 INFO (qtp8581994-5601) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[43]} 0 0
[junit4] 2> 894966 INFO (qtp8581994-5606) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[44]} 0 0
[junit4] 2> 894966 INFO (qtp8581994-5607) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[45]} 0 0
[junit4] 2> 894966 INFO (qtp8581994-5608) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[46]} 0 0
[junit4] 2> 894966 INFO (qtp8581994-5601) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[47]} 0 0
[junit4] 2> 894966 INFO (qtp8581994-5606) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[48]} 0 0
[junit4] 2> 894967 INFO (qtp8581994-5607) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[49]} 0 0
[junit4] 2> 894967 INFO (qtp8581994-5608) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[50]} 0 0
[junit4] 2> 894967 INFO (qtp8581994-5601) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[51]} 0 0
[junit4] 2> 894967 INFO (qtp8581994-5606) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[52]} 0 0
[junit4] 2> 894967 INFO (qtp8581994-5607) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[53]} 0 0
[junit4] 2> 894968 INFO (qtp8581994-5608) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[54]} 0 0
[junit4] 2> 894968 INFO (qtp8581994-5601) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[55]} 0 0
[junit4] 2> 894968 INFO (qtp8581994-5606) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[56]} 0 0
[junit4] 2> 894968 INFO (qtp8581994-5607) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[57]} 0 0
[junit4] 2> 894968 INFO (qtp8581994-5608) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[58]} 0 0
[junit4] 2> 894969 INFO (qtp8581994-5601) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[59]} 0 0
[junit4] 2> 894969 INFO (qtp8581994-5606) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[60]} 0 0
[junit4] 2> 894969 INFO (qtp8581994-5607) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[61]} 0 0
[junit4] 2> 894969 INFO (qtp8581994-5608) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[62]} 0 0
[junit4] 2> 894969 INFO (qtp8581994-5601) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[63]} 0 0
[junit4] 2> 894970 INFO (qtp8581994-5606) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[64]} 0 0
[junit4] 2> 894970 INFO (qtp8581994-5607) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[65]} 0 0
[junit4] 2> 894970 INFO (qtp8581994-5608) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[66]} 0 0
[junit4] 2> 894970 INFO (qtp8581994-5601) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[67]} 0 0
[junit4] 2> 894971 INFO (qtp8581994-5606) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[68]} 0 0
[junit4] 2> 894971 INFO (qtp8581994-5607) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[69]} 0 0
[junit4] 2> 894971 INFO (qtp8581994-5608) [
[...truncated too long message...]
Exception: No live SolrServers available to handle this request:[http://127.0.0.1:41203/e_t/c8n_1x3_lf_shard1_replica3]
[junit4] > at __randomizedtesting.SeedInfo.seed([DF93681792975EDE:57C757CD3C6B3326]:0)
[junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.directUpdate(CloudSolrClient.java:760)
[junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1172)
[junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:1061)
[junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:997)
[junit4] > at org.apache.solr.cloud.AbstractFullDistribZkTestBase.sendDocsWithRetry(AbstractFullDistribZkTestBase.java:753)
[junit4] > at org.apache.solr.cloud.AbstractFullDistribZkTestBase.sendDocsWithRetry(AbstractFullDistribZkTestBase.java:741)
[junit4] > at org.apache.solr.cloud.LeaderFailoverAfterPartitionTest.testRf3WithLeaderFailover(LeaderFailoverAfterPartitionTest.java:178)
[junit4] > at org.apache.solr.cloud.LeaderFailoverAfterPartitionTest.test(LeaderFailoverAfterPartitionTest.java:57)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:985)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > Caused by: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:41203/e_t/c8n_1x3_lf_shard1_replica3]
[junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:392)
[junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.lambda$directUpdate$0(CloudSolrClient.java:735)
[junit4] > at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] > at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > ... 1 more
[junit4] > Caused by: org.apache.solr.client.solrj.SolrServerException: Server refused connection at: http://127.0.0.1:41203/e_t/c8n_1x3_lf_shard1_replica3
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:615)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:261)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:250)
[junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:413)
[junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:381)
[junit4] > ... 6 more
[junit4] > Caused by: org.apache.http.conn.HttpHostConnectException: Connect to 127.0.0.1:41203 [/127.0.0.1] failed: Connection refused
[junit4] > at org.apache.http.impl.conn.DefaultHttpClientConnectionOperator.connect(DefaultHttpClientConnectionOperator.java:151)
[junit4] > at org.apache.http.impl.conn.PoolingHttpClientConnectionManager.connect(PoolingHttpClientConnectionManager.java:353)
[junit4] > at org.apache.http.impl.execchain.MainClientExec.establishRoute(MainClientExec.java:380)
[junit4] > at org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:236)
[junit4] > at org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:184)
[junit4] > at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:88)
[junit4] > at org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
[junit4] > at org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:184)
[junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
[junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:513)
[junit4] > ... 10 more
[junit4] > Caused by: java.net.ConnectException: Connection refused
[junit4] > at java.net.PlainSocketImpl.socketConnect(Native Method)
[junit4] > at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:350)
[junit4] > at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206)
[junit4] > at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188)
[junit4] > at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)
[junit4] > at java.net.Socket.connect(Socket.java:589)
[junit4] > at org.apache.http.conn.socket.PlainConnectionSocketFactory.connectSocket(PlainConnectionSocketFactory.java:74)
[junit4] > at org.apache.http.impl.conn.DefaultHttpClientConnectionOperator.connect(DefaultHttpClientConnectionOperator.java:134)
[junit4] > ... 20 more
[junit4] 2> 1591716 INFO (SUITE-LeaderFailoverAfterPartitionTest-seed#[DF93681792975EDE]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderFailoverAfterPartitionTest_DF93681792975EDE-001
[junit4] 2> Aug 19, 2016 7:48:36 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Lucene62, sim=ClassicSimilarity, locale=es-ES, timezone=Asia/Novosibirsk
[junit4] 2> NOTE: Linux 4.4.0-31-generic i386/Oracle Corporation 1.8.0_102 (32-bit)/cpus=12,threads=1,free=101121824,total=309329920
[junit4] 2> NOTE: All tests run in this JVM: [TestFreeTextSuggestions, WrapperMergePolicyFactoryTest, TestSolrDeletionPolicy1, TestFieldCollectionResource, BlockJoinFacetDistribTest, SearchHandlerTest, DocValuesMissingTest, BooleanFieldTest, SmileWriterTest, BasicDistributedZk2Test, LukeRequestHandlerTest, DistributedFacetPivotWhiteBoxTest, HighlighterConfigTest, InfoHandlerTest, TestLocalFSCloudBackupRestore, TestJmxIntegration, TriLevelCompositeIdRoutingTest, RemoteQueryErrorTest, TestRequestStatusCollectionAPI, CursorMarkTest, TermVectorComponentDistributedTest, TestSolrQueryParser, ConfigSetsAPITest, TestXIncludeConfig, TestSolrQueryResponse, TestManagedResource, TestSweetSpotSimilarityFactory, ZkStateReaderTest, TestConfigSetImmutable, TestLegacyFieldCache, SolrCloudExampleTest, TestSort, TestOnReconnectListenerSupport, FullSolrCloudDistribCmdsTest, TestMissingGroups, AddSchemaFieldsUpdateProcessorFactoryTest, TestOrdValues, TestElisionMultitermQuery, TestConfigSetsAPIExclusivity, TestJmxMonitoredMap, TestFieldSortValues, DeleteStatusTest, TestQueryWrapperFilter, SuggesterWFSTTest, DistributedDebugComponentTest, TestSearchPerf, DeleteNodeTest, TestUtils, UpdateParamsTest, TestCSVResponseWriter, ParsingFieldUpdateProcessorsTest, TestFieldCacheReopen, TestGroupingSearch, TestTolerantUpdateProcessorCloud, SampleTest, DistributedSuggestComponentTest, CustomCollectionTest, TestPHPSerializedResponseWriter, BinaryUpdateRequestHandlerTest, HdfsBasicDistributedZkTest, ForceLeaderTest, TestDefaultSearchFieldResource, ClusterStateTest, TestCharFilters, StatelessScriptUpdateProcessorFactoryTest, TestSolrQueryParserDefaultOperatorResource, TestZkChroot, HdfsCollectionsAPIDistributedZkTest, CdcrReplicationHandlerTest, SuggesterTSTTest, CircularListTest, HdfsWriteToMultipleCollectionsTest, TestIndexingPerformance, FieldAnalysisRequestHandlerTest, TestReplicationHandlerBackup, OverseerStatusTest, SliceStateTest, TestDistributedMissingSort, UnloadDistributedZkTest, RuleEngineTest, TestRecovery, TestReversedWildcardFilterFactory, TestExtendedDismaxParser, TestUseDocValuesAsStored2, TestSchemaSimilarityResource, TestFastWriter, HLLSerializationTest, ShowFileRequestHandlerTest, CoreAdminCreateDiscoverTest, HardAutoCommitTest, TestClassicSimilarityFactory, TestAnalyzeInfixSuggestions, PrimitiveFieldTypeTest, TestManagedStopFilterFactory, CoreAdminHandlerTest, TestSha256AuthenticationProvider, ScriptEngineTest, AutoCommitTest, TestCoreDiscovery, XmlUpdateRequestHandlerTest, TestShardHandlerFactory, DirectSolrConnectionTest, DirectUpdateHandlerOptimizeTest, TestRebalanceLeaders, BasicDistributedZkTest, SyncSliceTest, OpenCloseCoreStressTest, OverseerTest, LeaderElectionIntegrationTest, TestRandomFaceting, LeaderElectionTest, ZkCLITest, TestHashPartitioner, TestJoin, TestCoreContainer, SimpleFacetsTest, TestSolr4Spatial, SolrCoreTest, StatsComponentTest, SpellCheckComponentTest, SolrCmdDistributorTest, QueryElevationComponentTest, PeerSyncTest, BadIndexSchemaTest, TestFiltering, TestFunctionQuery, TestLazyCores, DirectUpdateHandlerTest, TestIndexSearcher, HighlighterTest, CurrencyFieldOpenExchangeTest, DistributedQueryElevationComponentTest, SuggesterFSTTest, DocValuesTest, XsltUpdateRequestHandlerTest, DebugComponentTest, TestSurroundQueryParser, TestWriterPerf, TestQueryTypes, TestValueSourceCache, TermVectorComponentTest, IndexSchemaRuntimeFieldTest, RegexBoostProcessorTest, TestCollationField, QueryParsingTest, TestPartialUpdateDeduplication, TestLFUCache, TestSimpleTrackingShardHandler, AsyncMigrateRouteKeyTest, CollectionStateFormat2Test, CollectionsAPIAsyncDistributedZkTest, DistribJoinFromCollectionTest, LeaderFailoverAfterPartitionTest]
[junit4] Completed [460/629 (2!)] on J2 in 65.14s, 1 test, 1 error <<< FAILURES!
[...truncated 53051 lines...]