Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-6.x/13/
1 tests failed. FAILED: org.apache.solr.cloud.UnloadDistributedZkTest.test Error Message: Captured an uncaught exception in thread: Thread[id=6844, name=testExecutor-2576-thread-14, state=RUNNABLE, group=TGRP-UnloadDistributedZkTest] Stack Trace: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=6844, name=testExecutor-2576-thread-14, 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:53746/_z at __randomizedtesting.SeedInfo.seed([750E54F38E26CDD4]: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:53746/_z 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 11446 lines...] [junit4] Suite: org.apache.solr.cloud.UnloadDistributedZkTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/init-core-data-001 [junit4] 2> 846409 INFO (SUITE-UnloadDistributedZkTest-seed#[750E54F38E26CDD4]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /_z/ [junit4] 2> 846412 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 846417 INFO (Thread-3009) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 846417 INFO (Thread-3009) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 846517 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.ZkTestServer start zk server on port:52563 [junit4] 2> 846517 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 846517 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 846520 INFO (zkCallback-839-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5d2c60d6 name:ZooKeeperConnection Watcher:127.0.0.1:52563 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 846520 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 846520 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 846520 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 846522 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 846522 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 846523 INFO (zkCallback-840-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@c2f4c50 name:ZooKeeperConnection Watcher:127.0.0.1:52563/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 846523 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 846523 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 846523 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1 [junit4] 2> 846525 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards [junit4] 2> 846526 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection [junit4] 2> 846527 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards [junit4] 2> 846528 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml [junit4] 2> 846528 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml [junit4] 2> 846530 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml [junit4] 2> 846530 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml [junit4] 2> 846532 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 846532 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 846533 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt [junit4] 2> 846533 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt [junit4] 2> 846535 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt [junit4] 2> 846535 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt [junit4] 2> 846536 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml [junit4] 2> 846536 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml [junit4] 2> 846538 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml [junit4] 2> 846538 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml [junit4] 2> 846539 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json [junit4] 2> 846539 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json [junit4] 2> 846540 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 846540 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 846542 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt [junit4] 2> 846542 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt [junit4] 2> 846543 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt [junit4] 2> 846543 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt [junit4] 2> 846634 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/control-001/cores/collection1 [junit4] 2> 846638 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.e.j.s.Server jetty-9.3.6.v20151106 [junit4] 2> 846639 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6dfe0ed1{/_z,null,AVAILABLE} [junit4] 2> 846642 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.e.j.s.ServerConnector Started ServerConnector@69cb916d{HTTP/1.1,[http/1.1]}{127.0.0.1:41637} [junit4] 2> 846642 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.e.j.s.Server Started @849365ms [junit4] 2> 846642 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/tempDir-001/control/data, hostContext=/_z, hostPort=41637, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/control-001/cores} [junit4] 2> 846643 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4e0e2f2a [junit4] 2> 846643 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/control-001' [junit4] 2> 846643 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 846643 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 846643 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 846644 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 846645 INFO (zkCallback-841-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@52c298d5 name:ZooKeeperConnection Watcher:127.0.0.1:52563/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 846645 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 846645 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 846646 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 846646 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/control-001/solr.xml [junit4] 2> 846651 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/control-001/cores [junit4] 2> 846651 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.CoreContainer New CoreContainer 1398273421 [junit4] 2> 846651 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/control-001] [junit4] 2> 846651 WARN (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/control-001/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/control-001/lib [junit4] 2> 846652 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] 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> 846653 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 846653 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 846653 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 846653 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:52563/solr [junit4] 2> 846653 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 846654 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 846654 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 846655 INFO (zkCallback-844-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@f74d69c name:ZooKeeperConnection Watcher:127.0.0.1:52563 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 846655 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 846655 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 846656 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 846657 INFO (zkCallback-845-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@500f069f name:ZooKeeperConnection Watcher:127.0.0.1:52563/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 846657 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 846658 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue [junit4] 2> 846660 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work [junit4] 2> 846662 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running [junit4] 2> 846663 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed [junit4] 2> 846665 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure [junit4] 2> 846666 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 846668 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 846669 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 846669 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 846670 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 846671 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 846673 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect [junit4] 2> 846674 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election [junit4] 2> 846675 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 846675 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/95558543427960836-127.0.0.1:41637__z-n_0000000000 [junit4] 2> 846675 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:41637__z [junit4] 2> 846675 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader [junit4] 2> 846676 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] o.a.s.c.Overseer Overseer (id=95558543427960836-127.0.0.1:41637__z-n_0000000000) starting [junit4] 2> 846678 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work [junit4] 2> 846682 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=10000 autoReplicaFailoverBadNodeExpiration=60000 [junit4] 2> 846683 INFO (OverseerCollectionConfigSetProcessor-95558543427960836-127.0.0.1:41637__z-n_0000000000) [n:127.0.0.1:41637__z ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer operations [junit4] 2> 846683 INFO (OverseerStateUpdate-95558543427960836-127.0.0.1:41637__z-n_0000000000) [n:127.0.0.1:41637__z ] o.a.s.c.Overseer Starting to work on the main queue [junit4] 2> 846683 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:41637__z [junit4] 2> 846684 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:41637__z [junit4] 2> 846685 INFO (zkCallback-845-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z ] 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> 846685 INFO (OverseerStateUpdate-95558543427960836-127.0.0.1:41637__z-n_0000000000) [n:127.0.0.1:41637__z ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 846690 INFO (zkCallback-845-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (1) [junit4] 2> 846703 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 846703 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 846704 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/control-001/cores [junit4] 2> 846705 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] 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> 846705 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] o.a.s.c.CorePropertiesLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/control-001/cores/collection1 [junit4] 2> 846705 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] o.a.s.c.CorePropertiesLocator Found 1 core definitions [junit4] 2> 846706 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2 [junit4] 2> 846706 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:41637__z ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 846706 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection x:collection1] o.a.s.c.ZkController publishing state=down [junit4] 2> 846706 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property [junit4] 2> 846708 INFO (OverseerStateUpdate-95558543427960836-127.0.0.1:41637__z-n_0000000000) [n:127.0.0.1:41637__z ] 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:41637/_z";, [junit4] 2> "node_name":"127.0.0.1:41637__z", [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> 846708 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection x:collection1] o.a.s.c.ZkController look for our core node name [junit4] 2> 846708 INFO (OverseerStateUpdate-95558543427960836-127.0.0.1:41637__z-n_0000000000) [n:127.0.0.1:41637__z ] 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:41637/_z";, [junit4] 2> "node_name":"127.0.0.1:41637__z", [junit4] 2> "numShards":"1", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} [junit4] 2> 846709 INFO (OverseerStateUpdate-95558543427960836-127.0.0.1:41637__z-n_0000000000) [n:127.0.0.1:41637__z ] o.a.s.c.o.ClusterStateMutator building a new cName: control_collection [junit4] 2> 846709 INFO (OverseerStateUpdate-95558543427960836-127.0.0.1:41637__z-n_0000000000) [n:127.0.0.1:41637__z ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1 [junit4] 2> 846710 INFO (zkCallback-845-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z ] 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> 847709 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection x:collection1] o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1 [junit4] 2> 847709 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection x:collection1] o.a.s.c.ZkController Check for collection zkNode:control_collection [junit4] 2> 847709 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection x:collection1] o.a.s.c.ZkController Collection zkNode exists [junit4] 2> 847709 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection x:collection1] o.a.s.c.c.ZkStateReader Load collection config from: [/collections/control_collection] [junit4] 2> 847710 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection x:collection1] o.a.s.c.c.ZkStateReader path=[/collections/control_collection] [configName]=[conf1] specified config exists in ZooKeeper [junit4] 2> 847710 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection x:collection1] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/control-001/cores/collection1' [junit4] 2> 847710 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection x:collection1] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 847710 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection x:collection1] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 847711 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection x:collection1] o.a.s.c.Config loaded config solrconfig.xml with version 0 [junit4] 2> 847716 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection x:collection1] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 847719 WARN (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead. [junit4] 2> 847720 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.1.0 [junit4] 2> 847729 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection x:collection1] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml [junit4] 2> 847734 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 847837 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 847842 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection x:collection1] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 847843 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection x:collection1] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 847857 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 847859 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 847861 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 847861 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 847862 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z 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-6.x/solr/build/solr-core/test/J2 [junit4] 2> 847863 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection control_collection [junit4] 2> 847863 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 847863 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z 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-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/control-001/cores/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/control-001/cores/collection1/data/] [junit4] 2> 847863 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z 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@7175699 [junit4] 2> 847864 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z 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-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/control-001/cores/collection1/data [junit4] 2> 847864 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z 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-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/control-001/cores/collection1/data/index/ [junit4] 2> 847864 WARN (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z 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-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/control-001/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 847864 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z 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-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/control-001/cores/collection1/data/index [junit4] 2> 847864 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=48, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 847865 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=RawDirectoryWrapper(RAMDirectory@684e5a91 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1e6cc19d),segFN=segments_1,generation=1} [junit4] 2> 847865 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 847877 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "nodistrib" [junit4] 2> 847877 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe" [junit4] 2> 847878 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 847878 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig" [junit4] 2> 847878 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 847878 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z 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> 847878 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z 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> 847878 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z 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> 847878 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z 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> 847878 WARN (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z 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> 847878 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:41637__z 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-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/control-001/cores/collection1/data/ [junit4] 2> 847879 WARN (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.DirectoryFactory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/control-001/cores/collection1/data/ does not point to a valid data directory; skipping clean-up of old index directories. [junit4] 2> 847880 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 847881 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 847881 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 847882 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 847885 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z 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> 847885 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z 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> 847886 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z 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> 847886 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z 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> 847886 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 847886 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 847887 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z 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=3, maxMergedSegmentMB=27.2138671875, floorSegmentMB=1.2861328125, forceMergeDeletesPctAllowed=9.976068962598323, segmentsPerTier=44.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 [junit4] 2> 847887 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=RawDirectoryWrapper(RAMDirectory@684e5a91 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1e6cc19d),segFN=segments_1,generation=1} [junit4] 2> 847887 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 847887 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5d5871b5[collection1] main] [junit4] 2> 847887 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z 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> 847888 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z 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> 847888 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z 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> 847888 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 847888 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {} [junit4] 2> 847888 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z 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> 847889 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z 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> 847889 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z 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> 847889 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 847889 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 847889 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z 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> 847889 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z 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> 847890 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z 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> 847890 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z 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 1528936696390877184 [junit4] 2> 847892 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z 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 1528936696390877184 [junit4] 2> 847892 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1 [junit4] 2> 847892 INFO (searcherExecutor-2498-thread-1-processing-n:127.0.0.1:41637__z x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5d5871b5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 847893 INFO (coreLoadExecutor-2497-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 847897 INFO (coreZkRegister-2491-thread-1-processing-n:127.0.0.1:41637__z x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:41637__z 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:41637/_z collection:control_collection shard:shard1 [junit4] 2> 847899 INFO (coreZkRegister-2491-thread-1-processing-n:127.0.0.1:41637__z x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:41637__z 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> 847901 INFO (coreZkRegister-2491-thread-1-processing-n:127.0.0.1:41637__z x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:41637__z 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/95558543427960836-core_node1-n_0000000000 [junit4] 2> 847902 INFO (coreZkRegister-2491-thread-1-processing-n:127.0.0.1:41637__z x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:41637__z 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> 847903 INFO (coreZkRegister-2491-thread-1-processing-n:127.0.0.1:41637__z x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 847903 INFO (coreZkRegister-2491-thread-1-processing-n:127.0.0.1:41637__z x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:41637__z 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> 847903 INFO (coreZkRegister-2491-thread-1-processing-n:127.0.0.1:41637__z x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:41637/_z/collection1/ [junit4] 2> 847903 INFO (coreZkRegister-2491-thread-1-processing-n:127.0.0.1:41637__z x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 847903 INFO (coreZkRegister-2491-thread-1-processing-n:127.0.0.1:41637__z x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy http://127.0.0.1:41637/_z/collection1/ has no replicas [junit4] 2> 847904 INFO (OverseerStateUpdate-95558543427960836-127.0.0.1:41637__z-n_0000000000) [n:127.0.0.1:41637__z ] 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> 847905 INFO (coreZkRegister-2491-thread-1-processing-n:127.0.0.1:41637__z x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1 [junit4] 2> 847907 INFO (coreZkRegister-2491-thread-1-processing-n:127.0.0.1:41637__z x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:41637__z 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/95558543427960836-core_node1-n_0000000000 [junit4] 2> 847909 INFO (coreZkRegister-2491-thread-1-processing-n:127.0.0.1:41637__z x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:41637__z 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:41637/_z/collection1/ shard1 [junit4] 2> 847909 INFO (OverseerStateUpdate-95558543427960836-127.0.0.1:41637__z-n_0000000000) [n:127.0.0.1:41637__z ] 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:41637/_z";, [junit4] 2> "core":"collection1", [junit4] 2> "state":"active"} current state version: 1 [junit4] 2> 848011 INFO (zkCallback-845-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z ] 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> 848060 INFO (coreZkRegister-2491-thread-1-processing-n:127.0.0.1:41637__z x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController We are http://127.0.0.1:41637/_z/collection1/ and leader is http://127.0.0.1:41637/_z/collection1/ [junit4] 2> 848060 INFO (coreZkRegister-2491-thread-1-processing-n:127.0.0.1:41637__z x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:41637__z 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:41637/_z [junit4] 2> 848060 INFO (coreZkRegister-2491-thread-1-processing-n:127.0.0.1:41637__z x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 848061 INFO (coreZkRegister-2491-thread-1-processing-n:127.0.0.1:41637__z x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:41637__z c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController publishing state=active [junit4] 2> 848061 INFO (coreZkRegister-2491-thread-1-processing-n:127.0.0.1:41637__z x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:41637__z 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> 848062 INFO (OverseerStateUpdate-95558543427960836-127.0.0.1:41637__z-n_0000000000) [n:127.0.0.1:41637__z ] 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:41637/_z";, [junit4] 2> "node_name":"127.0.0.1:41637__z", [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> 848063 INFO (OverseerStateUpdate-95558543427960836-127.0.0.1:41637__z-n_0000000000) [n:127.0.0.1:41637__z ] 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:41637/_z";, [junit4] 2> "node_name":"127.0.0.1:41637__z", [junit4] 2> "numShards":"1", [junit4] 2> "state":"active", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} [junit4] 2> 848165 INFO (zkCallback-845-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z ] 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> 848208 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 848208 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 848209 INFO (zkCallback-847-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@c9cc13c name:ZooKeeperConnection Watcher:127.0.0.1:52563/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 848209 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 848209 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 848209 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 848211 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 848211 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false [junit4] 2> 848211 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Creating collection1 with stateFormat=2 [junit4] 2> 848211 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 848214 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 848215 INFO (zkCallback-848-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7bbd46ed name:ZooKeeperConnection Watcher:127.0.0.1:52563/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 848215 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 848215 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 848217 INFO (OverseerStateUpdate-95558543427960836-127.0.0.1:41637__z-n_0000000000) [n:127.0.0.1:41637__z ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"create", [junit4] 2> "name":"collection1", [junit4] 2> "numShards":"2", [junit4] 2> "stateFormat":"2"} current state version: 3 [junit4] 2> 848217 INFO (OverseerStateUpdate-95558543427960836-127.0.0.1:41637__z-n_0000000000) [n:127.0.0.1:41637__z ] o.a.s.c.o.ClusterStateMutator building a new cName: collection1 [junit4] 2> 848308 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/shard-1-001/cores/collection1 [junit4] 2> 848309 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/shard-1-001 [junit4] 2> 848310 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.e.j.s.Server jetty-9.3.6.v20151106 [junit4] 2> 848311 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7b45db34{/_z,null,AVAILABLE} [junit4] 2> 848312 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.e.j.s.ServerConnector Started ServerConnector@197734b3{HTTP/1.1,[http/1.1]}{127.0.0.1:52056} [junit4] 2> 848312 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.e.j.s.Server Started @851035ms [junit4] 2> 848312 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/tempDir-001/jetty1, solrconfig=solrconfig.xml, hostContext=/_z, hostPort=52056, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/shard-1-001/cores} [junit4] 2> 848312 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4e0e2f2a [junit4] 2> 848312 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/shard-1-001' [junit4] 2> 848312 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 848312 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 848313 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 848314 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 848316 INFO (zkCallback-849-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@44e03dc5 name:ZooKeeperConnection Watcher:127.0.0.1:52563/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 848316 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 848316 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 848317 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 848317 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/shard-1-001/solr.xml [junit4] 2> 848322 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/shard-1-001/cores [junit4] 2> 848322 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.CoreContainer New CoreContainer 1058266066 [junit4] 2> 848322 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/shard-1-001] [junit4] 2> 848322 WARN (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/shard-1-001/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/shard-1-001/lib [junit4] 2> 848322 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] 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> 848323 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 848324 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 848324 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 848324 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:52563/solr [junit4] 2> 848324 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 848324 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 848326 INFO (OverseerStateUpdate-95558543427960836-127.0.0.1:41637__z-n_0000000000) [n:127.0.0.1:41637__z ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/collection1/state.json [junit4] 2> 848331 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 848332 INFO (zkCallback-852-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1b1e1e08 name:ZooKeeperConnection Watcher:127.0.0.1:52563 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 848332 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 848332 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 848334 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:52056__z ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 848334 INFO (zkCallback-853-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5b509fa5 name:ZooKeeperConnection Watcher:127.0.0.1:52563/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 848334 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:52056__z ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 848338 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:52056__z ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 848339 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:52056__z ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 848340 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:52056__z ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 848341 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:52056__z ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/95558543427960841-127.0.0.1:52056__z-n_0000000001 [junit4] 2> 848341 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:52056__z ] o.a.s.c.LeaderElector Watching path /overseer_elect/election/95558543427960836-127.0.0.1:41637__z-n_0000000000 to know if I could be the leader [junit4] 2> 848341 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:52056__z ] o.a.s.c.ZkController Publish node=127.0.0.1:52056__z as DOWN [junit4] 2> 848343 INFO (OverseerStateUpdate-95558543427960836-127.0.0.1:41637__z-n_0000000000) [n:127.0.0.1:41637__z ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"downnode", [junit4] 2> "node_name":"127.0.0.1:52056__z"} current state version: 3 [junit4] 2> 848343 INFO (OverseerStateUpdate-95558543427960836-127.0.0.1:41637__z-n_0000000000) [n:127.0.0.1:41637__z ] o.a.s.c.o.NodeMutator DownNode state invoked for node: 127.0.0.1:52056__z [junit4] 2> 848344 INFO (OverseerStateUpdate-95558543427960836-127.0.0.1:41637__z-n_0000000000) [n:127.0.0.1:41637__z ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/collection1/state.json version: 0 [junit4] 2> 848447 INFO (zkCallback-845-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z ] 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> 848447 INFO (zkCallback-853-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z ] 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> 848447 INFO (zkCallback-847-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> 849343 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:52056__z ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:52056__z [junit4] 2> 849344 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:52056__z ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:52056__z [junit4] 2> 849345 INFO (zkCallback-853-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z ] 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> 849345 INFO (zkCallback-845-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z ] 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> 849345 INFO (zkCallback-847-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> 849345 INFO (zkCallback-847-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 849345 INFO (zkCallback-845-thread-1-processing-n:127.0.0.1:41637__z) [n:127.0.0.1:41637__z ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 849345 INFO (zkCallback-853-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 849354 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:52056__z ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 849357 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:52056__z ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 849358 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:52056__z ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/shard-1-001/cores [junit4] 2> 849359 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:52056__z ] 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> 849359 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:52056__z ] o.a.s.c.CorePropertiesLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/shard-1-001/cores/collection1 [junit4] 2> 849359 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:52056__z ] o.a.s.c.CorePropertiesLocator Found 1 core definitions [junit4] 2> 849360 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:52056__z ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2 [junit4] 2> 849360 INFO (TEST-UnloadDistributedZkTest.test-seed#[750E54F38E26CDD4]) [n:127.0.0.1:52056__z ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 849361 INFO (coreLoadExecutor-2508-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z c:collection1 x:collection1] o.a.s.c.ZkController publishing state=down [junit4] 2> 849361 INFO (coreLoadExecutor-2508-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z c:collection1 x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property [junit4] 2> 849362 INFO (coreLoadExecutor-2508-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z c:collection1 x:collection1] o.a.s.c.ZkController Registering watch for collection collection1 [junit4] 2> 849362 INFO (coreLoadExecutor-2508-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z c:collection1 x:collection1] o.a.s.c.c.ZkStateReader addZkWatch [collection1] [junit4] 2> 849362 INFO (coreLoadExecutor-2508-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z c:collection1 x:collection1] o.a.s.c.c.ZkStateReader Add data for [collection1] ver [1] [junit4] 2> 849362 INFO (OverseerStateUpdate-95558543427960836-127.0.0.1:41637__z-n_0000000000) [n:127.0.0.1:41637__z ] 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:52056/_z";, [junit4] 2> "node_name":"127.0.0.1:52056__z", [junit4] 2> "numShards":"2", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"collection1", [junit4] 2> "operation":"state"} current state version: 4 [junit4] 2> 849362 INFO (coreLoadExecutor-2508-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z c:collection1 x:collection1] o.a.s.c.ZkController look for our core node name [junit4] 2> 849363 INFO (OverseerStateUpdate-95558543427960836-127.0.0.1:41637__z-n_0000000000) [n:127.0.0.1:41637__z ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={ [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:52056/_z";, [junit4] 2> "node_name":"127.0.0.1:52056__z", [junit4] 2> "numShards":"2", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"collection1", [junit4] 2> "operation":"state"} [junit4] 2> 849363 INFO (OverseerStateUpdate-95558543427960836-127.0.0.1:41637__z-n_0000000000) [n:127.0.0.1:41637__z ] o.a.s.c.o.ReplicaMutator Collection already exists with numShards=2 [junit4] 2> 849363 INFO (OverseerStateUpdate-95558543427960836-127.0.0.1:41637__z-n_0000000000) [n:127.0.0.1:41637__z ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard2 [junit4] 2> 849465 INFO (OverseerStateUpdate-95558543427960836-127.0.0.1:41637__z-n_0000000000) [n:127.0.0.1:41637__z ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/collection1/state.json version: 1 [junit4] 2> 849465 INFO (zkCallback-853-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [2]) [junit4] 2> 849465 INFO (zkCallback-853-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z ] o.a.s.c.c.ZkStateReader Updating data for [collection1] from [1] to [2] [junit4] 2> 850363 INFO (coreLoadExecutor-2508-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z c:collection1 x:collection1] o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1 [junit4] 2> 850363 INFO (coreLoadExecutor-2508-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z c:collection1 x:collection1] o.a.s.c.ZkController Check for collection zkNode:collection1 [junit4] 2> 850363 INFO (coreLoadExecutor-2508-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z c:collection1 x:collection1] o.a.s.c.ZkController Collection zkNode exists [junit4] 2> 850363 INFO (coreLoadExecutor-2508-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z c:collection1 x:collection1] o.a.s.c.c.ZkStateReader Load collection config from: [/collections/collection1] [junit4] 2> 850363 INFO (coreLoadExecutor-2508-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z c:collection1 x:collection1] o.a.s.c.c.ZkStateReader path=[/collections/collection1] [configName]=[conf1] specified config exists in ZooKeeper [junit4] 2> 850364 INFO (coreLoadExecutor-2508-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z c:collection1 x:collection1] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.UnloadDistributedZkTest_750E54F38E26CDD4-001/shard-1-001/cores/collection1' [junit4] 2> 850364 INFO (coreLoadExecutor-2508-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z c:collection1 x:collection1] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 850364 INFO (coreLoadExecutor-2508-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z c:collection1 x:collection1] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 850365 INFO (coreLoadExecutor-2508-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z c:collection1 x:collection1] o.a.s.c.Config loaded config solrconfig.xml with version 0 [junit4] 2> 850369 INFO (coreLoadExecutor-2508-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z c:collection1 x:collection1] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 850372 WARN (coreLoadExecutor-2508-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z c:collection1 x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead. [junit4] 2> 850373 INFO (coreLoadExecutor-2508-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z c:collection1 x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.1.0 [junit4] 2> 850382 INFO (coreLoadExecutor-2508-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z c:collection1 x:collection1] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml [junit4] 2> 850387 INFO (coreLoadExecutor-2508-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z c:collection1 x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 850494 INFO (coreLoadExecutor-2508-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z c:collection1 x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 850499 INFO (coreLoadExecutor-2508-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z c:collection1 x:collection1] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 850501 INFO (coreLoadExecutor-2508-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z c:collection1 x:collection1] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 850508 INFO (coreLoadExecutor-2508-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z c:collection1 x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 850510 INFO (coreLoadExecutor-2508-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z c:collection1 x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 850514 INFO (coreLoadExecutor-2508-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z c:collection1 x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 850515 INFO (coreLoadExecutor-2508-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z c:collection1 x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 850516 INFO (coreLoadExecutor-2508-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z c:collection1 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-6.x/solr/build/solr-core/test/J2 [junit4] 2> 850516 INFO (coreLoadExecutor-2508-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z c:collection1 x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection collection1 [junit4] 2> 850517 INFO (coreLoadExecutor-2508-thread-1-processing-n:127.0.0.1:52056__z) [n:127.0.0.1:52056__z c:collection1 [...truncated too long message...] [junit4] > at org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273) [junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140) [junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57) [junit4] > at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261) [junit4] > at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283) [junit4] > at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251) [junit4] > at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197) [junit4] > at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272) [junit4] > at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124) [junit4] > at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685) [junit4] > at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487) [junit4] > at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882) [junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82) [junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107) [junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:482) [junit4] > ... 8 moreThrowable #8: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=6832, name=testExecutor-2576-thread-2, state=RUNNABLE, group=TGRP-UnloadDistributedZkTest] [junit4] > Caused by: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:53746/_z [junit4] > at __randomizedtesting.SeedInfo.seed([750E54F38E26CDD4]:0) [junit4] > at org.apache.solr.cloud.BasicDistributedZkTest.lambda$createCores$3(BasicDistributedZkTest.java:583) [junit4] > at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$6(ExecutorUtil.java:229) [junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] > Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:53746/_z [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:588) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230) [junit4] > at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219) [junit4] > at org.apache.solr.cloud.BasicDistributedZkTest.lambda$createCores$3(BasicDistributedZkTest.java:581) [junit4] > ... 4 more [junit4] > Caused by: java.net.SocketTimeoutException: Read timed out [junit4] > at java.net.SocketInputStream.socketRead0(Native Method) [junit4] > at java.net.SocketInputStream.socketRead(SocketInputStream.java:116) [junit4] > at java.net.SocketInputStream.read(SocketInputStream.java:170) [junit4] > at java.net.SocketInputStream.read(SocketInputStream.java:141) [junit4] > at org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160) [junit4] > at org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84) [junit4] > at org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273) [junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140) [junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57) [junit4] > at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261) [junit4] > at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283) [junit4] > at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251) [junit4] > at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197) [junit4] > at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272) [junit4] > at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124) [junit4] > at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685) [junit4] > at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487) [junit4] > at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882) [junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82) [junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107) [junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:482) [junit4] > ... 8 more [junit4] 2> 982522 INFO (SUITE-UnloadDistributedZkTest-seed#[750E54F38E26CDD4]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> Mar 16, 2016 5:56:33 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s). [junit4] 2> NOTE: test params are: codec=Asserting(Lucene60): {other_tl1=FST50, range_facet_l_dv=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), _version_=FST50, multiDefault=PostingsFormat(name=LuceneFixedGap), a_t=FST50, intDefault=FST50, a_i1=FST50, id=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), range_facet_i_dv=FST50, text=PostingsFormat(name=LuceneVarGapFixedInterval), range_facet_l=FST50, timestamp=FST50}, docValues:{range_facet_l_dv=DocValuesFormat(name=Direct), range_facet_i_dv=DocValuesFormat(name=Asserting), timestamp=DocValuesFormat(name=Asserting)}, maxPointsInLeafNode=1707, maxMBSortInHeap=4.459052596996281, sim=ClassicSimilarity, locale=es-HN, timezone=ACT [junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.8.0_66 (64-bit)/cpus=4,threads=1,free=213686280,total=487063552 [junit4] 2> NOTE: All tests run in this JVM: [TestFieldTypeCollectionResource, CdcrUpdateLogTest, TestIndexingPerformance, DeleteStatusTest, CollectionStateFormat2Test, OverseerTest, NoCacheHeaderTest, BlockJoinFacetRandomTest, SSLMigrationTest, TestPerFieldSimilarity, StatsComponentTest, TestBulkSchemaConcurrent, DistributedQueryComponentCustomSortTest, LukeRequestHandlerTest, TestElisionMultitermQuery, SuggesterWFSTTest, LeaderElectionTest, TestReload, PluginInfoTest, TestSolrDeletionPolicy1, HdfsRestartWhileUpdatingTest, TestFastWriter, TestReloadAndDeleteDocs, ShowFileRequestHandlerTest, TestBlobHandler, SimpleFacetsTest, TestComplexPhraseQParserPlugin, TestIndexSearcher, TestDownShardTolerantSearch, TestRecovery, UpdateParamsTest, TestUtils, TestReloadDeadlock, TestRTimerTree, TestStressRecovery, CloudMLTQParserTest, BinaryUpdateRequestHandlerTest, DirectSolrConnectionTest, ClusterStateTest, TestRawResponseWriter, TestJettySolrRunner, ScriptEngineTest, TestMacros, TestPivotHelperCode, UUIDUpdateProcessorFallbackTest, SecurityConfHandlerTest, ReplicationFactorTest, StressHdfsTest, HdfsNNFailoverTest, HighlighterConfigTest, DocValuesMissingTest, DeleteLastCustomShardedReplicaTest, UnloadDistributedZkTest] [junit4] Completed [132/580 (1!)] on J2 in 136.83s, 1 test, 1 error <<< FAILURES! [...truncated 1518 lines...] BUILD FAILED /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:747: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:684: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:59: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build.xml:233: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/common-build.xml:526: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:1457: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:1014: There were test failures: 580 suites (10 ignored), 2320 tests, 1 error, 32 ignored (16 assumptions) [seed: 750E54F38E26CDD4] Total time: 260 minutes 25 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: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org
