Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-master/957/
3 tests failed. FAILED: org.apache.solr.cloud.UnloadDistributedZkTest.test Error Message: Captured an uncaught exception in thread: Thread[id=14126, name=testExecutor-4324-thread-10, state=RUNNABLE, group=TGRP-UnloadDistributedZkTest] Stack Trace: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=14126, name=testExecutor-4324-thread-10, state=RUNNABLE, group=TGRP-UnloadDistributedZkTest] Caused by: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:43904/iu_n/s at __randomizedtesting.SeedInfo.seed([FBC2105739482AE5]:0) at org.apache.solr.cloud.BasicDistributedZkTest.lambda$createCores$3(BasicDistributedZkTest.java:583) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$6(ExecutorUtil.java:229) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:745) Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:43904/iu_n/s at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:588) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230) at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219) at org.apache.solr.cloud.BasicDistributedZkTest.lambda$createCores$3(BasicDistributedZkTest.java:581) ... 4 more Caused by: java.net.SocketTimeoutException: Read timed out at java.net.SocketInputStream.socketRead0(Native Method) at java.net.SocketInputStream.socketRead(SocketInputStream.java:116) at java.net.SocketInputStream.read(SocketInputStream.java:170) at java.net.SocketInputStream.read(SocketInputStream.java:141) at org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160) at org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84) at org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273) at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140) at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57) at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261) at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283) at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251) at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197) at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272) at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124) at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685) at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487) at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:482) ... 8 more FAILED: org.apache.solr.handler.TestReplicationHandler.doTestStressReplication Error Message: timed out waiting for collection1 startAt time to exceed: Sat Mar 12 10:39:36 GMT+08:00 2016 Stack Trace: java.lang.AssertionError: timed out waiting for collection1 startAt time to exceed: Sat Mar 12 10:39:36 GMT+08:00 2016 at __randomizedtesting.SeedInfo.seed([FBC2105739482AE5:206910913C604356]:0) at org.junit.Assert.fail(Assert.java:93) at org.apache.solr.handler.TestReplicationHandler.watchCoreStartAt(TestReplicationHandler.java:1422) at org.apache.solr.handler.TestReplicationHandler.doTestStressReplication(TestReplicationHandler.java:774) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:497) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java: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) FAILED: org.apache.solr.cloud.hdfs.HdfsUnloadDistributedZkTest.test Error Message: Captured an uncaught exception in thread: Thread[id=135019, name=testExecutor-10880-thread-15, state=RUNNABLE, group=TGRP-HdfsUnloadDistributedZkTest] Stack Trace: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=135019, name=testExecutor-10880-thread-15, state=RUNNABLE, group=TGRP-HdfsUnloadDistributedZkTest] Caused by: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:56703 at __randomizedtesting.SeedInfo.seed([FBC2105739482AE5]:0) at org.apache.solr.cloud.BasicDistributedZkTest.lambda$createCores$3(BasicDistributedZkTest.java:583) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$6(ExecutorUtil.java:229) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:745) Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:56703 at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:588) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230) at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219) at org.apache.solr.cloud.BasicDistributedZkTest.lambda$createCores$3(BasicDistributedZkTest.java:581) ... 4 more Caused by: java.net.SocketTimeoutException: Read timed out at java.net.SocketInputStream.socketRead0(Native Method) at java.net.SocketInputStream.socketRead(SocketInputStream.java:116) at java.net.SocketInputStream.read(SocketInputStream.java:170) at java.net.SocketInputStream.read(SocketInputStream.java:141) at org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160) at org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84) at org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273) at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140) at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57) at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261) at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283) at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251) at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197) at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272) at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124) at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685) at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487) at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:482) ... 8 more Build Log: [...truncated 11668 lines...] [junit4] Suite: org.apache.solr.cloud.UnloadDistributedZkTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/init-core-data-001 [junit4] 2> 1745572 INFO (SUITE-UnloadDistributedZkTest-seed#[FBC2105739482AE5]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /iu_n/s [junit4] 2> 1745578 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 1745584 INFO (Thread-6751) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 1745584 INFO (Thread-6751) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 1745684 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.ZkTestServer start zk server on port:51700 [junit4] 2> 1745684 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1745697 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1745713 INFO (zkCallback-1514-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2a1b27a9 name:ZooKeeperConnection Watcher:127.0.0.1:51700 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1745713 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1745713 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1745713 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 1745717 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1745813 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1745825 INFO (zkCallback-1515-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4f27d35a name:ZooKeeperConnection Watcher:127.0.0.1:51700/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1745825 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1745825 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1745826 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1 [junit4] 2> 1745827 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards [junit4] 2> 1745828 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection [junit4] 2> 1745829 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards [junit4] 2> 1745830 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml [junit4] 2> 1745830 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml [junit4] 2> 1745831 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml [junit4] 2> 1745831 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml [junit4] 2> 1745833 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 1745833 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 1745834 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt [junit4] 2> 1745834 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt [junit4] 2> 1745835 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt [junit4] 2> 1745835 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt [junit4] 2> 1745836 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml [junit4] 2> 1745837 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml [junit4] 2> 1745838 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml [junit4] 2> 1745838 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml [junit4] 2> 1745839 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json [junit4] 2> 1745839 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json [junit4] 2> 1745840 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 1745840 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 1745846 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt [junit4] 2> 1745847 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt [junit4] 2> 1745848 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt [junit4] 2> 1745848 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt [junit4] 2> 1745962 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/control-001/cores/collection1 [junit4] 2> 1745966 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.e.j.s.Server jetty-9.3.6.v20151106 [junit4] 2> 1745977 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@17199e26{/iu_n/s,null,AVAILABLE} [junit4] 2> 1745980 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.e.j.s.ServerConnector Started ServerConnector@4e3353c4{HTTP/1.1,[http/1.1]}{127.0.0.1:39341} [junit4] 2> 1745980 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.e.j.s.Server Started @1749216ms [junit4] 2> 1745980 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/tempDir-001/control/data, hostContext=/iu_n/s, hostPort=39341, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/control-001/cores} [junit4] 2> 1745980 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4e0e2f2a [junit4] 2> 1745980 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/control-001' [junit4] 2> 1745980 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 1745980 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 1745981 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1745989 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1745990 INFO (zkCallback-1516-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4952fd21 name:ZooKeeperConnection Watcher:127.0.0.1:51700/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1745990 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1745990 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1745991 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 1745991 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/control-001/solr.xml [junit4] 2> 1745997 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/control-001/cores [junit4] 2> 1745997 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.CoreContainer New CoreContainer 1435446814 [junit4] 2> 1745997 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/control-001] [junit4] 2> 1745997 WARN (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/control-001/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/control-001/lib [junit4] 2> 1745997 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 1745999 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 1745999 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 1745999 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 1745999 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51700/solr [junit4] 2> 1745999 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 1746000 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1746000 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1746001 INFO (zkCallback-1519-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3536cffe name:ZooKeeperConnection Watcher:127.0.0.1:51700 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1746002 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1746002 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1746005 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1746005 INFO (zkCallback-1520-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@60e0538d name:ZooKeeperConnection Watcher:127.0.0.1:51700/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1746005 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1746007 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue [junit4] 2> 1746011 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work [junit4] 2> 1746016 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running [junit4] 2> 1746017 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed [junit4] 2> 1746019 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure [junit4] 2> 1746020 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 1746022 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 1746023 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 1746024 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 1746025 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 1746026 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 1746027 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect [junit4] 2> 1746028 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election [junit4] 2> 1746038 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 1746038 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/95535084763742212-127.0.0.1:39341_iu_n%2Fs-n_0000000000 [junit4] 2> 1746039 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:39341_iu_n%2Fs [junit4] 2> 1746039 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader [junit4] 2> 1746039 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.Overseer Overseer (id=95535084763742212-127.0.0.1:39341_iu_n%2Fs-n_0000000000) starting [junit4] 2> 1746041 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work [junit4] 2> 1746044 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=10000 autoReplicaFailoverBadNodeExpiration=60000 [junit4] 2> 1746063 INFO (OverseerStateUpdate-95535084763742212-127.0.0.1:39341_iu_n%2Fs-n_0000000000) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.Overseer Starting to work on the main queue [junit4] 2> 1746064 INFO (OverseerStateUpdate-95535084763742212-127.0.0.1:39341_iu_n%2Fs-n_0000000000) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 1746067 INFO (OverseerCollectionConfigSetProcessor-95535084763742212-127.0.0.1:39341_iu_n%2Fs-n_0000000000) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer operations [junit4] 2> 1746081 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:39341_iu_n%2Fs [junit4] 2> 1746082 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:39341_iu_n%2Fs [junit4] 2> 1746083 INFO (zkCallback-1520-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [0]) [junit4] 2> 1746084 INFO (zkCallback-1520-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 1746099 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 1746099 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 1746099 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/control-001/cores [junit4] 2> 1746100 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, collection=control_collection, coreNodeName=, dataDir=data/, shard=} [junit4] 2> 1746100 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.CorePropertiesLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/control-001/cores/collection1 [junit4] 2> 1746100 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.CorePropertiesLocator Found 1 core definitions [junit4] 2> 1746107 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection x:collection1] o.a.s.c.ZkController publishing state=down [junit4] 2> 1746107 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property [junit4] 2> 1746108 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection x:collection1] o.a.s.c.ZkController look for our core node name [junit4] 2> 1746114 INFO (OverseerStateUpdate-95535084763742212-127.0.0.1:39341_iu_n%2Fs-n_0000000000) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:39341/iu_n/s";, [junit4] 2> "node_name":"127.0.0.1:39341_iu_n%2Fs", [junit4] 2> "numShards":"1", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} current state version: 0 [junit4] 2> 1746114 INFO (OverseerStateUpdate-95535084763742212-127.0.0.1:39341_iu_n%2Fs-n_0000000000) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={ [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:39341/iu_n/s";, [junit4] 2> "node_name":"127.0.0.1:39341_iu_n%2Fs", [junit4] 2> "numShards":"1", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} [junit4] 2> 1746115 INFO (OverseerStateUpdate-95535084763742212-127.0.0.1:39341_iu_n%2Fs-n_0000000000) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.o.ClusterStateMutator building a new cName: control_collection [junit4] 2> 1746115 INFO (OverseerStateUpdate-95535084763742212-127.0.0.1:39341_iu_n%2Fs-n_0000000000) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1 [junit4] 2> 1746116 INFO (zkCallback-1520-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [1]) [junit4] 2> 1746126 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2 [junit4] 2> 1746126 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 1747109 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection x:collection1] o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1 [junit4] 2> 1747109 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection x:collection1] o.a.s.c.ZkController Check for collection zkNode:control_collection [junit4] 2> 1747109 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection x:collection1] o.a.s.c.ZkController Collection zkNode exists [junit4] 2> 1747109 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection x:collection1] o.a.s.c.c.ZkStateReader Load collection config from: [/collections/control_collection] [junit4] 2> 1747110 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection x:collection1] o.a.s.c.c.ZkStateReader path=[/collections/control_collection] [configName]=[conf1] specified config exists in ZooKeeper [junit4] 2> 1747110 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection x:collection1] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/control-001/cores/collection1' [junit4] 2> 1747110 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection x:collection1] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 1747110 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection x:collection1] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 1747111 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection x:collection1] o.a.s.c.Config loaded config solrconfig.xml with version 0 [junit4] 2> 1747116 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection x:collection1] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 1747119 WARN (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead. [junit4] 2> 1747120 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 1747129 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection x:collection1] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml [junit4] 2> 1747150 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1747364 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 1747370 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection x:collection1] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 1747371 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection x:collection1] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 1747387 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 1747390 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 1747394 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1747395 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1747396 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection x:collection1] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/configs/conf1', cwd=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2 [junit4] 2> 1747396 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection control_collection [junit4] 2> 1747396 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 1747397 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/control-001/cores/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/control-001/cores/collection1/data/] [junit4] 2> 1747397 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@5bb6a6ce [junit4] 2> 1747397 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/control-001/cores/collection1/data [junit4] 2> 1747397 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/control-001/cores/collection1/data/index/ [junit4] 2> 1747398 WARN (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/control-001/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 1747398 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/control-001/cores/collection1/data/index [junit4] 2> 1747398 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=3, maxMergeAtOnceExplicit=7, maxMergedSegmentMB=25.8427734375, floorSegmentMB=0.3271484375, forceMergeDeletesPctAllowed=20.02421040095236, segmentsPerTier=17.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 [junit4] 2> 1747402 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@13321b7a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@48d67e3a),segFN=segments_1,generation=1} [junit4] 2> 1747402 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 1747402 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/control-001/cores/collection1/data/ [junit4] 2> 1747403 WARN (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.DirectoryFactory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/control-001/cores/collection1/data/ does not point to a valid data directory; skipping clean-up of old index directories. [junit4] 2> 1747406 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "nodistrib" [junit4] 2> 1747406 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe" [junit4] 2> 1747406 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 1747406 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig" [junit4] 2> 1747406 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 1747406 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 1747407 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 1747407 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 1747407 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 1747407 WARN (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,args = {defaults={a=A,b=B}}} [junit4] 2> 1747409 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1747410 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1747411 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1747412 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1747415 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,/dump,/update/csv,/sql,/update/json/docs,/admin/luke,/export,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/stream,/schema,/admin/plugins,/admin/logging,/update/json,/admin/ping,/admin/threads,/update,/admin/file [junit4] 2> 1747415 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 1747416 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 1747416 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 1747418 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1747418 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1747418 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@16c1d3f0 [junit4] 2> 1747419 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@13321b7a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@48d67e3a),segFN=segments_1,generation=1} [junit4] 2> 1747419 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 1747419 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@880e4c1[collection1] main] [junit4] 2> 1747419 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.ZkStateReader Load collection config from: [/collections/control_collection] [junit4] 2> 1747420 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.ZkStateReader path=[/collections/control_collection] [configName]=[conf1] specified config exists in ZooKeeper [junit4] 2> 1747420 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1 [junit4] 2> 1747420 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 1747421 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {} [junit4] 2> 1747421 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 1747421 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage No data found for znode /configs/conf1/_rest_managed.json [junit4] 2> 1747421 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 1747421 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 1747421 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 1747422 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets [junit4] 2> 1747422 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version buckets from index [junit4] 2> 1747422 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket highest value from index [junit4] 2> 1747422 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1528561358137720832 [junit4] 2> 1747425 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Took 2.0ms to seed version buckets with highest version 1528561358137720832 [junit4] 2> 1747425 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1 [junit4] 2> 1747425 INFO (searcherExecutor-4247-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@880e4c1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1747426 INFO (coreLoadExecutor-4246-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 1747426 INFO (coreZkRegister-4240-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController Register replica - core:collection1 address:http://127.0.0.1:39341/iu_n/s collection:control_collection shard:shard1 [junit4] 2> 1747427 INFO (coreZkRegister-4240-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leader_elect/shard1/election [junit4] 2> 1747433 INFO (coreZkRegister-4240-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.LeaderElector Joined leadership election with path: /collections/control_collection/leader_elect/shard1/election/95535084763742212-core_node1-n_0000000000 [junit4] 2> 1747434 INFO (coreZkRegister-4240-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Running the leader process for shard=shard1 and weAreReplacement=false and leaderVoteWait=180000 [junit4] 2> 1747437 INFO (coreZkRegister-4240-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 1747437 INFO (coreZkRegister-4240-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 1747437 INFO (coreZkRegister-4240-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:39341/iu_n/s/collection1/ [junit4] 2> 1747437 INFO (coreZkRegister-4240-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 1747437 INFO (OverseerStateUpdate-95535084763742212-127.0.0.1:39341_iu_n%2Fs-n_0000000000) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"leader", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection"} current state version: 1 [junit4] 2> 1747437 INFO (coreZkRegister-4240-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy http://127.0.0.1:39341/iu_n/s/collection1/ has no replicas [junit4] 2> 1747438 INFO (coreZkRegister-4240-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1 [junit4] 2> 1747442 INFO (coreZkRegister-4240-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/control_collection/leaders/shard1/leader after winning as /collections/control_collection/leader_elect/shard1/election/95535084763742212-core_node1-n_0000000000 [junit4] 2> 1747448 INFO (coreZkRegister-4240-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:39341/iu_n/s/collection1/ shard1 [junit4] 2> 1747448 INFO (OverseerStateUpdate-95535084763742212-127.0.0.1:39341_iu_n%2Fs-n_0000000000) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"leader", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "base_url":"http://127.0.0.1:39341/iu_n/s";, [junit4] 2> "core":"collection1", [junit4] 2> "state":"active"} current state version: 1 [junit4] 2> 1747553 INFO (zkCallback-1520-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [1]) [junit4] 2> 1747599 INFO (coreZkRegister-4240-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController We are http://127.0.0.1:39341/iu_n/s/collection1/ and leader is http://127.0.0.1:39341/iu_n/s/collection1/ [junit4] 2> 1747599 INFO (coreZkRegister-4240-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:39341/iu_n/s [junit4] 2> 1747599 INFO (coreZkRegister-4240-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 1747599 INFO (coreZkRegister-4240-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController publishing state=active [junit4] 2> 1747599 INFO (coreZkRegister-4240-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39341_iu_n%2Fs c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property [junit4] 2> 1747602 INFO (OverseerStateUpdate-95535084763742212-127.0.0.1:39341_iu_n%2Fs-n_0000000000) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "core":"collection1", [junit4] 2> "core_node_name":"core_node1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:39341/iu_n/s";, [junit4] 2> "node_name":"127.0.0.1:39341_iu_n%2Fs", [junit4] 2> "numShards":"1", [junit4] 2> "state":"active", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} current state version: 2 [junit4] 2> 1747602 INFO (OverseerStateUpdate-95535084763742212-127.0.0.1:39341_iu_n%2Fs-n_0000000000) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={ [junit4] 2> "core":"collection1", [junit4] 2> "core_node_name":"core_node1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:39341/iu_n/s";, [junit4] 2> "node_name":"127.0.0.1:39341_iu_n%2Fs", [junit4] 2> "numShards":"1", [junit4] 2> "state":"active", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} [junit4] 2> 1747627 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1747641 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1747655 INFO (zkCallback-1522-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7af4cfad name:ZooKeeperConnection Watcher:127.0.0.1:51700/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1747655 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1747655 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1747655 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 1747658 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 1747658 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false [junit4] 2> 1747704 INFO (zkCallback-1522-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [1]) [junit4] 2> 1747704 INFO (zkCallback-1520-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [1]) [junit4] 2> 1747760 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/shard-1-001/cores/collection1 [junit4] 2> 1747760 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/shard-1-001 [junit4] 2> 1747777 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.e.j.s.Server jetty-9.3.6.v20151106 [junit4] 2> 1747853 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@403c7a0a{/iu_n/s,null,AVAILABLE} [junit4] 2> 1747853 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.e.j.s.ServerConnector Started ServerConnector@8ad62{HTTP/1.1,[http/1.1]}{127.0.0.1:55589} [junit4] 2> 1747853 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.e.j.s.Server Started @1751090ms [junit4] 2> 1747853 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/tempDir-001/jetty1, solrconfig=solrconfig.xml, hostContext=/iu_n/s, hostPort=55589, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/shard-1-001/cores} [junit4] 2> 1747853 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4e0e2f2a [junit4] 2> 1747853 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/shard-1-001' [junit4] 2> 1747854 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 1747854 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 1747854 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1747876 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1747888 INFO (zkCallback-1523-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4498c717 name:ZooKeeperConnection Watcher:127.0.0.1:51700/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1747888 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1747888 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1747889 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 1747889 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/shard-1-001/solr.xml [junit4] 2> 1747894 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/shard-1-001/cores [junit4] 2> 1747894 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.CoreContainer New CoreContainer 876954018 [junit4] 2> 1747894 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/shard-1-001] [junit4] 2> 1747895 WARN (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/shard-1-001/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/shard-1-001/lib [junit4] 2> 1747895 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 1747896 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 1747896 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 1747896 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 1747896 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51700/solr [junit4] 2> 1747896 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 1747897 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1747905 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1747937 INFO (zkCallback-1526-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5295b3de name:ZooKeeperConnection Watcher:127.0.0.1:51700 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1747938 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1747938 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1747969 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:55589_iu_n%2Fs ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1747978 INFO (zkCallback-1527-thread-1-processing-n:127.0.0.1:55589_iu_n%2Fs) [n:127.0.0.1:55589_iu_n%2Fs ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@d6a0146 name:ZooKeeperConnection Watcher:127.0.0.1:51700/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1747978 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:55589_iu_n%2Fs ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1747982 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:55589_iu_n%2Fs ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 1747983 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:55589_iu_n%2Fs ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 1747984 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:55589_iu_n%2Fs ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 1747984 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:55589_iu_n%2Fs ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/95535084763742216-127.0.0.1:55589_iu_n%2Fs-n_0000000001 [junit4] 2> 1747985 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:55589_iu_n%2Fs ] o.a.s.c.LeaderElector Watching path /overseer_elect/election/95535084763742212-127.0.0.1:39341_iu_n%2Fs-n_0000000000 to know if I could be the leader [junit4] 2> 1747985 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:55589_iu_n%2Fs ] o.a.s.c.ZkController Publish node=127.0.0.1:55589_iu_n%2Fs as DOWN [junit4] 2> 1747986 INFO (OverseerStateUpdate-95535084763742212-127.0.0.1:39341_iu_n%2Fs-n_0000000000) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"downnode", [junit4] 2> "node_name":"127.0.0.1:55589_iu_n%2Fs"} current state version: 3 [junit4] 2> 1747986 INFO (OverseerStateUpdate-95535084763742212-127.0.0.1:39341_iu_n%2Fs-n_0000000000) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.o.NodeMutator DownNode state invoked for node: 127.0.0.1:55589_iu_n%2Fs [junit4] 2> 1748088 INFO (zkCallback-1522-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [1]) [junit4] 2> 1748088 INFO (zkCallback-1527-thread-1-processing-n:127.0.0.1:55589_iu_n%2Fs) [n:127.0.0.1:55589_iu_n%2Fs ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [1]) [junit4] 2> 1748089 INFO (zkCallback-1520-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [1]) [junit4] 2> 1748988 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:55589_iu_n%2Fs ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:55589_iu_n%2Fs [junit4] 2> 1748988 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:55589_iu_n%2Fs ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:55589_iu_n%2Fs [junit4] 2> 1748990 INFO (zkCallback-1520-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [1]) [junit4] 2> 1748990 INFO (zkCallback-1527-thread-1-processing-n:127.0.0.1:55589_iu_n%2Fs) [n:127.0.0.1:55589_iu_n%2Fs ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [1]) [junit4] 2> 1748990 INFO (zkCallback-1522-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [1]) [junit4] 2> 1748992 INFO (zkCallback-1522-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 1748992 INFO (zkCallback-1520-thread-1-processing-n:127.0.0.1:39341_iu_n%2Fs) [n:127.0.0.1:39341_iu_n%2Fs ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 1748992 INFO (zkCallback-1527-thread-1-processing-n:127.0.0.1:55589_iu_n%2Fs) [n:127.0.0.1:55589_iu_n%2Fs ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 1749004 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:55589_iu_n%2Fs ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 1749004 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:55589_iu_n%2Fs ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 1749004 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:55589_iu_n%2Fs ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/shard-1-001/cores [junit4] 2> 1749006 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:55589_iu_n%2Fs ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, collection=collection1, coreNodeName=, dataDir=data/, shard=} [junit4] 2> 1749006 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:55589_iu_n%2Fs ] o.a.s.c.CorePropertiesLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_FBC2105739482AE5-001/shard-1-001/cores/collection1 [junit4] 2> 1749006 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:55589_iu_n%2Fs ] o.a.s.c.CorePropertiesLocator Found 1 core definitions [junit4] 2> 1749007 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:55589_iu_n%2Fs ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2 [junit4] 2> 1749007 INFO (TEST-UnloadDistributedZkTest.test-seed#[FBC2105739482AE5]) [n:127.0.0.1:55589_iu_n%2Fs ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 1749007 INFO (coreLoadExecutor-4257-thread-1-processing-n:127.0.0.1:55589_iu_ [...truncated too long message...] ns/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/apacheds-interceptors-event-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/apacheds-interceptors-exception-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/apacheds-interceptors-journal-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/apacheds-interceptors-normalization-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/apacheds-interceptors-operational-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/apacheds-interceptors-referral-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/apacheds-interceptors-schema-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/apacheds-interceptors-subtree-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/apacheds-interceptors-trigger-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/apacheds-jdbm-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/apacheds-jdbm1-2.0.0-M2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/apacheds-kerberos-codec-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/apacheds-ldif-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/apacheds-mavibot-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/apacheds-protocol-kerberos-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/apacheds-protocol-ldap-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/apacheds-protocol-shared-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/apacheds-xdbm-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/api-all-1.0.0-M20.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/bcprov-jdk15-1.45.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/cglib-nodep-2.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/commons-collections-3.2.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/commons-math3-3.4.1.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/easymock-3.0.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/ehcache-core-2.4.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/hadoop-common-2.6.0-tests.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/hadoop-hdfs-2.6.0-tests.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/hadoop-minikdc-2.6.0.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/jackson-annotations-2.5.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/jackson-databind-2.5.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/jersey-core-1.9.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/jersey-server-1.9.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/jetty-6.1.26.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/jetty-util-6.1.26.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/mina-core-2.0.0-M5.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/mockito-core-1.9.5.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/objenesis-1.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/presto-parser-0.122.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/test-lib/slice-0.10.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/lucene/build/analysis/icu/lucene-analyzers-icu-7.0.0-SNAPSHOT.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/contrib/solr-analysis-extras/classes/java:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/lucene/build/queryparser/classes/test:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/contrib/analysis-extras/lib/icu4j-56.1.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-launcher.jar:/x1/jenkins/.ant/lib/ivy-2.3.0.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-antlr.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-regexp.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-resolver.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-commons-net.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jmf.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-oro.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-xalan2.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-commons-logging.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jsch.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-junit4.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-javamail.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jai.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jdepend.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-junit.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-bsf.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-swing.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-netrexx.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-bcel.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-testutil.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-log4j.jar:/x1/jenkins/jenkins-slave/tools/hudson.model.JDK/latest1.8/lib/tools.jar:/x1/jenkins/.ivy2/cache/com.carrotsearch.randomizedtesting/junit4-ant/jars/junit4-ant-2.3.2.jar com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe -eventsfile /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/temp/junit4-J1-20160312_015917_588.events @/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/temp/junit4-J1-20160312_015917_588.suites -stdin [junit4] ERROR: JVM J1 ended with an exception: Quit event not received from the forked process? This may indicate JVM crash or runner bugs. [junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4.executeSlave(JUnit4.java:1501) [junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4.access$000(JUnit4.java:121) [junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4$2.call(JUnit4.java:955) [junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4$2.call(JUnit4.java:952) [junit4] at java.util.concurrent.FutureTask.run(FutureTask.java:266) [junit4] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [junit4] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [junit4] at java.lang.Thread.run(Thread.java:745) BUILD FAILED /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/build.xml:747: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/build.xml:684: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/build.xml:59: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build.xml:233: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/common-build.xml:524: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/lucene/common-build.xml:1457: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/lucene/common-build.xml:1014: At least one slave process threw an exception, first: Quit event not received from the forked process? This may indicate JVM crash or runner bugs. Total time: 219 minutes 50 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts No prior successful build to compare, so performing full copy of artifacts Recording test results Email was triggered for: Failure - Any Sending email for trigger: Failure - Any
--------------------------------------------------------------------- To unsubscribe, e-mail: [email protected] For additional commands, e-mail: [email protected]
