Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-5.3/15/
2 tests failed.
FAILED: org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test
Error Message:
Captured an uncaught exception in thread: Thread[id=4827, name=collection1,
state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught
exception in thread: Thread[id=4827, name=collection1, state=RUNNABLE,
group=TGRP-CollectionsAPIDistributedZkTest]
at
__randomizedtesting.SeedInfo.seed([7AB1EEB318D46550:F2E5D169B62808A8]:0)
Caused by:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error
from server at http://127.0.0.1:36506/p/j: Could not find collection :
awholynewstresscollection_collection1_0
at __randomizedtesting.SeedInfo.seed([7AB1EEB318D46550]: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:376)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:328)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1098)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:869)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:805)
at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:894)
FAILED: org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.test
Error Message:
Captured an uncaught exception in thread: Thread[id=3259, name=collection0,
state=RUNNABLE, group=TGRP-HdfsCollectionsAPIDistributedZkTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught
exception in thread: Thread[id=3259, name=collection0, state=RUNNABLE,
group=TGRP-HdfsCollectionsAPIDistributedZkTest]
Caused by:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error
from server at http://127.0.0.1:48551/u/km: Could not find collection :
awholynewstresscollection_collection0_0
at __randomizedtesting.SeedInfo.seed([7AB1EEB318D46550]: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:376)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:328)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1098)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:869)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:805)
at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:894)
Build Log:
[...truncated 10310 lines...]
[junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/init-core-data-001
[junit4] 2> 152224 INFO
(SUITE-CollectionsAPIDistributedZkTest-seed#[7AB1EEB318D46550]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
[junit4] 2> 152224 INFO
(SUITE-CollectionsAPIDistributedZkTest-seed#[7AB1EEB318D46550]-worker) [ ]
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /p/j
[junit4] 2> 152230 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 152231 INFO (Thread-3996) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 152231 INFO (Thread-3996) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 152331 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.ZkTestServer start zk server on port:36882
[junit4] 2> 152331 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 152332 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 152334 INFO (zkCallback-37-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@50ea2583
name:ZooKeeperConnection Watcher:127.0.0.1:36882 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 152335 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 152335 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 152335 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 152340 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 152341 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 152342 INFO (zkCallback-38-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@3d993e70
name:ZooKeeperConnection Watcher:127.0.0.1:36882/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 152343 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 152345 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 152345 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/collection1
[junit4] 2> 152349 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
[junit4] 2> 152352 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
[junit4] 2> 152354 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
[junit4] 2> 152357 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 152357 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
[junit4] 2> 152361 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 152361 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
[junit4] 2> 152364 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 152364 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 152367 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 152367 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
[junit4] 2> 152370 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 152370 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
[junit4] 2> 152373 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 152373 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
[junit4] 2> 152375 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 152376 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
[junit4] 2> 152378 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 152379 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
[junit4] 2> 152381 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 152381 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 152384 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 152384 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
[junit4] 2> 152387 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 152387 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
[junit4] 2> 152391 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 152392 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 152393 INFO (zkCallback-39-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@168310c1
name:ZooKeeperConnection Watcher:127.0.0.1:36882 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 152393 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 152394 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 152394 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 152402 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 152404 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 152405 INFO (zkCallback-40-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@7855b10 name:ZooKeeperConnection
Watcher:127.0.0.1:36882/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 152406 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 152406 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 152407 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf2/solrconfig.xml
[junit4] 2> 152407 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/solrconfig.xml
[junit4] 2> 152412 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf2/schema.xml
[junit4] 2> 152412 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/schema.xml
[junit4] 2> 152416 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf2/enumsConfig.xml
[junit4] 2> 152416 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/enumsConfig.xml
[junit4] 2> 152419 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf2/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 152419 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient makePath:
/configs/conf2/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 152422 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf2/stopwords.txt
[junit4] 2> 152423 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/stopwords.txt
[junit4] 2> 152426 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf2/protwords.txt
[junit4] 2> 152426 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/protwords.txt
[junit4] 2> 152430 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf2/currency.xml
[junit4] 2> 152430 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/currency.xml
[junit4] 2> 152434 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf2/open-exchange-rates.json
[junit4] 2> 152434 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/open-exchange-rates.json
[junit4] 2> 152437 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf2/mapping-ISOLatin1Accent.txt
[junit4] 2> 152438 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/mapping-ISOLatin1Accent.txt
[junit4] 2> 152441 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf2/old_synonyms.txt
[junit4] 2> 152442 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/old_synonyms.txt
[junit4] 2> 152444 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf2/synonyms.txt
[junit4] 2> 152445 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/synonyms.txt
[junit4] 2> 152447 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/elevate.xml
to /configs/conf2/elevate.xml
[junit4] 2> 152448 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/elevate.xml
[junit4] 2> 152558 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/control-001/cores/collection1
[junit4] 2> 152560 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.e.j.s.Server jetty-9.2.11.v20150529
[junit4] 2> 152563 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@51aef44e{/p/j,null,AVAILABLE}
[junit4] 2> 152565 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@2172218b{HTTP/1.1}{127.0.0.1:37125}
[junit4] 2> 152565 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.e.j.s.Server Started @155579ms
[junit4] 2> 152565 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/tempDir-001/control/data,
hostContext=/p/j, hostPort=37125,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/control-001/cores}
[junit4] 2> 152566 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@7b3cb2c6
[junit4] 2> 152566 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/control-001/'
[junit4] 2> 152585 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 152586 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 152588 INFO (zkCallback-41-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@5d22fcbb
name:ZooKeeperConnection Watcher:127.0.0.1:36882/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 152588 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 152588 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 152591 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 152591 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/control-001/solr.xml
[junit4] 2> 152612 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.CoresLocator Config-defined core root directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/control-001/cores
[junit4] 2> 152612 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.CoreContainer New CoreContainer 601835083
[junit4] 2> 152613 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/control-001/]
[junit4] 2> 152613 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.CoreContainer loading shared library:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/control-001/lib
[junit4] 2> 152613 WARN
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
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-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/control-001/lib).
[junit4] 2> 152623 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
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> 152625 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 152625 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 152626 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.l.LogWatcher Registering Log Listener [Log4j
(org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 152626 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36882/solr
[junit4] 2> 152626 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 152626 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 152627 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 152629 INFO (zkCallback-43-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@641d7948
name:ZooKeeperConnection Watcher:127.0.0.1:36882 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 152629 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 152630 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 152632 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 152634 INFO
(zkCallback-44-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@23182215
name:ZooKeeperConnection Watcher:127.0.0.1:36882/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 152634 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 152636 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
[junit4] 2> 152639 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-queue-work
[junit4] 2> 152642 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-running
[junit4] 2> 152645 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-completed
[junit4] 2> 152649 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-failure
[junit4] 2> 152652 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 152655 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 152658 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.c.SolrZkClient makePath:
/clusterstate.json
[junit4] 2> 152661 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 152662 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:37125_p%2Fj
[junit4] 2> 152663 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.c.SolrZkClient makePath:
/live_nodes/127.0.0.1:37125_p%2Fj
[junit4] 2> 152666 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 152668 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect/election
[junit4] 2> 152670 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 152671 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.LeaderElector Joined leadership election
with path:
/overseer_elect/election/95232287596150790-127.0.0.1:37125_p%2Fj-n_0000000000
[junit4] 2> 152672 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:37125_p%2Fj
[junit4] 2> 152673 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect/leader
[junit4] 2> 152675 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.Overseer Overseer
(id=95232287596150790-127.0.0.1:37125_p%2Fj-n_0000000000) starting
[junit4] 2> 152691 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.c.SolrZkClient makePath:
/overseer/queue-work
[junit4] 2> 152704 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.OverseerAutoReplicaFailoverThread
Starting OverseerAutoReplicaFailoverThread
autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=10000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 152712 INFO
(OverseerStateUpdate-95232287596150790-127.0.0.1:37125_p%2Fj-n_0000000000)
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.Overseer Starting to work on the main
queue
[junit4] 2> 152710 INFO
(OverseerCollectionProcessor-95232287596150790-127.0.0.1:37125_p%2Fj-n_0000000000)
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.OverseerCollectionProcessor Process
current queue of collection creations
[junit4] 2> 152717 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.c.ZkStateReader Updating cluster state
from ZooKeeper...
[junit4] 2> 152761 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.CoreContainer Security conf doesn't
exist. Skipping setup for authorization module.
[junit4] 2> 152762 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.CoreContainer No authentication plugin
used.
[junit4] 2> 152763 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.CoresLocator Looking for core definitions
underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/control-001/cores
[junit4] 2> 152764 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.SolrCore Created CoreDescriptor:
{absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/control-001/cores/collection1/,
name=collection1, config=solrconfig.xml, shard=,
instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/control-001/cores/collection1,
dataDir=data/, coreNodeName=, collection=control_collection,
loadOnStartup=true, schema=schema.xml, transient=false,
configSetProperties=configsetprops.json}
[junit4] 2> 152764 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.CoresLocator Found core collection1 in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/control-001/cores/collection1/
[junit4] 2> 152765 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.CoresLocator Found 1 core definitions
[junit4] 2> 152766 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:37125_p%2Fj ] o.a.s.s.SolrDispatchFilter
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1
[junit4] 2> 152767 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection x:collection1]
o.a.s.c.ZkController publishing state=down
[junit4] 2> 152767 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection x:collection1]
o.a.s.c.ZkController numShards not found on descriptor - reading it from system
property
[junit4] 2> 152767 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:37125_p%2Fj ] o.a.s.s.SolrDispatchFilter
SolrDispatchFilter.init() done
[junit4] 2> 152769 INFO
(zkCallback-44-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.DistributedQueue NodeChildrenChanged
fired on path /overseer/queue state SyncConnected
[junit4] 2> 152769 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection x:collection1]
o.a.s.c.ZkController look for our core node name
[junit4] 2> 152770 INFO
(OverseerStateUpdate-95232287596150790-127.0.0.1:37125_p%2Fj-n_0000000000)
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:37125/p/j";,
[junit4] 2> "numShards":"1",
[junit4] 2> "operation":"state",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "state":"down",
[junit4] 2> "core":"collection1",
[junit4] 2> "shard":null,
[junit4] 2> "node_name":"127.0.0.1:37125_p%2Fj"} current state version: 0
[junit4] 2> 152771 INFO
(OverseerStateUpdate-95232287596150790-127.0.0.1:37125_p%2Fj-n_0000000000)
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.o.ReplicaMutator Update state numShards=1
message={
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:37125/p/j";,
[junit4] 2> "numShards":"1",
[junit4] 2> "operation":"state",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "state":"down",
[junit4] 2> "core":"collection1",
[junit4] 2> "shard":null,
[junit4] 2> "node_name":"127.0.0.1:37125_p%2Fj"}
[junit4] 2> 152771 INFO
(OverseerStateUpdate-95232287596150790-127.0.0.1:37125_p%2Fj-n_0000000000)
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.o.ClusterStateMutator building a new
cName: control_collection
[junit4] 2> 152772 INFO
(OverseerStateUpdate-95232287596150790-127.0.0.1:37125_p%2Fj-n_0000000000)
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.o.ReplicaMutator Assigning new node to
shard shard=shard1
[junit4] 2> 152774 INFO
(zkCallback-44-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj ] 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> 152778 INFO
(zkCallback-44-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.c.ZkStateReader Updated cluster state
version to 1
[junit4] 2> 153769 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection x:collection1]
o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1
[junit4] 2> 153770 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection x:collection1]
o.a.s.c.ZkController Check for collection zkNode:control_collection
[junit4] 2> 153771 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection x:collection1]
o.a.s.c.ZkController Collection zkNode exists
[junit4] 2> 153771 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection x:collection1]
o.a.s.c.c.ZkStateReader Load collection config
from:/collections/control_collection
[junit4] 2> 153772 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection x:collection1]
o.a.s.c.c.ZkStateReader path=/collections/control_collection configName=conf1
specified config exists in ZooKeeper
[junit4] 2> 153773 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection x:collection1]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/control-001/cores/collection1/'
[junit4] 2> 153794 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection x:collection1] o.a.s.c.Config
loaded config solrconfig.xml with version 0
[junit4] 2> 153818 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection x:collection1]
o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 153838 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection x:collection1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.3.2
[junit4] 2> 153883 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection x:collection1] o.a.s.c.Config
Loaded SolrConfig: solrconfig.xml
[junit4] 2> 153885 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection x:collection1]
o.a.s.s.IndexSchema Reading Solr Schema from /configs/conf1/schema.xml
[junit4] 2> 153935 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection x:collection1]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 154281 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Initialized with
rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 154300 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection x:collection1]
o.a.s.s.IndexSchema default search field in schema is text
[junit4] 2> 154303 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection x:collection1]
o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 154332 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 154337 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 154342 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 154344 WARN
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE
[junit4] 2> 154344 WARN
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING
[junit4] 2> 154344 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 154345 WARN
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE
[junit4] 2> 154345 WARN
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING
[junit4] 2> 154347 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj 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-5.3/solr/build/solr-core/test/J1
[junit4] 2> 154347 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection x:collection1]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
collection control_collection
[junit4] 2> 154347 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 154348 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj 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-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/control-001/cores/collection1/],
dataDir=[null]
[junit4] 2> 154348 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj 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@bbe5d86
[junit4] 2> 154350 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj 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-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/control-001/cores/collection1/data
[junit4] 2> 154350 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj 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-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/control-001/cores/collection1/data/index/
[junit4] 2> 154350 WARN
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj 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-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/control-001/cores/collection1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 154354 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj 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-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/control-001/cores/collection1/data/index
[junit4] 2> 154354 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj 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=39, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 154365 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj 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(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/index-SimpleFSDirectory-001
lockFactory=org.apache.lucene.store.NativeFSLockFactory@391533f1),segFN=segments_1,generation=1}
[junit4] 2> 154365 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 154366 INFO
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:37125_p%2Fj
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-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/control-001/cores/collection1/data/
[junit4] 2> 154367 WARN
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:37125_p%2Fj
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.DirectoryFactory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/control-001/cores/collection1/data/
does not point to a valid data directory; skipping clean-up of old index
directories.
[junit4] 2> 154375 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 154376 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 154377 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 154377 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 154377 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 154377 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj 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> 154378 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj 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> 154378 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj 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> 154379 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj 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> 154382 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 154383 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 154385 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 154386 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 154393 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.RequestHandlers Registered paths:
/admin/threads,/update,/admin/mbeans,/admin/properties,/admin/plugins,/admin/luke,/admin/system,/update/json/docs,/update/csv,/admin/segments,/replication,/admin/file,/config,/schema,/admin/ping,/get,standard,/admin/logging,/update/json
[junit4] 2> 154394 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj 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> 154395 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj 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> 154395 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj 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> 154396 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
[junit4] 2> 154397 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
[junit4] 2> 154397 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj 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@3b0f5e01
[junit4] 2> 154405 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj 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(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/index-SimpleFSDirectory-001
lockFactory=org.apache.lucene.store.NativeFSLockFactory@391533f1),segFN=segments_1,generation=1}
[junit4] 2> 154406 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 154406 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@2274261e[collection1]
main
[junit4] 2> 154406 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj 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> 154408 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj 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> 154408 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj 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> 154410 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO
with znodeBase: /configs/conf1
[junit4] 2> 154410 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
[junit4] 2> 154410 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj 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> 154411 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj 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> 154412 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj 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> 154412 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 154412 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 154413 INFO
(searcherExecutor-134-thread-1-processing-r:core_node1 c:control_collection
x:collection1 n:127.0.0.1:37125_p%2Fj s:shard1) [n:127.0.0.1:37125_p%2Fj
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore
[collection1] Registered new searcher Searcher@2274261e[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 154414 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj 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> 154415 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj 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> 154415 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj 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> 154415 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj 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 1523716603826405376
[junit4] 2> 154417 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.UpdateLog Took 2 ms to seed version buckets with highest
version 1523716603826405376
[junit4] 2> 154417 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1
[junit4] 2> 154418 INFO
(coreLoadExecutor-133-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 154419 INFO
(coreZkRegister-127-thread-1-processing-r:core_node1 c:control_collection
x:collection1 n:127.0.0.1:37125_p%2Fj s:shard1) [n:127.0.0.1:37125_p%2Fj
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:37125/p/j
collection:control_collection shard:shard1
[junit4] 2> 154420 INFO
(coreZkRegister-127-thread-1-processing-r:core_node1 c:control_collection
x:collection1 n:127.0.0.1:37125_p%2Fj s:shard1) [n:127.0.0.1:37125_p%2Fj
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> 154428 INFO
(coreZkRegister-127-thread-1-processing-r:core_node1 c:control_collection
x:collection1 n:127.0.0.1:37125_p%2Fj s:shard1) [n:127.0.0.1:37125_p%2Fj
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/95232287596150790-core_node1-n_0000000000
[junit4] 2> 154430 INFO
(coreZkRegister-127-thread-1-processing-r:core_node1 c:control_collection
x:collection1 n:127.0.0.1:37125_p%2Fj s:shard1) [n:127.0.0.1:37125_p%2Fj
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext Running the leader process for shard shard1
[junit4] 2> 154442 INFO
(zkCallback-44-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.DistributedQueue NodeChildrenChanged
fired on path /overseer/queue state SyncConnected
[junit4] 2> 154443 INFO
(coreZkRegister-127-thread-1-processing-r:core_node1 c:control_collection
x:collection1 n:127.0.0.1:37125_p%2Fj s:shard1) [n:127.0.0.1:37125_p%2Fj
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 154444 INFO
(coreZkRegister-127-thread-1-processing-r:core_node1 c:control_collection
x:collection1 n:127.0.0.1:37125_p%2Fj s:shard1) [n:127.0.0.1:37125_p%2Fj
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> 154444 INFO
(coreZkRegister-127-thread-1-processing-r:core_node1 c:control_collection
x:collection1 n:127.0.0.1:37125_p%2Fj s:shard1) [n:127.0.0.1:37125_p%2Fj
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
Sync replicas to http://127.0.0.1:37125/p/j/collection1/
[junit4] 2> 154444 INFO
(coreZkRegister-127-thread-1-processing-r:core_node1 c:control_collection
x:collection1 n:127.0.0.1:37125_p%2Fj s:shard1) [n:127.0.0.1:37125_p%2Fj
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
Sync Success - now sync replicas to me
[junit4] 2> 154444 INFO
(coreZkRegister-127-thread-1-processing-r:core_node1 c:control_collection
x:collection1 n:127.0.0.1:37125_p%2Fj s:shard1) [n:127.0.0.1:37125_p%2Fj
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
http://127.0.0.1:37125/p/j/collection1/ has no replicas
[junit4] 2> 154444 INFO
(coreZkRegister-127-thread-1-processing-r:core_node1 c:control_collection
x:collection1 n:127.0.0.1:37125_p%2Fj s:shard1) [n:127.0.0.1:37125_p%2Fj
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:37125/p/j/collection1/ shard1
[junit4] 2> 154444 INFO
(OverseerStateUpdate-95232287596150790-127.0.0.1:37125_p%2Fj-n_0000000000)
[n:127.0.0.1:37125_p%2Fj ] 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> 154445 INFO
(coreZkRegister-127-thread-1-processing-r:core_node1 c:control_collection
x:collection1 n:127.0.0.1:37125_p%2Fj s:shard1) [n:127.0.0.1:37125_p%2Fj
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1
[junit4] 2> 154446 INFO
(zkCallback-44-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj ] 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> 154451 INFO
(zkCallback-44-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.c.ZkStateReader Updated cluster state
version to 2
[junit4] 2> 154456 INFO
(OverseerStateUpdate-95232287596150790-127.0.0.1:37125_p%2Fj-n_0000000000)
[n:127.0.0.1:37125_p%2Fj ] 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:37125/p/j";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 2
[junit4] 2> 154459 INFO
(zkCallback-44-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.DistributedQueue NodeChildrenChanged
fired on path /overseer/queue state SyncConnected
[junit4] 2> 154460 INFO
(zkCallback-44-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj ] 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> 154464 INFO
(zkCallback-44-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.c.ZkStateReader Updated cluster state
version to 3
[junit4] 2> 154506 INFO
(coreZkRegister-127-thread-1-processing-r:core_node1 c:control_collection
x:collection1 n:127.0.0.1:37125_p%2Fj s:shard1) [n:127.0.0.1:37125_p%2Fj
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
We are http://127.0.0.1:37125/p/j/collection1/ and leader is
http://127.0.0.1:37125/p/j/collection1/
[junit4] 2> 154506 INFO
(coreZkRegister-127-thread-1-processing-r:core_node1 c:control_collection
x:collection1 n:127.0.0.1:37125_p%2Fj s:shard1) [n:127.0.0.1:37125_p%2Fj
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:37125/p/j
[junit4] 2> 154506 INFO
(coreZkRegister-127-thread-1-processing-r:core_node1 c:control_collection
x:collection1 n:127.0.0.1:37125_p%2Fj s:shard1) [n:127.0.0.1:37125_p%2Fj
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
I am the leader, no recovery necessary
[junit4] 2> 154507 INFO
(coreZkRegister-127-thread-1-processing-r:core_node1 c:control_collection
x:collection1 n:127.0.0.1:37125_p%2Fj s:shard1) [n:127.0.0.1:37125_p%2Fj
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
publishing state=active
[junit4] 2> 154507 INFO
(coreZkRegister-127-thread-1-processing-r:core_node1 c:control_collection
x:collection1 n:127.0.0.1:37125_p%2Fj s:shard1) [n:127.0.0.1:37125_p%2Fj
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> 154510 INFO
(zkCallback-44-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.DistributedQueue NodeChildrenChanged
fired on path /overseer/queue state SyncConnected
[junit4] 2> 154511 INFO
(OverseerStateUpdate-95232287596150790-127.0.0.1:37125_p%2Fj-n_0000000000)
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:37125/p/j";,
[junit4] 2> "numShards":"1",
[junit4] 2> "operation":"state",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "state":"active",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "core":"collection1",
[junit4] 2> "shard":"shard1",
[junit4] 2> "node_name":"127.0.0.1:37125_p%2Fj"} current state version: 3
[junit4] 2> 154513 INFO
(OverseerStateUpdate-95232287596150790-127.0.0.1:37125_p%2Fj-n_0000000000)
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.o.ReplicaMutator Update state numShards=1
message={
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:37125/p/j";,
[junit4] 2> "numShards":"1",
[junit4] 2> "operation":"state",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "state":"active",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "core":"collection1",
[junit4] 2> "shard":"shard1",
[junit4] 2> "node_name":"127.0.0.1:37125_p%2Fj"}
[junit4] 2> 154619 INFO
(zkCallback-44-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj ] 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> 154623 INFO
(zkCallback-44-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.c.ZkStateReader Updated cluster state
version to 4
[junit4] 2> 154770 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 154770 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 154772 INFO (zkCallback-46-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@49360bd0
name:ZooKeeperConnection Watcher:127.0.0.1:36882/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 154773 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 154773 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 154773 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 154779 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection
loss:false
[junit4] 2> 154779 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase Creating collection1 with stateFormat=2
[junit4] 2> 154779 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 154781 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 154782 INFO (zkCallback-47-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@36e6e06e
name:ZooKeeperConnection Watcher:127.0.0.1:36882/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 154782 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 154783 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 154786 INFO
(zkCallback-44-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.DistributedQueue NodeChildrenChanged
fired on path /overseer/queue state SyncConnected
[junit4] 2> 154788 INFO
(OverseerStateUpdate-95232287596150790-127.0.0.1:37125_p%2Fj-n_0000000000)
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "operation":"create",
[junit4] 2> "name":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "stateFormat":"2"} current state version: 4
[junit4] 2> 154788 INFO
(OverseerStateUpdate-95232287596150790-127.0.0.1:37125_p%2Fj-n_0000000000)
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.o.ClusterStateMutator building a new
cName: collection1
[junit4] 2> 154894 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/shard-1-001/cores/collection1
[junit4] 2> 154895 INFO
(OverseerStateUpdate-95232287596150790-127.0.0.1:37125_p%2Fj-n_0000000000)
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.o.ZkStateWriter going to
create_collection /collections/collection1/state.json
[junit4] 2> 154896 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/shard-1-001
[junit4] 2> 154897 INFO
(zkCallback-44-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj ] 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> 154897 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.e.j.s.Server jetty-9.2.11.v20150529
[junit4] 2> 154897 INFO (zkCallback-46-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred
- updating... (live nodes size: 1)
[junit4] 2> 154904 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@29adde92{/p/j,null,AVAILABLE}
[junit4] 2> 154904 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@55ef589e{HTTP/1.1}{127.0.0.1:60559}
[junit4] 2> 154905 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.e.j.s.Server Started @157918ms
[junit4] 2> 154905 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/tempDir-001/jetty1,
hostContext=/p/j, solrconfig=solrconfig.xml,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/shard-1-001/cores,
hostPort=60559}
[junit4] 2> 154905 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@7b3cb2c6
[junit4] 2> 154905 INFO
(zkCallback-44-thread-1-processing-n:127.0.0.1:37125_p%2Fj)
[n:127.0.0.1:37125_p%2Fj ] o.a.s.c.c.ZkStateReader Updated cluster state
version to 5
[junit4] 2> 154905 INFO (zkCallback-46-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated cluster state version to 5
[junit4] 2> 154905 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/shard-1-001/'
[junit4] 2> 154925 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 154926 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 154928 INFO (zkCallback-48-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@10b11d0c
name:ZooKeeperConnection Watcher:127.0.0.1:36882/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 154930 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 154930 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 154933 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 154933 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/shard-1-001/solr.xml
[junit4] 2> 154953 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.CoresLocator Config-defined core root directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/shard-1-001/cores
[junit4] 2> 154953 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.CoreContainer New CoreContainer 98415100
[junit4] 2> 154953 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/shard-1-001/]
[junit4] 2> 154954 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.CoreContainer loading shared library:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/shard-1-001/lib
[junit4] 2> 154954 WARN
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
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-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/shard-1-001/lib).
[junit4] 2> 154964 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
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> 154965 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 154966 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 154966 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.l.LogWatcher Registering Log Listener [Log4j
(org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 154966 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36882/solr
[junit4] 2> 154966 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 154967 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 154967 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 154969 INFO (zkCallback-50-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@6eb5d55a
name:ZooKeeperConnection Watcher:127.0.0.1:36882 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 154969 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 154970 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 154974 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:60559_p%2Fj ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 154976 INFO
(zkCallback-51-thread-1-processing-n:127.0.0.1:60559_p%2Fj)
[n:127.0.0.1:60559_p%2Fj ] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@74b4cfb7
name:ZooKeeperConnection Watcher:127.0.0.1:36882/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 154976 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:60559_p%2Fj ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 154985 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:60559_p%2Fj ] o.a.s.c.c.ZkStateReader Updating cluster state
from ZooKeeper...
[junit4] 2> 155998 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:60559_p%2Fj ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:60559_p%2Fj
[junit4] 2> 155999 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:60559_p%2Fj ] o.a.s.c.c.SolrZkClient makePath:
/live_nodes/127.0.0.1:60559_p%2Fj
[junit4] 2> 156004 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:60559_p%2Fj ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 156005 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:60559_p%2Fj ] o.a.s.c.LeaderElector Joined leadership election
with path:
/overseer_elect/election/95232287596150795-127.0.0.1:60559_p%2Fj-n_0000000001
[junit4] 2> 156007 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:60559_p%2Fj ] o.a.s.c.LeaderElector Watching path
/overseer_elect/election/95232287596150790-127.0.0.1:37125_p%2Fj-n_0000000000
to know if I could be the leader
[junit4] 2> 156025 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:60559_p%2Fj ] o.a.s.c.CoreContainer Security conf doesn't
exist. Skipping setup for authorization module.
[junit4] 2> 156025 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:60559_p%2Fj ] o.a.s.c.CoreContainer No authentication plugin
used.
[junit4] 2> 156026 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:60559_p%2Fj ] o.a.s.c.CoresLocator Looking for core definitions
underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/shard-1-001/cores
[junit4] 2> 156027 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[7AB1EEB318D46550])
[n:127.0.0.1:60559_p%2Fj ] o.a.s.c.SolrCore Created CoreDescriptor: {shard=,
name=collection1, dataDir=data/, collection=collection1,
absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/shard-1-001/cores/collection1/,
instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_7AB1EEB318D46550-001/shard-1
[...truncated too long message...]
tor interrupted: java.lang.InterruptedException: sleep interrupted
[junit4] 2> 1743768 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[7AB1EEB318D46550]-worker)
[n:127.0.0.1:44990_u%2Fkm c:addReplicaColl s:shard2 r:core_node6
x:addReplicaColl_shard2_replica3] o.m.log Stopped
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:0
[junit4] 2> 1743869 ERROR
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[7AB1EEB318D46550]-worker)
[n:127.0.0.1:44990_u%2Fkm c:addReplicaColl s:shard2 r:core_node6
x:addReplicaColl_shard2_replica3] o.a.h.m.l.MethodMetric Error invoking method
getBlocksTotal
[junit4] 2> java.lang.reflect.InvocationTargetException
[junit4] 2> at sun.reflect.GeneratedMethodAccessor54.invoke(Unknown
Source)
[junit4] 2> at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:606)
[junit4] 2> at
org.apache.hadoop.metrics2.lib.MethodMetric$2.snapshot(MethodMetric.java:111)
[junit4] 2> at
org.apache.hadoop.metrics2.lib.MethodMetric.snapshot(MethodMetric.java:144)
[junit4] 2> at
org.apache.hadoop.metrics2.lib.MetricsRegistry.snapshot(MetricsRegistry.java:387)
[junit4] 2> at
org.apache.hadoop.metrics2.lib.MetricsSourceBuilder$1.getMetrics(MetricsSourceBuilder.java:79)
[junit4] 2> at
org.apache.hadoop.metrics2.impl.MetricsSourceAdapter.getMetrics(MetricsSourceAdapter.java:195)
[junit4] 2> at
org.apache.hadoop.metrics2.impl.MetricsSourceAdapter.updateJmxCache(MetricsSourceAdapter.java:172)
[junit4] 2> at
org.apache.hadoop.metrics2.impl.MetricsSourceAdapter.getMBeanInfo(MetricsSourceAdapter.java:151)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getClassName(DefaultMBeanServerInterceptor.java:1804)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.safeGetClassName(DefaultMBeanServerInterceptor.java:1595)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.checkMBeanPermission(DefaultMBeanServerInterceptor.java:1813)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:430)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:415)
[junit4] 2> at
com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:546)
[junit4] 2> at
org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:81)
[junit4] 2> at
org.apache.hadoop.metrics2.impl.MetricsSourceAdapter.stopMBeans(MetricsSourceAdapter.java:227)
[junit4] 2> at
org.apache.hadoop.metrics2.impl.MetricsSourceAdapter.stop(MetricsSourceAdapter.java:212)
[junit4] 2> at
org.apache.hadoop.metrics2.impl.MetricsSystemImpl.stopSources(MetricsSystemImpl.java:461)
[junit4] 2> at
org.apache.hadoop.metrics2.impl.MetricsSystemImpl.stop(MetricsSystemImpl.java:212)
[junit4] 2> at
org.apache.hadoop.metrics2.impl.MetricsSystemImpl.shutdown(MetricsSystemImpl.java:592)
[junit4] 2> at
org.apache.hadoop.metrics2.lib.DefaultMetricsSystem.shutdownInstance(DefaultMetricsSystem.java:72)
[junit4] 2> at
org.apache.hadoop.metrics2.lib.DefaultMetricsSystem.shutdown(DefaultMetricsSystem.java:68)
[junit4] 2> at
org.apache.hadoop.hdfs.server.namenode.metrics.NameNodeMetrics.shutdown(NameNodeMetrics.java:145)
[junit4] 2> at
org.apache.hadoop.hdfs.server.namenode.NameNode.stop(NameNode.java:822)
[junit4] 2> at
org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1720)
[junit4] 2> at
org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1699)
[junit4] 2> at
org.apache.solr.cloud.hdfs.HdfsTestUtil.teardownClass(HdfsTestUtil.java:197)
[junit4] 2> at
org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.teardownClass(HdfsCollectionsAPIDistributedZkTest.java:50)
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native
Method)
[junit4] 2> at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
[junit4] 2> at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:606)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:799)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[junit4] 2> at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
[junit4] 2> at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> Caused by: java.lang.NullPointerException
[junit4] 2> at
org.apache.hadoop.hdfs.server.blockmanagement.BlocksMap.size(BlocksMap.java:198)
[junit4] 2> at
org.apache.hadoop.hdfs.server.blockmanagement.BlockManager.getTotalBlocks(BlockManager.java:3291)
[junit4] 2> at
org.apache.hadoop.hdfs.server.namenode.FSNamesystem.getBlocksTotal(FSNamesystem.java:6223)
[junit4] 2> ... 53 more
[junit4] 2> 1743873 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[7AB1EEB318D46550]-worker)
[n:127.0.0.1:44990_u%2Fkm c:addReplicaColl s:shard2 r:core_node6
x:addReplicaColl_shard2_replica3] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> Jan 18, 2016 3:29:40 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 2 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene53):
{_version_=PostingsFormat(name=MockRandom),
range_facet_i_dv=PostingsFormat(name=Direct),
range_facet_l=PostingsFormat(name=Direct),
timestamp=PostingsFormat(name=Direct),
intDefault=PostingsFormat(name=MockRandom), a_i1=PostingsFormat(name=Direct),
range_facet_l_dv=PostingsFormat(name=LuceneVarGapFixedInterval),
multiDefault=PostingsFormat(name=Direct),
text=PostingsFormat(name=LuceneFixedGap),
id=PostingsFormat(name=LuceneVarGapFixedInterval),
other_tl1=PostingsFormat(name=MockRandom), a_t=PostingsFormat(name=Direct)},
docValues:{range_facet_i_dv=DocValuesFormat(name=Asserting),
timestamp=DocValuesFormat(name=Asserting),
range_facet_l_dv=DocValuesFormat(name=Lucene50)}, sim=DefaultSimilarity,
locale=sr_BA, timezone=America/Atikokan
[junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation
1.7.0_80 (64-bit)/cpus=4,threads=2,free=142108824,total=462946304
[junit4] 2> NOTE: All tests run in this JVM:
[SolrCoreCheckLockOnStartupTest, TestLRUStatsCache, RecoveryZkTest, TestDocSet,
OutputWriterTest, TestHdfsUpdateLog, HdfsCollectionsAPIDistributedZkTest]
[junit4] Completed [176/533] on J2 in 1392.44s, 1 test, 1 error <<< FAILURES!
[...truncated 1274 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/build.xml:733:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/build.xml:670:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/build.xml:59:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build.xml:230:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/common-build.xml:524:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/lucene/common-build.xml:1449:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/lucene/common-build.xml:1003:
There were test failures: 533 suites, 2104 tests, 2 errors, 26 ignored (14
assumptions)
Total time: 243 minutes 54 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
No prior successful build to compare, so performing full copy of artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org
