You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2016/05/25 00:57:00 UTC
[JENKINS] Lucene-Solr-NightlyTests-6.x - Build # 72 - Still Failing
Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-6.x/72/
15 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.CollectionsAPIDistributedZkTest
Error Message:
Suite timeout exceeded (>= 7200000 msec).
Stack Trace:
java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
at __randomizedtesting.SeedInfo.seed([C5197636D0A6D4DC]:0)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.CollectionsAPIDistributedZkTest
Error Message:
Captured an uncaught exception in thread: Thread[id=13733, name=zkCallback-2451-thread-2, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=13733, name=zkCallback-2451-thread-2, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Caused by: java.lang.OutOfMemoryError: GC overhead limit exceeded
at __randomizedtesting.SeedInfo.seed([C5197636D0A6D4DC]:0)
at java.lang.ThreadLocal.createMap(ThreadLocal.java:244)
at java.lang.ThreadLocal.set(ThreadLocal.java:205)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:215)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$$Lambda$8/1320144060.run(Unknown Source)
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)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.CollectionsAPIDistributedZkTest
Error Message:
Captured an uncaught exception in thread: Thread[id=11687, name=org.eclipse.jetty.server.session.HashSessionManager@63e5cffcTimer, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=11687, name=org.eclipse.jetty.server.session.HashSessionManager@63e5cffcTimer, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Caused by: java.lang.OutOfMemoryError: GC overhead limit exceeded
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.CollectionsAPIDistributedZkTest
Error Message:
Captured an uncaught exception in thread: Thread[id=11669, name=SessionTracker, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=11669, name=SessionTracker, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Caused by: java.lang.OutOfMemoryError: GC overhead limit exceeded
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.CollectionsAPIDistributedZkTest
Error Message:
Captured an uncaught exception in thread: Thread[id=13806, name=searcherExecutor-6231-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim x:awholynewstresscollection_collection2_2_shard6_replica4 s:shard6 c:awholynewstresscollection_collection2_2 r:core_node20, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=13806, name=searcherExecutor-6231-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim x:awholynewstresscollection_collection2_2_shard6_replica4 s:shard6 c:awholynewstresscollection_collection2_2 r:core_node20, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Caused by: java.lang.OutOfMemoryError: GC overhead limit exceeded
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.CollectionsAPIDistributedZkTest
Error Message:
Captured an uncaught exception in thread: Thread[id=11934, name=OverseerThreadFactory-5113-thread-5, state=RUNNABLE, group=Overseer collection creation process.]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=11934, name=OverseerThreadFactory-5113-thread-5, state=RUNNABLE, group=Overseer collection creation process.]
Caused by: java.lang.OutOfMemoryError: GC overhead limit exceeded
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.CollectionsAPIDistributedZkTest
Error Message:
Captured an uncaught exception in thread: Thread[id=11841, name=OverseerThreadFactory-5113-thread-1, state=RUNNABLE, group=Overseer collection creation process.]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=11841, name=OverseerThreadFactory-5113-thread-1, state=RUNNABLE, group=Overseer collection creation process.]
Caused by: java.lang.OutOfMemoryError: GC overhead limit exceeded
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.CollectionsAPIDistributedZkTest
Error Message:
Captured an uncaught exception in thread: Thread[id=12140, name=collection4, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=12140, name=collection4, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Caused by: java.lang.OutOfMemoryError: GC overhead limit exceeded
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.CollectionsAPIDistributedZkTest
Error Message:
Captured an uncaught exception in thread: Thread[id=12141, name=collection5, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=12141, name=collection5, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Caused by: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:55978/zxy/im, http://127.0.0.1:60704/zxy/im, http://127.0.0.1:37071/zxy/im, http://127.0.0.1:57367/zxy/im, http://127.0.0.1:50382/zxy/im]
at __randomizedtesting.SeedInfo.seed([C5197636D0A6D4DC]:0)
at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:997)
Caused by: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:55978/zxy/im, http://127.0.0.1:60704/zxy/im, http://127.0.0.1:37071/zxy/im, http://127.0.0.1:57367/zxy/im, http://127.0.0.1:50382/zxy/im]
at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:384)
at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1228)
at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:998)
at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:934)
at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1599)
at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1620)
at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:987)
Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:55978/zxy/im: KeeperErrorCode = Session expired for /overseer/collection-queue-work/qnr-
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:590)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:259)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:404)
at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:357)
... 7 more
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.CollectionsAPIDistributedZkTest
Error Message:
Captured an uncaught exception in thread: Thread[id=12138, name=collection2, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=12138, name=collection2, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Caused by: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:55978/zxy/im, http://127.0.0.1:60704/zxy/im, http://127.0.0.1:37071/zxy/im, http://127.0.0.1:57367/zxy/im, http://127.0.0.1:50382/zxy/im]
at __randomizedtesting.SeedInfo.seed([C5197636D0A6D4DC]:0)
at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:997)
Caused by: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:55978/zxy/im, http://127.0.0.1:60704/zxy/im, http://127.0.0.1:37071/zxy/im, http://127.0.0.1:57367/zxy/im, http://127.0.0.1:50382/zxy/im]
at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:384)
at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1228)
at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:998)
at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:934)
at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1599)
at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1620)
at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:987)
Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:55978/zxy/im
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:601)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:259)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:404)
at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:357)
... 7 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:495)
... 11 more
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.CollectionsAPIDistributedZkTest
Error Message:
Captured an uncaught exception in thread: Thread[id=12137, name=collection1, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=12137, name=collection1, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Caused by: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:55978/zxy/im, http://127.0.0.1:60704/zxy/im, http://127.0.0.1:37071/zxy/im, http://127.0.0.1:57367/zxy/im, http://127.0.0.1:50382/zxy/im]
at __randomizedtesting.SeedInfo.seed([C5197636D0A6D4DC]:0)
at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:997)
Caused by: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:55978/zxy/im, http://127.0.0.1:60704/zxy/im, http://127.0.0.1:37071/zxy/im, http://127.0.0.1:57367/zxy/im, http://127.0.0.1:50382/zxy/im]
at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:384)
at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1228)
at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:998)
at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:934)
at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1599)
at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1620)
at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:987)
Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:55978/zxy/im
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:601)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:259)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:404)
at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:357)
... 7 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:495)
... 11 more
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.CollectionsAPIDistributedZkTest
Error Message:
Captured an uncaught exception in thread: Thread[id=12136, name=collection0, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=12136, name=collection0, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Caused by: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:55978/zxy/im, http://127.0.0.1:37071/zxy/im, http://127.0.0.1:57367/zxy/im, http://127.0.0.1:50382/zxy/im]
at __randomizedtesting.SeedInfo.seed([C5197636D0A6D4DC]:0)
at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:997)
Caused by: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:55978/zxy/im, http://127.0.0.1:37071/zxy/im, http://127.0.0.1:57367/zxy/im, http://127.0.0.1:50382/zxy/im]
at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:384)
at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1228)
at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:998)
at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:934)
at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:994)
Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:55978/zxy/im: KeeperErrorCode = Session expired for /overseer/collection-queue-work/qnr-
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:590)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:259)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:404)
at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:357)
... 5 more
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.CollectionsAPIDistributedZkTest
Error Message:
Captured an uncaught exception in thread: Thread[id=12139, name=collection3, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=12139, name=collection3, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Caused by: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:55978/zxy/im, http://127.0.0.1:60704/zxy/im, http://127.0.0.1:37071/zxy/im, http://127.0.0.1:57367/zxy/im]
at __randomizedtesting.SeedInfo.seed([C5197636D0A6D4DC]:0)
at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:997)
Caused by: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:55978/zxy/im, http://127.0.0.1:60704/zxy/im, http://127.0.0.1:37071/zxy/im, http://127.0.0.1:57367/zxy/im]
at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:384)
at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1228)
at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:998)
at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:934)
at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:994)
Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:55978/zxy/im: KeeperErrorCode = Session expired for /overseer/collection-queue-work/qnr-
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:590)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:259)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:404)
at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:357)
... 5 more
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.CollectionsAPIDistributedZkTest
Error Message:
Captured an uncaught exception in thread: Thread[id=11670, name=SyncThread:0, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=11670, name=SyncThread:0, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Caused by: java.lang.SecurityException: java.lang.System#exit(11) calls are not allowed because they terminate the test runner's JVM.
at __randomizedtesting.SeedInfo.seed([C5197636D0A6D4DC]:0)
at org.apache.lucene.util.TestSecurityManager$1.run(TestSecurityManager.java:85)
at org.apache.lucene.util.TestSecurityManager$1.run(TestSecurityManager.java:52)
at java.security.AccessController.doPrivileged(Native Method)
at org.apache.lucene.util.TestSecurityManager.checkExit(TestSecurityManager.java:52)
at java.lang.Runtime.exit(Runtime.java:107)
at java.lang.System.exit(System.java:971)
at org.apache.zookeeper.server.SyncRequestProcessor.run(SyncRequestProcessor.java:185)
FAILED: org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test
Error Message:
Test abandoned because suite timeout was reached.
Stack Trace:
java.lang.Exception: Test abandoned because suite timeout was reached.
at __randomizedtesting.SeedInfo.seed([C5197636D0A6D4DC]:0)
Build Log:
[...truncated 12614 lines...]
[junit4] JVM J1: stdout was not empty, see: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/temp/junit4-J1-20160524_222841_095.sysout
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] java.lang.OutOfMemoryError: GC overhead limit exceeded
[junit4] Dumping heap to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/heapdumps/java_pid29131.hprof ...
[junit4] Heap dump file created [613072084 bytes in 2.851 secs]
[junit4] <<< JVM J1: EOF ----
[junit4] JVM J1: stderr was not empty, see: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/temp/junit4-J1-20160524_222841_095.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] WARN: Unhandled exception in event serialization. -> java.lang.OutOfMemoryError: GC overhead limit exceeded
[junit4] <<< JVM J1: EOF ----
[...truncated 400 lines...]
[junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest
[junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_C5197636D0A6D4DC-001/init-core-data-001
[junit4] 2> 1455777 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[C5197636D0A6D4DC]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
[junit4] 2> 1455778 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[C5197636D0A6D4DC]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /zxy/im
[junit4] 2> 1455779 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1455779 INFO (Thread-3932) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1455779 INFO (Thread-3932) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1455879 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.ZkTestServer start zk server on port:35429
[junit4] 2> 1455879 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1455880 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1455881 INFO (zkCallback-2287-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4b2867b5 name:ZooKeeperConnection Watcher:127.0.0.1:35429 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1455881 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1455882 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1455882 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1455883 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1455883 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1455883 INFO (zkCallback-2288-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1884acd name:ZooKeeperConnection Watcher:127.0.0.1:35429/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1455883 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1455884 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1455884 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1
[junit4] 2> 1455884 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
[junit4] 2> 1455885 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
[junit4] 2> 1455886 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
[junit4] 2> 1455886 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] 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> 1455887 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
[junit4] 2> 1455888 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] 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> 1455888 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
[junit4] 2> 1455889 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] 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> 1455889 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 1455890 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] 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> 1455890 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
[junit4] 2> 1455890 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] 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> 1455890 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
[junit4] 2> 1455891 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] 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> 1455891 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
[junit4] 2> 1455892 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] 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> 1455892 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
[junit4] 2> 1455897 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] 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> 1455897 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
[junit4] 2> 1455898 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] 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> 1455898 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 1455899 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] 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> 1455899 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
[junit4] 2> 1455900 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] 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> 1455900 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
[junit4] 2> 1455960 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] 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.CollectionsAPIDistributedZkTest_C5197636D0A6D4DC-001/control-001/cores/collection1
[junit4] 2> 1455961 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 1455962 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@599b816f{/zxy/im,null,AVAILABLE}
[junit4] 2> 1455962 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.e.j.s.ServerConnector Started ServerConnector@5d42c16e{HTTP/1.1,[http/1.1]}{127.0.0.1:37071}
[junit4] 2> 1455966 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.e.j.s.Server Started @1458184ms
[junit4] 2> 1455966 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] 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.CollectionsAPIDistributedZkTest_C5197636D0A6D4DC-001/tempDir-001/control/data, hostContext=/zxy/im, hostPort=37071, 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.CollectionsAPIDistributedZkTest_C5197636D0A6D4DC-001/control-001/cores}
[junit4] 2> 1455966 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@73d16e93
[junit4] 2> 1455966 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] 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.CollectionsAPIDistributedZkTest_C5197636D0A6D4DC-001/control-001'
[junit4] 2> 1455966 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1455966 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 1455966 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1455966 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1455970 INFO (zkCallback-2289-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@46ccdb93 name:ZooKeeperConnection Watcher:127.0.0.1:35429/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1455970 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1455970 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1455971 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 1455971 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] 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.CollectionsAPIDistributedZkTest_C5197636D0A6D4DC-001/control-001/solr.xml
[junit4] 2> 1455974 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] 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.CollectionsAPIDistributedZkTest_C5197636D0A6D4DC-001/control-001/cores
[junit4] 2> 1455974 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.CoreContainer New CoreContainer 1985972780
[junit4] 2> 1455974 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] 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.CollectionsAPIDistributedZkTest_C5197636D0A6D4DC-001/control-001]
[junit4] 2> 1455974 WARN (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] 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.CollectionsAPIDistributedZkTest_C5197636D0A6D4DC-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.CollectionsAPIDistributedZkTest_C5197636D0A6D4DC-001/control-001/lib
[junit4] 2> 1455974 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] 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> 1455975 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1455975 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1455975 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1455975 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35429/solr
[junit4] 2> 1455975 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 1455975 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1455976 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1455977 INFO (zkCallback-2292-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@16d2a737 name:ZooKeeperConnection Watcher:127.0.0.1:35429 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1455977 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1455978 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1455978 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.ZkController Added new OnReconnect listener org.apache.solr.cloud.ZkController$$Lambda$11/1871527715@16548eda
[junit4] 2> 1455985 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1455985 INFO (zkCallback-2293-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@a9b78f5 name:ZooKeeperConnection Watcher:127.0.0.1:35429/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1455986 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1455986 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
[junit4] 2> 1455987 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
[junit4] 2> 1455989 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
[junit4] 2> 1455990 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
[junit4] 2> 1455990 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
[junit4] 2> 1455991 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1455992 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1455992 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1455993 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1455993 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1455993 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 1455994 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 1455995 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 1455995 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
[junit4] 2> 1455996 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1455996 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/95953248527187972-127.0.0.1:37071_zxy%2Fim-n_0000000000
[junit4] 2> 1455996 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:37071_zxy%2Fim
[junit4] 2> 1455996 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
[junit4] 2> 1455997 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.Overseer Overseer (id=95953248527187972-127.0.0.1:37071_zxy%2Fim-n_0000000000) starting
[junit4] 2> 1455998 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
[junit4] 2> 1456000 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=10000 autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 1456000 INFO (OverseerCollectionConfigSetProcessor-95953248527187972-127.0.0.1:37071_zxy%2Fim-n_0000000000) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer operations
[junit4] 2> 1456000 INFO (OverseerStateUpdate-95953248527187972-127.0.0.1:37071_zxy%2Fim-n_0000000000) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.Overseer Starting to work on the main queue
[junit4] 2> 1456000 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:37071_zxy%2Fim
[junit4] 2> 1456001 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:37071_zxy%2Fim
[junit4] 2> 1456002 INFO (OverseerStateUpdate-95953248527187972-127.0.0.1:37071_zxy%2Fim-n_0000000000) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 1456002 INFO (zkCallback-2293-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim ] 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> 1456003 INFO (zkCallback-2293-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1456026 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 1456026 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 1456026 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] 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.CollectionsAPIDistributedZkTest_C5197636D0A6D4DC-001/control-001/cores
[junit4] 2> 1456027 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] 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> 1456027 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] 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.CollectionsAPIDistributedZkTest_C5197636D0A6D4DC-001/control-001/cores/collection1
[junit4] 2> 1456027 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
[junit4] 2> 1456028 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] 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> 1456028 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 1456028 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection x:collection1] o.a.s.c.ZkController publishing state=down
[junit4] 2> 1456028 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property
[junit4] 2> 1456029 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection x:collection1] o.a.s.c.ZkController Collection control_collection not visible yet, but flagging it so a watch is registered when it becomes visible
[junit4] 2> 1456029 INFO (OverseerStateUpdate-95953248527187972-127.0.0.1:37071_zxy%2Fim-n_0000000000) [n:127.0.0.1:37071_zxy%2Fim ] 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:37071/zxy/im",
[junit4] 2> "node_name":"127.0.0.1:37071_zxy%2Fim",
[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> 1456029 INFO (OverseerStateUpdate-95953248527187972-127.0.0.1:37071_zxy%2Fim-n_0000000000) [n:127.0.0.1:37071_zxy%2Fim ] 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:37071/zxy/im",
[junit4] 2> "node_name":"127.0.0.1:37071_zxy%2Fim",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 1456029 INFO (OverseerStateUpdate-95953248527187972-127.0.0.1:37071_zxy%2Fim-n_0000000000) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.o.ClusterStateMutator building a new cName: control_collection
[junit4] 2> 1456029 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection x:collection1] o.a.s.c.c.ZkStateReader Deleting data for [control_collection]
[junit4] 2> 1456029 INFO (OverseerStateUpdate-95953248527187972-127.0.0.1:37071_zxy%2Fim-n_0000000000) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1
[junit4] 2> 1456030 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection x:collection1] o.a.s.c.ZkController look for our core node name
[junit4] 2> 1456030 INFO (zkCallback-2293-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim ] 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> 1457031 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection x:collection1] o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1
[junit4] 2> 1457031 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection x:collection1] o.a.s.c.ZkController Check for collection zkNode:control_collection
[junit4] 2> 1457032 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection x:collection1] o.a.s.c.ZkController Collection zkNode exists
[junit4] 2> 1457032 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection x:collection1] o.a.s.c.c.ZkStateReader Load collection config from: [/collections/control_collection]
[junit4] 2> 1457032 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection x:collection1] o.a.s.c.c.ZkStateReader path=[/collections/control_collection] [configName]=[conf1] specified config exists in ZooKeeper
[junit4] 2> 1457032 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim 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.CollectionsAPIDistributedZkTest_C5197636D0A6D4DC-001/control-001/cores/collection1'
[junit4] 2> 1457032 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection x:collection1] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1457032 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection x:collection1] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 1457033 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection x:collection1] o.a.s.c.Config loaded config solrconfig.xml with version 0
[junit4] 2> 1457037 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection x:collection1] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 1457040 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.1.0
[junit4] 2> 1457046 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection x:collection1] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1457050 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1457124 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1457128 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection x:collection1] o.a.s.s.IndexSchema default search field in schema is text
[junit4] 2> 1457129 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection x:collection1] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 1457134 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 1457135 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 1457136 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1457136 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1457137 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim 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> 1457137 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection control_collection
[junit4] 2> 1457137 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1457138 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim 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.CollectionsAPIDistributedZkTest_C5197636D0A6D4DC-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.CollectionsAPIDistributedZkTest_C5197636D0A6D4DC-001/control-001/cores/collection1/data/]
[junit4] 2> 1457138 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim 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@615c269b
[junit4] 2> 1457138 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim 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.CollectionsAPIDistributedZkTest_C5197636D0A6D4DC-001/control-001/cores/collection1/data
[junit4] 2> 1457138 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim 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.CollectionsAPIDistributedZkTest_C5197636D0A6D4DC-001/control-001/cores/collection1/data/index/
[junit4] 2> 1457138 WARN (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim 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.CollectionsAPIDistributedZkTest_C5197636D0A6D4DC-001/control-001/cores/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 1457138 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim 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.CollectionsAPIDistributedZkTest_C5197636D0A6D4DC-001/control-001/cores/collection1/data/index
[junit4] 2> 1457138 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim 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=45, maxMergeAtOnceExplicit=27, maxMergedSegmentMB=96.8818359375, floorSegmentMB=1.662109375, forceMergeDeletesPctAllowed=11.680029060221928, segmentsPerTier=2.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8232040723363663
[junit4] 2> 1457139 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@181388cb lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1b9527d0),segFN=segments_1,generation=1}
[junit4] 2> 1457139 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 1457139 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:37071_zxy%2Fim 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.CollectionsAPIDistributedZkTest_C5197636D0A6D4DC-001/control-001/cores/collection1/data/
[junit4] 2> 1457139 WARN (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:37071_zxy%2Fim 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.CollectionsAPIDistributedZkTest_C5197636D0A6D4DC-001/control-001/cores/collection1/data/ does not point to a valid data directory; skipping clean-up of old index directories.
[junit4] 2> 1457141 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "nodistrib"
[junit4] 2> 1457141 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe"
[junit4] 2> 1457141 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 1457141 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 1457141 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 1457141 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim 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> 1457141 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim 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> 1457141 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim 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> 1457141 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim 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> 1457141 WARN (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim 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> 1457142 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1457143 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1457143 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1457144 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1457145 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/dump,/update/csv,/sql,/graph,/admin/segments,/admin/system,/replication,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file
[junit4] 2> 1457145 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim 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> 1457146 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim 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> 1457146 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim 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> 1457146 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1457146 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1457147 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim 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=15, maxMergeAtOnceExplicit=10, maxMergedSegmentMB=2.1435546875, floorSegmentMB=1.7529296875, forceMergeDeletesPctAllowed=10.812299123469678, segmentsPerTier=15.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.44928560798485395
[junit4] 2> 1457147 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@181388cb lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1b9527d0),segFN=segments_1,generation=1}
[junit4] 2> 1457147 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 1457147 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@736ac14[collection1] main]
[junit4] 2> 1457147 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim 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> 1457147 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim 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> 1457147 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim 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> 1457148 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 1457148 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
[junit4] 2> 1457148 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim 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> 1457148 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim 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> 1457148 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim 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> 1457148 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 1457148 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1457148 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim 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> 1457148 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim 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> 1457148 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim 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> 1457148 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim 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 1535251977869459456
[junit4] 2> 1457150 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Took 1.0ms to seed version buckets with highest version 1535251977869459456
[junit4] 2> 1457150 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1
[junit4] 2> 1457151 INFO (searcherExecutor-5116-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@736ac14[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1457151 INFO (coreLoadExecutor-5115-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 1457151 INFO (coreZkRegister-5109-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37071_zxy%2Fim 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:37071/zxy/im collection:control_collection shard:shard1
[junit4] 2> 1457151 INFO (coreZkRegister-5109-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37071_zxy%2Fim 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> 1457153 INFO (coreZkRegister-5109-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37071_zxy%2Fim 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/95953248527187972-core_node1-n_0000000000
[junit4] 2> 1457153 INFO (coreZkRegister-5109-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37071_zxy%2Fim 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> 1457154 INFO (coreZkRegister-5109-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1457154 INFO (coreZkRegister-5109-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37071_zxy%2Fim 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> 1457154 INFO (coreZkRegister-5109-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:37071/zxy/im/collection1/
[junit4] 2> 1457154 INFO (coreZkRegister-5109-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 1457154 INFO (coreZkRegister-5109-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy http://127.0.0.1:37071/zxy/im/collection1/ has no replicas
[junit4] 2> 1457154 INFO (OverseerStateUpdate-95953248527187972-127.0.0.1:37071_zxy%2Fim-n_0000000000) [n:127.0.0.1:37071_zxy%2Fim ] 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> 1457155 INFO (coreZkRegister-5109-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1
[junit4] 2> 1457156 INFO (coreZkRegister-5109-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37071_zxy%2Fim 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/95953248527187972-core_node1-n_0000000000
[junit4] 2> 1457157 INFO (coreZkRegister-5109-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37071_zxy%2Fim 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:37071/zxy/im/collection1/ shard1
[junit4] 2> 1457157 INFO (OverseerStateUpdate-95953248527187972-127.0.0.1:37071_zxy%2Fim-n_0000000000) [n:127.0.0.1:37071_zxy%2Fim ] 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:37071/zxy/im",
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 1
[junit4] 2> 1457259 INFO (zkCallback-2293-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim ] 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> 1457308 INFO (coreZkRegister-5109-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController We are http://127.0.0.1:37071/zxy/im/collection1/ and leader is http://127.0.0.1:37071/zxy/im/collection1/
[junit4] 2> 1457308 INFO (coreZkRegister-5109-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37071_zxy%2Fim 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:37071/zxy/im
[junit4] 2> 1457308 INFO (coreZkRegister-5109-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 1457308 INFO (coreZkRegister-5109-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37071_zxy%2Fim c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController publishing state=active
[junit4] 2> 1457308 INFO (coreZkRegister-5109-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37071_zxy%2Fim 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> 1457309 INFO (OverseerStateUpdate-95953248527187972-127.0.0.1:37071_zxy%2Fim-n_0000000000) [n:127.0.0.1:37071_zxy%2Fim ] 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:37071/zxy/im",
[junit4] 2> "node_name":"127.0.0.1:37071_zxy%2Fim",
[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> 1457309 INFO (OverseerStateUpdate-95953248527187972-127.0.0.1:37071_zxy%2Fim-n_0000000000) [n:127.0.0.1:37071_zxy%2Fim ] 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:37071/zxy/im",
[junit4] 2> "node_name":"127.0.0.1:37071_zxy%2Fim",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 1457410 INFO (zkCallback-2293-thread-1-processing-n:127.0.0.1:37071_zxy%2Fim) [n:127.0.0.1:37071_zxy%2Fim ] 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> 1457529 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1457529 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1457530 INFO (zkCallback-2297-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@480c130f name:ZooKeeperConnection Watcher:127.0.0.1:35429/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1457530 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1457530 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1457530 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1457533 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 1457534 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1457534 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false
[junit4] 2> 1457535 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Creating collection1 with stateFormat=2
[junit4] 2> 1457535 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1457535 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1457535 INFO (zkCallback-2298-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@16bbe47a name:ZooKeeperConnection Watcher:127.0.0.1:35429/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1457536 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1457536 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[C5197636D0A6D4DC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1457537 INFO (OverseerStateUpdate-95953248527187972-127.0.0.1:37071_zxy%2Fim-n_0000000000) [n:127.0.0.1:37071_zxy%2Fim ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"create",
[junit4] 2> "name":"collection1",
[ju
[...truncated too long message...]
g-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-collective-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-event-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-exception-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-journal-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-normalization-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-operational-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-referral-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-schema-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-subtree-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-trigger-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-jdbm-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-jdbm1-2.0.0-M2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-kerberos-codec-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-ldif-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-mavibot-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-protocol-kerberos-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-protocol-ldap-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-protocol-shared-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-xdbm-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/api-all-1.0.0-M20.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/bcprov-jdk15-1.45.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/cglib-nodep-2.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/commons-collections-3.2.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/commons-math3-3.4.1.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/easymock-3.0.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/ehcache-core-2.4.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/hadoop-common-2.6.0-tests.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/hadoop-hdfs-2.6.0-tests.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/hadoop-minikdc-2.6.0.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jackson-annotations-2.5.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jackson-databind-2.5.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jersey-core-1.9.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jersey-server-1.9.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jetty-6.1.26.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jetty-util-6.1.26.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/mina-core-2.0.0-M5.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/mockito-core-1.9.5.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/objenesis-1.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/presto-parser-0.122.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/slice-0.10.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/build/analysis/icu/lucene-analyzers-icu-6.1.0-SNAPSHOT.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/contrib/solr-analysis-extras/classes/java:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/build/queryparser/classes/test:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/contrib/analysis-extras/lib/icu4j-56.1.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-launcher.jar:/x1/jenkins/.ant/lib/ivy-2.3.0.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-antlr.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-regexp.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-resolver.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-commons-net.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jmf.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-oro.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-xalan2.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-commons-logging.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jsch.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-junit4.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-javamail.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jai.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jdepend.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-junit.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-bsf.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-swing.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-netrexx.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-bcel.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-testutil.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-log4j.jar:/x1/jenkins/jenkins-slave/tools/hudson.model.JDK/latest1.8/lib/tools.jar:/x1/jenkins/.ivy2/cache/com.carrotsearch.randomizedtesting/junit4-ant/jars/junit4-ant-2.3.4.jar com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe -eventsfile /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/temp/junit4-J1-20160524_222841_095.events @/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/temp/junit4-J1-20160524_222841_095.suites -stdin
[junit4] ERROR: JVM J1 ended with an exception: Quit event not received from the forked process? This may indicate JVM crash or runner bugs.
[junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4.executeSlave(JUnit4.java:1501)
[junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4.access$000(JUnit4.java:121)
[junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4$2.call(JUnit4.java:955)
[junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4$2.call(JUnit4.java:952)
[junit4] at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
[junit4] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] at java.lang.Thread.run(Thread.java:745)
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-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:531: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:1427: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:984: At least one slave process threw an exception, first: Quit event not received from the forked process? This may indicate JVM crash or runner bugs.
Total time: 305 minutes 10 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