Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-trunk/772/
4 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.search.TestReloadDeadlock
Error Message:
Suite timeout exceeded (>= 300000 msec).
Stack Trace:
java.lang.Exception: Suite timeout exceeded (>= 300000 msec).
at __randomizedtesting.SeedInfo.seed([7636EEA5640CABE3]:0)
FAILED: org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test
Error Message:
Captured an uncaught exception in thread: Thread[id=11405, name=collection0,
state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught
exception in thread: Thread[id=11405, name=collection0, state=RUNNABLE,
group=TGRP-CollectionsAPIDistributedZkTest]
Caused by:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error
from server at http://127.0.0.1:35050: Could not find collection :
awholynewstresscollection_collection0_5
at __randomizedtesting.SeedInfo.seed([7636EEA5640CABE3]:0)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:560)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:234)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:226)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1086)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:857)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:800)
at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:895)
FAILED: org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.test
Error Message:
Captured an uncaught exception in thread: Thread[id=74537, name=collection5,
state=RUNNABLE, group=TGRP-HdfsCollectionsAPIDistributedZkTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught
exception in thread: Thread[id=74537, name=collection5, state=RUNNABLE,
group=TGRP-HdfsCollectionsAPIDistributedZkTest]
Caused by:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error
from server at http://127.0.0.1:59781/_x/nu: Could not find collection :
awholynewstresscollection_collection5_0
at __randomizedtesting.SeedInfo.seed([7636EEA5640CABE3]:0)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:560)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:234)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:226)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1086)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:857)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:800)
at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:895)
FAILED: org.apache.solr.search.TestReloadDeadlock.testReloadDeadlock
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([7636EEA5640CABE3]:0)
Build Log:
[...truncated 10261 lines...]
[junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/init-core-data-001
[junit4] 2> 1141977 INFO
(SUITE-CollectionsAPIDistributedZkTest-seed#[7636EEA5640CABE3]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true)
[junit4] 2> 1141977 INFO
(SUITE-CollectionsAPIDistributedZkTest-seed#[7636EEA5640CABE3]-worker) [ ]
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
[junit4] 2> 1141982 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1141983 INFO (Thread-7278) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1141983 INFO (Thread-7278) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 1142083 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.ZkTestServer start zk server on port:50634
[junit4] 2> 1142083 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1142084 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1142086 INFO (zkCallback-711-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@5143c77e
name:ZooKeeperConnection Watcher:127.0.0.1:50634 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1142086 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1142086 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1142086 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1142089 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1142089 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1142090 INFO (zkCallback-712-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@7ea477c0
name:ZooKeeperConnection Watcher:127.0.0.1:50634/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1142090 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1142090 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1142090 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/collection1
[junit4] 2> 1142092 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
[junit4] 2> 1142093 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
[junit4] 2> 1142094 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
[junit4] 2> 1142095 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 1142096 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
[junit4] 2> 1142098 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 1142098 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
[junit4] 2> 1142100 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 1142100 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.SolrZkClient makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 1142101 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 1142102 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
[junit4] 2> 1142103 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 1142103 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
[junit4] 2> 1142105 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 1142105 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
[junit4] 2> 1142106 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 1142107 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
[junit4] 2> 1142108 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 1142108 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
[junit4] 2> 1142110 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 1142110 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 1142111 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 1142112 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
[junit4] 2> 1142113 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 1142113 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
[junit4] 2> 1142440 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/control-001/cores/collection1
[junit4] 2> 1142442 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.e.j.s.Server jetty-9.2.13.v20150730
[junit4] 2> 1142443 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@377cf582{/,null,AVAILABLE}
[junit4] 2> 1142450 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@5a18d40e{HTTP/1.1}{127.0.0.1:35050}
[junit4] 2> 1142450 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.e.j.s.Server Started @1145700ms
[junit4] 2> 1142450 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/tempDir-001/control/data,
hostContext=/, hostPort=35050,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/control-001/cores}
[junit4] 2> 1142451 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@4e0e2f2a
[junit4] 2> 1142451 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/control-001/'
[junit4] 2> 1142467 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1142467 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1142468 INFO (zkCallback-713-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@2afa0f1a
name:ZooKeeperConnection Watcher:127.0.0.1:50634/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1142469 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1142469 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1142470 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 1142470 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/control-001/solr.xml
[junit4] 2> 1142475 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.CoresLocator Config-defined core root directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/control-001/cores
[junit4] 2> 1142475 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.CoreContainer New CoreContainer 171040098
[junit4] 2> 1142475 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/control-001/]
[junit4] 2> 1142475 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.CoreContainer loading shared library:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/control-001/lib
[junit4] 2> 1142475 WARN
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to
classloader: lib (resolved as:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/control-001/lib).
[junit4] 2> 1142482 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
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> 1142484 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1142484 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1142484 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.l.LogWatcher Registering Log Listener [Log4j
(org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1142484 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:50634/solr
[junit4] 2> 1142485 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 1142485 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1142485 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1142486 INFO (zkCallback-715-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@321faa5b
name:ZooKeeperConnection Watcher:127.0.0.1:50634 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1142487 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1142487 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1142492 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:35050_ ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 1142493 INFO
(zkCallback-716-thread-1-processing-n:127.0.0.1:35050_) [n:127.0.0.1:35050_
] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@48e5bfe1
name:ZooKeeperConnection Watcher:127.0.0.1:50634/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1142493 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:35050_ ] o.a.s.c.c.ConnectionManager Client is connected to
ZooKeeper
[junit4] 2> 1142494 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:35050_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
[junit4] 2> 1142496 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:35050_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-queue-work
[junit4] 2> 1142498 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:35050_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-running
[junit4] 2> 1142500 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:35050_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-completed
[junit4] 2> 1142501 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:35050_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-failure
[junit4] 2> 1142503 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:35050_ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1142505 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:35050_ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1142506 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:35050_ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1142507 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:35050_ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1142508 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:35050_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:35050_
[junit4] 2> 1142508 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:35050_ ] o.a.s.c.c.SolrZkClient makePath:
/live_nodes/127.0.0.1:35050_
[junit4] 2> 1142510 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:35050_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 1142511 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:35050_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect/election
[junit4] 2> 1142512 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:35050_ ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1142513 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:35050_ ] o.a.s.c.LeaderElector Joined leadership election with
path: /overseer_elect/election/94388519457521668-127.0.0.1:35050_-n_0000000000
[junit4] 2> 1142513 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:35050_ ] o.a.s.c.OverseerElectionContext I am going to be the
leader 127.0.0.1:35050_
[junit4] 2> 1142513 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:35050_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
[junit4] 2> 1142514 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:35050_ ] o.a.s.c.Overseer Overseer
(id=94388519457521668-127.0.0.1:35050_-n_0000000000) starting
[junit4] 2> 1142516 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:35050_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
[junit4] 2> 1142523 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:35050_ ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=10000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 1142523 INFO
(OverseerCollectionProcessor-94388519457521668-127.0.0.1:35050_-n_0000000000)
[n:127.0.0.1:35050_ ] o.a.s.c.OverseerProcessor Process current queue of
overseer operations
[junit4] 2> 1142523 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:35050_ ] o.a.s.c.c.ZkStateReader Updating cluster state from
ZooKeeper...
[junit4] 2> 1142524 INFO
(OverseerStateUpdate-94388519457521668-127.0.0.1:35050_-n_0000000000)
[n:127.0.0.1:35050_ ] o.a.s.c.Overseer Starting to work on the main queue
[junit4] 2> 1142545 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:35050_ ] o.a.s.c.CoreContainer Security conf doesn't exist.
Skipping setup for authorization module.
[junit4] 2> 1142545 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:35050_ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 1142546 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:35050_ ] o.a.s.c.CoresLocator Looking for core definitions
underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/control-001/cores
[junit4] 2> 1142547 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:35050_ ] o.a.s.c.SolrCore Created CoreDescriptor:
{name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml,
loadOnStartup=true, configSetProperties=configsetprops.json,
instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/control-001/cores/collection1,
collection=control_collection,
absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/control-001/cores/collection1/,
coreNodeName=, dataDir=data/, shard=}
[junit4] 2> 1142547 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:35050_ ] o.a.s.c.CoresLocator Found core collection1 in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/control-001/cores/collection1/
[junit4] 2> 1142548 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:35050_ ] o.a.s.c.CoresLocator Found 1 core definitions
[junit4] 2> 1142549 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection x:collection1] o.a.s.c.ZkController
publishing state=down
[junit4] 2> 1142549 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection x:collection1] o.a.s.c.ZkController
numShards not found on descriptor - reading it from system property
[junit4] 2> 1142549 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:35050_ ] o.a.s.s.SolrDispatchFilter
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0
[junit4] 2> 1142549 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:35050_ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init()
done
[junit4] 2> 1142549 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection x:collection1] o.a.s.c.ZkController
look for our core node name
[junit4] 2> 1142550 INFO
(OverseerStateUpdate-94388519457521668-127.0.0.1:35050_-n_0000000000)
[n:127.0.0.1:35050_ ] 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:35050";,
[junit4] 2> "node_name":"127.0.0.1:35050_",
[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> 1142550 INFO
(OverseerStateUpdate-94388519457521668-127.0.0.1:35050_-n_0000000000)
[n:127.0.0.1:35050_ ] 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:35050";,
[junit4] 2> "node_name":"127.0.0.1:35050_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 1142550 INFO
(OverseerStateUpdate-94388519457521668-127.0.0.1:35050_-n_0000000000)
[n:127.0.0.1:35050_ ] o.a.s.c.o.ClusterStateMutator building a new cName:
control_collection
[junit4] 2> 1142551 INFO
(OverseerStateUpdate-94388519457521668-127.0.0.1:35050_-n_0000000000)
[n:127.0.0.1:35050_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard1
[junit4] 2> 1142552 INFO
(zkCallback-716-thread-1-processing-n:127.0.0.1:35050_) [n:127.0.0.1:35050_
] 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> 1143549 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection x:collection1] o.a.s.c.ZkController
waiting to find shard id in clusterstate for collection1
[junit4] 2> 1143550 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection x:collection1] o.a.s.c.ZkController
Check for collection zkNode:control_collection
[junit4] 2> 1143550 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection x:collection1] o.a.s.c.ZkController
Collection zkNode exists
[junit4] 2> 1143550 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection x:collection1]
o.a.s.c.c.ZkStateReader Load collection config
from:/collections/control_collection
[junit4] 2> 1143551 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection x:collection1]
o.a.s.c.c.ZkStateReader path=/collections/control_collection configName=conf1
specified config exists in ZooKeeper
[junit4] 2> 1143551 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection x:collection1]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/control-001/cores/collection1/'
[junit4] 2> 1143564 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection x:collection1] o.a.s.c.Config loaded
config solrconfig.xml with version 0
[junit4] 2> 1143568 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection x:collection1] o.a.s.c.SolrConfig
current version of requestparams : -1
[junit4] 2> 1143572 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection x:collection1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.0.0
[junit4] 2> 1143580 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection x:collection1] o.a.s.c.Config Loaded
SolrConfig: solrconfig.xml
[junit4] 2> 1143581 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection x:collection1] o.a.s.s.IndexSchema
Reading Solr Schema from /configs/conf1/schema.xml
[junit4] 2> 1143585 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 1143676 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Initialized with
rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1143682 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection x:collection1] o.a.s.s.IndexSchema
default search field in schema is text
[junit4] 2> 1143683 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection x:collection1] o.a.s.s.IndexSchema
unique key field: id
[junit4] 2> 1143690 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 1143692 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 1143694 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 1143695 WARN
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE
[junit4] 2> 1143695 WARN
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING
[junit4] 2> 1143695 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 1143696 WARN
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE
[junit4] 2> 1143696 WARN
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING
[junit4] 2> 1143697 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ 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-trunk/solr/build/solr-core/test/J0
[junit4] 2> 1143697 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection
control_collection
[junit4] 2> 1143697 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1143697 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ 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-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/control-001/cores/collection1/],
dataDir=[null]
[junit4] 2> 1143697 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ 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@19b22fc
[junit4] 2> 1143698 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ 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-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/control-001/cores/collection1/data
[junit4] 2> 1143698 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ 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-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/control-001/cores/collection1/data/index/
[junit4] 2> 1143698 WARN
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ 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-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/control-001/cores/collection1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 1143699 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ 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-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/control-001/cores/collection1/data/index
[junit4] 2> 1143699 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.MockRandomMergePolicy:
org.apache.lucene.index.MockRandomMergePolicy@686170b7
[junit4] 2> 1143699 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@3be016ff
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7a06398e),segFN=segments_1,generation=1}
[junit4] 2> 1143699 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 1143700 INFO
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:35050_
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-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/control-001/cores/collection1/data/
[junit4] 2> 1143700 WARN
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:35050_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.DirectoryFactory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/control-001/cores/collection1/data/
does not point to a valid data directory; skipping clean-up of old index
directories.
[junit4] 2> 1143704 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"nodistrib"
[junit4] 2> 1143704 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"dedupe"
[junit4] 2> 1143704 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 1143704 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"stored_sig"
[junit4] 2> 1143704 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 1143704 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ 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> 1143705 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ 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> 1143705 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ 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> 1143705 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ 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> 1143707 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1143708 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1143709 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1143709 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1143712 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.RequestHandlers Registered paths:
/admin/mbeans,standard,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
[junit4] 2> 1143713 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ 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> 1143713 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ 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> 1143713 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ 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> 1143714 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore Hard AutoCommit: disabled
[junit4] 2> 1143714 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore Soft AutoCommit: disabled
[junit4] 2> 1143715 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=31, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.5292538946777621]
[junit4] 2> 1143715 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@3be016ff
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7a06398e),segFN=segments_1,generation=1}
[junit4] 2> 1143715 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 1143715 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.s.SolrIndexSearcher Opening Searcher@6b8edf22[collection1] main
[junit4] 2> 1143716 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ 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> 1143716 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ 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> 1143717 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ 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> 1143717 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 1143717 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.RestManager Initializing RestManager with initArgs: {}
[junit4] 2> 1143717 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ 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> 1143718 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ 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> 1143718 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ 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> 1143718 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 1143718 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1143718 INFO
(searcherExecutor-2967-thread-1-processing-n:127.0.0.1:35050_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:35050_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore
[collection1] Registered new searcher Searcher@6b8edf22[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1143719 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ 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> 1143719 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ 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> 1143719 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ 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> 1143719 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ 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 1510216313139625984
[junit4] 2> 1143721 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.UpdateLog Took 2.0ms to seed version buckets with highest version
1510216313139625984
[junit4] 2> 1143721 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ZkController watch zkdir /configs/conf1
[junit4] 2> 1143722 INFO
(coreLoadExecutor-2966-thread-1-processing-n:127.0.0.1:35050_)
[n:127.0.0.1:35050_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 1143722 INFO
(coreZkRegister-2960-thread-1-processing-n:127.0.0.1:35050_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:35050_
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:35050
collection:control_collection shard:shard1
[junit4] 2> 1143723 INFO
(coreZkRegister-2960-thread-1-processing-n:127.0.0.1:35050_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:35050_
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> 1143726 INFO
(coreZkRegister-2960-thread-1-processing-n:127.0.0.1:35050_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:35050_
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/94388519457521668-core_node1-n_0000000000
[junit4] 2> 1143726 INFO
(coreZkRegister-2960-thread-1-processing-n:127.0.0.1:35050_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:35050_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext Running the leader process for shard shard1
[junit4] 2> 1143728 INFO
(coreZkRegister-2960-thread-1-processing-n:127.0.0.1:35050_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:35050_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1143728 INFO
(coreZkRegister-2960-thread-1-processing-n:127.0.0.1:35050_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:35050_
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> 1143728 INFO
(coreZkRegister-2960-thread-1-processing-n:127.0.0.1:35050_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:35050_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
Sync replicas to http://127.0.0.1:35050/collection1/
[junit4] 2> 1143728 INFO
(OverseerStateUpdate-94388519457521668-127.0.0.1:35050_-n_0000000000)
[n:127.0.0.1:35050_ ] 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> 1143728 INFO
(coreZkRegister-2960-thread-1-processing-n:127.0.0.1:35050_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:35050_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
Sync Success - now sync replicas to me
[junit4] 2> 1143728 INFO
(coreZkRegister-2960-thread-1-processing-n:127.0.0.1:35050_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:35050_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
http://127.0.0.1:35050/collection1/ has no replicas
[junit4] 2> 1143729 INFO
(coreZkRegister-2960-thread-1-processing-n:127.0.0.1:35050_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:35050_
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:35050/collection1/ shard1
[junit4] 2> 1143729 INFO
(coreZkRegister-2960-thread-1-processing-n:127.0.0.1:35050_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:35050_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1
[junit4] 2> 1143732 INFO
(OverseerStateUpdate-94388519457521668-127.0.0.1:35050_-n_0000000000)
[n:127.0.0.1:35050_ ] 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:35050";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 1
[junit4] 2> 1143834 INFO
(zkCallback-716-thread-2-processing-n:127.0.0.1:35050_) [n:127.0.0.1:35050_
] 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> 1143883 INFO
(coreZkRegister-2960-thread-1-processing-n:127.0.0.1:35050_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:35050_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
We are http://127.0.0.1:35050/collection1/ and leader is
http://127.0.0.1:35050/collection1/
[junit4] 2> 1143883 INFO
(coreZkRegister-2960-thread-1-processing-n:127.0.0.1:35050_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:35050_
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:35050
[junit4] 2> 1143883 INFO
(coreZkRegister-2960-thread-1-processing-n:127.0.0.1:35050_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:35050_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
I am the leader, no recovery necessary
[junit4] 2> 1143883 INFO
(coreZkRegister-2960-thread-1-processing-n:127.0.0.1:35050_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:35050_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
publishing state=active
[junit4] 2> 1143883 INFO
(coreZkRegister-2960-thread-1-processing-n:127.0.0.1:35050_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:35050_
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> 1143885 INFO
(OverseerStateUpdate-94388519457521668-127.0.0.1:35050_-n_0000000000)
[n:127.0.0.1:35050_ ] 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:35050";,
[junit4] 2> "node_name":"127.0.0.1:35050_",
[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> 1143885 INFO
(OverseerStateUpdate-94388519457521668-127.0.0.1:35050_-n_0000000000)
[n:127.0.0.1:35050_ ] 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:35050";,
[junit4] 2> "node_name":"127.0.0.1:35050_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 1143988 INFO
(zkCallback-716-thread-2-processing-n:127.0.0.1:35050_) [n:127.0.0.1:35050_
] 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> 1144051 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1144052 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1144053 INFO (zkCallback-718-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@286f7646
name:ZooKeeperConnection Watcher:127.0.0.1:50634/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1144053 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1144054 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1144054 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1144056 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection
loss:false
[junit4] 2> 1144378 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/shard-1-001/cores/collection1
[junit4] 2> 1144379 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/shard-1-001
[junit4] 2> 1144380 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.e.j.s.Server jetty-9.2.13.v20150730
[junit4] 2> 1144381 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@77ce5062{/,null,AVAILABLE}
[junit4] 2> 1144382 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@7b5fa2c6{HTTP/1.1}{127.0.0.1:42103}
[junit4] 2> 1144382 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.e.j.s.Server Started @1147632ms
[junit4] 2> 1144382 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/tempDir-001/jetty1,
solrconfig=solrconfig.xml, hostContext=/, hostPort=42103,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/shard-1-001/cores}
[junit4] 2> 1144382 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@4e0e2f2a
[junit4] 2> 1144382 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/shard-1-001/'
[junit4] 2> 1144397 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1144398 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1144399 INFO (zkCallback-719-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@3cc90948
name:ZooKeeperConnection Watcher:127.0.0.1:50634/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1144399 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1144400 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1144401 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 1144401 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/shard-1-001/solr.xml
[junit4] 2> 1144406 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.CoresLocator Config-defined core root directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/shard-1-001/cores
[junit4] 2> 1144406 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.CoreContainer New CoreContainer 34030372
[junit4] 2> 1144406 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/shard-1-001/]
[junit4] 2> 1144406 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.CoreContainer loading shared library:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/shard-1-001/lib
[junit4] 2> 1144406 WARN
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to
classloader: lib (resolved as:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/shard-1-001/lib).
[junit4] 2> 1144414 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
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> 1144415 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1144415 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1144416 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.l.LogWatcher Registering Log Listener [Log4j
(org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1144416 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:50634/solr
[junit4] 2> 1144416 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 1144416 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1144417 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1144419 INFO (zkCallback-721-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@7da3484a
name:ZooKeeperConnection Watcher:127.0.0.1:50634 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1144419 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1144420 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1144421 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:42103_ ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 1144422 INFO
(zkCallback-722-thread-1-processing-n:127.0.0.1:42103_) [n:127.0.0.1:42103_
] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@cde0a7a name:ZooKeeperConnection
Watcher:127.0.0.1:50634/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 1144422 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:42103_ ] o.a.s.c.c.ConnectionManager Client is connected to
ZooKeeper
[junit4] 2> 1144426 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:42103_ ] o.a.s.c.c.ZkStateReader Updating cluster state from
ZooKeeper...
[junit4] 2> 1145430 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:42103_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:42103_
[junit4] 2> 1145431 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:42103_ ] o.a.s.c.c.SolrZkClient makePath:
/live_nodes/127.0.0.1:42103_
[junit4] 2> 1145432 INFO
(zkCallback-716-thread-2-processing-n:127.0.0.1:35050_) [n:127.0.0.1:35050_
] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live
nodes size: 1)
[junit4] 2> 1145432 INFO
(zkCallback-722-thread-1-processing-n:127.0.0.1:42103_) [n:127.0.0.1:42103_
] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live
nodes size: 1)
[junit4] 2> 1145432 INFO (zkCallback-718-thread-1) [ ]
o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live
nodes size: 1)
[junit4] 2> 1145433 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:42103_ ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1145434 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:42103_ ] o.a.s.c.LeaderElector Joined leadership election with
path: /overseer_elect/election/94388519457521672-127.0.0.1:42103_-n_0000000001
[junit4] 2> 1145435 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:42103_ ] o.a.s.c.LeaderElector Watching path
/overseer_elect/election/94388519457521668-127.0.0.1:35050_-n_0000000000 to
know if I could be the leader
[junit4] 2> 1145444 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:42103_ ] o.a.s.c.CoreContainer Security conf doesn't exist.
Skipping setup for authorization module.
[junit4] 2> 1145444 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:42103_ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 1145445 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:42103_ ] o.a.s.c.CoresLocator Looking for core definitions
underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/shard-1-001/cores
[junit4] 2> 1145446 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:42103_ ] o.a.s.c.SolrCore Created CoreDescriptor:
{name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml,
loadOnStartup=true, configSetProperties=configsetprops.json,
instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/shard-1-001/cores/collection1,
collection=collection1,
absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/shard-1-001/cores/collection1/,
coreNodeName=, dataDir=data/, shard=}
[junit4] 2> 1145446 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:42103_ ] o.a.s.c.CoresLocator Found core collection1 in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/shard-1-001/cores/collection1/
[junit4] 2> 1145446 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:42103_ ] o.a.s.c.CoresLocator Found 1 core definitions
[junit4] 2> 1145447 INFO
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 x:collection1] o.a.s.c.ZkController
publishing state=down
[junit4] 2> 1145447 INFO
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 x:collection1] o.a.s.c.ZkController
numShards not found on descriptor - reading it from system property
[junit4] 2> 1145447 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:42103_ ] o.a.s.s.SolrDispatchFilter
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0
[junit4] 2> 1145447 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7636EEA5640CABE3])
[n:127.0.0.1:42103_ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init()
done
[junit4] 2> 1145448 INFO
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 x:collection1] o.a.s.c.ZkController look
for our core node name
[junit4] 2> 1145448 INFO
(OverseerStateUpdate-94388519457521668-127.0.0.1:35050_-n_0000000000)
[n:127.0.0.1:35050_ ] 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:42103";,
[junit4] 2> "node_name":"127.0.0.1:42103_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"} current state version: 3
[junit4] 2> 1145449 INFO
(OverseerStateUpdate-94388519457521668-127.0.0.1:35050_-n_0000000000)
[n:127.0.0.1:35050_ ] o.a.s.c.o.ReplicaMutator Update state numShards=2
message={
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:42103";,
[junit4] 2> "node_name":"127.0.0.1:42103_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"}
[junit4] 2> 1145449 INFO
(OverseerStateUpdate-94388519457521668-127.0.0.1:35050_-n_0000000000)
[n:127.0.0.1:35050_ ] o.a.s.c.o.ClusterStateMutator building a new cName:
collection1
[junit4] 2> 1145449 INFO
(OverseerStateUpdate-94388519457521668-127.0.0.1:35050_-n_0000000000)
[n:127.0.0.1:35050_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard2
[junit4] 2> 1145551 INFO (zkCallback-718-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred
- updating... (live nodes size: 2)
[junit4] 2> 1145551 INFO
(zkCallback-722-thread-1-processing-n:127.0.0.1:42103_) [n:127.0.0.1:42103_
] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred
- updating... (live nodes size: 2)
[junit4] 2> 1145551 INFO
(zkCallback-716-thread-2-processing-n:127.0.0.1:35050_) [n:127.0.0.1:35050_
] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred
- updating... (live nodes size: 2)
[junit4] 2> 1146448 INFO
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 x:collection1] o.a.s.c.ZkController waiting
to find shard id in clusterstate for collection1
[junit4] 2> 1146448 INFO
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 x:collection1] o.a.s.c.ZkController Check
for collection zkNode:collection1
[junit4] 2> 1146449 INFO
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 x:collection1] o.a.s.c.ZkController
Collection zkNode exists
[junit4] 2> 1146449 INFO
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 x:collection1] o.a.s.c.c.ZkStateReader Load
collection config from:/collections/collection1
[junit4] 2> 1146450 INFO
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 x:collection1] o.a.s.c.c.ZkStateReader
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 1146450 INFO
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 x:collection1] o.a.s.c.SolrResourceLoader
new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/shard-1-001/cores/collection1/'
[junit4] 2> 1146463 INFO
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 x:collection1] o.a.s.c.Config loaded config
solrconfig.xml with version 0
[junit4] 2> 1146467 INFO
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 x:collection1] o.a.s.c.SolrConfig current
version of requestparams : -1
[junit4] 2> 1146470 INFO
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 x:collection1] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 6.0.0
[junit4] 2> 1146479 INFO
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 x:collection1] o.a.s.c.Config Loaded
SolrConfig: solrconfig.xml
[junit4] 2> 1146480 INFO
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 x:collection1] o.a.s.s.IndexSchema Reading
Solr Schema from /configs/conf1/schema.xml
[junit4] 2> 1146484 INFO
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 1146580 INFO
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Initialized with
rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1146585 INFO
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 x:collection1] o.a.s.s.IndexSchema default
search field in schema is text
[junit4] 2> 1146586 INFO
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 x:collection1] o.a.s.s.IndexSchema unique
key field: id
[junit4] 2> 1146594 INFO
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 1146596 INFO
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 1146597 INFO
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 1146598 WARN
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE
[junit4] 2> 1146598 WARN
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING
[junit4] 2> 1146598 INFO
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 1146599 WARN
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE
[junit4] 2> 1146599 WARN
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING
[junit4] 2> 1146600 INFO
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 x:collection1] o.a.s.c.ConfigSetProperties
Did not find ConfigSet properties, assuming default properties: Can't find
resource 'configsetprops.json' in classpath or '/configs/conf1',
cwd=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0
[junit4] 2> 1146600 INFO
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection collection1
[junit4] 2> 1146601 INFO
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 s:shard2 r:core_node1 x:collection1]
o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1146601 INFO
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 s:shard2 r:core_node1 x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/shard-1-001/cores/collection1/],
dataDir=[null]
[junit4] 2> 1146601 INFO
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 s:shard2 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@19b22fc
[junit4] 2> 1146602 INFO
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 s:shard2 r:core_node1 x:collection1]
o.a.s.c.CachingDirectoryFactory return new directory for
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/shard-1-001/cores/collection1/data
[junit4] 2> 1146602 INFO
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 s:shard2 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-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest_7636EEA5640CABE3-001/shard-1-001/cores/collection1/data/index/
[junit4] 2> 1146602 WARN
(coreLoadExecutor-2977-thread-1-processing-n:127.0.0.1:42103_)
[n:127.0.0.1:42103_ c:collection1 s:shard2 r:core_node1 x:collection1]
o.a.s.c.SolrCore [collection1] Solr index directory
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build
[...truncated too long message...]
.handleRequest(RequestHandlerBase.java:151)
[junit4] 2> at
org.apache.solr.core.SolrCore.execute(SolrCore.java:2079)
[junit4] 2> at
org.apache.solr.servlet.DirectSolrConnection.request(DirectSolrConnection.java:131)
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.updateJ(SolrTestCaseJ4.java:1104)
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.addAndGetVersion(SolrTestCaseJ4.java:1250)
[junit4] 2> at
org.apache.solr.search.TestReloadDeadlock.addDoc(TestReloadDeadlock.java:200)
[junit4] 2> at
org.apache.solr.search.TestReloadDeadlock.access$100(TestReloadDeadlock.java:46)
[junit4] 2> at
org.apache.solr.search.TestReloadDeadlock$1.run(TestReloadDeadlock.java:156)
[junit4] 2> 8) Thread[id=78020, name=Thread-66401, state=WAITING,
group=TGRP-TestReloadDeadlock]
[junit4] 2> at java.lang.Object.wait(Native Method)
[junit4] 2> at java.lang.Object.wait(Object.java:502)
[junit4] 2> at
org.apache.solr.core.CloserThread.run(CoreContainer.java:1149)
[junit4] 2> 9) Thread[id=78097, name=searcherExecutor-9339-thread-1,
state=WAITING, group=TGRP-TestReloadDeadlock]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] 2> at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 10) Thread[id=78099, name=searcherExecutor-9343-thread-1,
state=WAITING, group=TGRP-TestReloadDeadlock]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] 2> at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene53):
{val_l=Lucene50(blocksize=128), _version_=PostingsFormat(name=MockRandom),
id=PostingsFormat(name=LuceneVarGapDocFreqInterval)}, docValues:{},
sim=RandomSimilarityProvider(queryNorm=true,coord=no): {}, locale=ro,
timezone=Etc/GMT-7
[junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation
1.8.0_45 (64-bit)/cpus=4,threads=11,free=280558760,total=531628032
[junit4] 2> NOTE: All tests run in this JVM: [TestNoOpRegenerator,
HdfsWriteToMultipleCollectionsTest, TestDistribDocBasedVersion,
ParsingFieldUpdateProcessorsTest, TestFieldResource, TermsComponentTest,
TestIBSimilarityFactory, HdfsLockFactoryTest, TestConfig,
HighlighterConfigTest, TestIndexingPerformance,
DefaultValueUpdateProcessorTest, RuleEngineTest, HLLSerializationTest,
SpatialHeatmapFacetsTest, TestMiniSolrCloudClusterSSL, TestFaceting,
SuggesterWFSTTest, RulesTest, CleanupOldIndexTest,
TestSolrQueryParserDefaultOperatorResource, BaseCdcrDistributedZkTest,
TestRandomFaceting, CoreAdminRequestStatusTest, PreAnalyzedUpdateProcessorTest,
TestCodecSupport, TestSearcherReuse, DateMathParserTest,
TestPKIAuthenticationPlugin, TestCloudSchemaless, TestCrossCoreJoin,
CursorPagingTest, UniqFieldsUpdateProcessorFactoryTest, QueryResultKeyTest,
DistribJoinFromCollectionTest, UUIDFieldTest, DistributedIntervalFacetingTest,
DocExpirationUpdateProcessorFactoryTest,
TestOverriddenPrefixQueryForCustomFieldType, JavabinLoaderTest,
TestComplexPhraseQParserPlugin, TestPhraseSuggestions,
TestCustomDocTransformer, TestInfoStreamLogging, TestCSVLoader,
TestJmxIntegration, TestConfigReload, TestBadConfig, ZkNodePropsTest,
TestBulkSchemaConcurrent, BasicZkTest, TestSolrDeletionPolicy1,
VersionInfoTest, CurrencyFieldXmlFileTest,
DistributedQueryComponentOptimizationTest, TestChildDocTransformer,
TestRandomMergePolicy, TestArbitraryIndexDir, SolrIndexConfigTest,
SpatialRPTFieldTypeTest, SimpleCollectionCreateDeleteTest, MBeansHandlerTest,
SuggesterFSTTest, EnumFieldTest, ResponseHeaderTest, MultiTermTest,
PingRequestHandlerTest, RequestLoggingTest, TestRequestStatusCollectionAPI,
TestSolrQueryParserResource, TestTolerantSearch, ExitableDirectoryReaderTest,
ConnectionManagerTest, HighlighterMaxOffsetTest,
VMParamsZkACLAndCredentialsProvidersTest, DeleteInactiveReplicaTest,
TestConfigSetImmutable, OverseerCollectionQueueTest,
StandardRequestHandlerTest, DistributedVersionInfoTest, SimplePostToolTest,
TestRuleBasedAuthorizationPlugin, PeerSyncTest, TestRemoveLastDynamicCopyField,
CoreAdminCreateDiscoverTest, BasicDistributedZkTest, BasicDistributedZk2Test,
CollectionsAPIDistributedZkTest, SyncSliceTest, OpenCloseCoreStressTest,
ZkCLITest, ShardRoutingCustomTest, TestDistributedSearch,
TestMergePolicyConfig, SampleTest, TestDocSet, TestBinaryField,
MinimalSchemaTest, ExternalFileFieldSortTest, TestSolrCoreProperties,
TestPostingsSolrHighlighter, DirectSolrConnectionTest,
NotRequiredUniqueKeyTest, TestLuceneMatchVersion, SpellPossibilityIteratorTest,
TestCharFilters, SynonymTokenizerTest, TestXIncludeConfig, EchoParamsTest,
TestSweetSpotSimilarityFactory, TestDFRSimilarityFactory,
TestPerFieldSimilarity, TestLMDirichletSimilarityFactory,
TestBM25SimilarityFactory, TestFastWriter, TestJmxMonitoredMap,
TimeZoneUtilsTest, OpenExchangeRatesOrgProviderTest, URLClassifyProcessorTest,
PluginInfoTest, ChaosMonkeyNothingIsSafeTest, CdcrRequestHandlerTest,
CollectionStateFormat2Test, ConcurrentDeleteAndCreateCollectionTest,
OverriddenZkACLAndCredentialsProvidersTest, OverseerRolesTest,
SharedFSAutoReplicaFailoverUtilsTest, SolrCloudExampleTest,
TestAuthenticationFramework, TestCloudInspectUtil, TestCryptoKeys,
TestDownShardTolerantSearch, TestMiniSolrCloudCluster,
TestSolrCloudWithKerberosAlt, TriLevelCompositeIdRoutingTest,
HdfsChaosMonkeySafeLeaderTest, HdfsCollectionsAPIDistributedZkTest,
DistributedExpandComponentTest, DistributedFacetPivotSmallTest,
SuggestComponentTest, TestPivotHelperCode, TestTrackingShardHandlerFactory,
SmileWriterTest, TestMacros, TestRawResponseWriter, TestSortingResponseWriter,
TestManagedResourceStorage, TestBulkSchemaAPI, TestCopyFieldCollectionResource,
TestDefaultSearchFieldResource, TestDynamicFieldCollectionResource,
TestDynamicFieldResource, TestFieldCollectionResource, TestFieldTypeResource,
TestManagedSchemaDynamicFieldResource, TestManagedSchemaFieldResource,
TestSchemaNameResource, TestSchemaSimilarityResource,
TestSchemaVersionResource, TestSerializedLuceneMatchVersion,
TestUniqueKeyFieldResource, TestManagedSynonymFilterFactory, BadCopyFieldTest,
ChangedSchemaMergeTest, DateRangeFieldTest, DocValuesMissingTest,
TestCloudManagedSchema, TestCollationFieldDocValues,
AnalyticsMergeStrategyTest, CursorMarkTest, RankQueryTest,
TestCollapseQParserPlugin, TestFieldSortValues, TestHashQParserPlugin,
TestInitQParser, TestMaxScoreQueryParser, TestMissingGroups,
TestReRankQParserPlugin, TestReloadDeadlock]
[junit4] 2> NOTE: download the large Jenkins line-docs file by running
'ant get-jenkins-line-docs' in the lucene directory.
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestReloadDeadlock
-Dtests.seed=7636EEA5640CABE3 -Dtests.multiplier=2 -Dtests.nightly=true
-Dtests.slow=true
-Dtests.linedocsfile=/x1/jenkins/lucene-data/enwiki.random.lines.txt
-Dtests.locale=ro -Dtests.timezone=Etc/GMT-7 -Dtests.asserts=true
-Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 0.00s J0 | TestReloadDeadlock (suite) <<<
[junit4] > Throwable #1: java.lang.Exception: Suite timeout exceeded (>=
300000 msec).
[junit4] > at
__randomizedtesting.SeedInfo.seed([7636EEA5640CABE3]:0)
[junit4] Completed [541/541] on J0 in 323.27s, 1 test, 2 errors <<< FAILURES!
[...truncated 14 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:782:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:719:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:59:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build.xml:233:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/common-build.xml:514:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:1432:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:987:
There were test failures: 541 suites, 2134 tests, 1 suite-level error, 3
errors, 26 ignored (14 assumptions)
Total time: 180 minutes 56 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
Sending email for trigger: Failure
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
