Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-6.x/97/

2 tests failed.
FAILED:  org.apache.solr.update.processor.TestNamedUpdateProcessors.test

Error Message:
Index: 0, Size: 0

Stack Trace:
java.lang.IndexOutOfBoundsException: Index: 0, Size: 0
        at 
__randomizedtesting.SeedInfo.seed([E7B830774568D30B:6FEC0FADEB94BEF3]:0)
        at java.util.ArrayList.rangeCheck(ArrayList.java:653)
        at java.util.ArrayList.get(ArrayList.java:429)
        at 
org.apache.solr.update.processor.TestNamedUpdateProcessors.test(TestNamedUpdateProcessors.java:128)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:992)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(Thread.java:745)


FAILED:  org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test

Error Message:
Captured an uncaught exception in thread: Thread[id=4455, name=collection4, 
state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=4455, name=collection4, state=RUNNABLE, 
group=TGRP-CollectionsAPIDistributedZkTest]
Caused by: 
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at https://127.0.0.1:43886: collection already exists: 
awholynewstresscollection_collection4_0
        at __randomizedtesting.SeedInfo.seed([E7B830774568D30B]:0)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:590)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:259)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:403)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:356)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1228)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:998)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:934)
        at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1599)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1620)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:987)




Build Log:
[...truncated 11181 lines...]
   [junit4] Suite: org.apache.solr.update.processor.TestNamedUpdateProcessors
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/init-core-data-001
   [junit4]   2> 257272 INFO  
(SUITE-TestNamedUpdateProcessors-seed#[E7B830774568D30B]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 257272 INFO  
(SUITE-TestNamedUpdateProcessors-seed#[E7B830774568D30B]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
   [junit4]   2> 257288 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 257288 INFO  (Thread-10202) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 257288 INFO  (Thread-10202) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 257392 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.ZkTestServer start zk server on port:58662
   [junit4]   2> 257392 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 257396 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 257402 INFO  (zkCallback-174-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@27c9e7f1 
name:ZooKeeperConnection Watcher:127.0.0.1:58662 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 257402 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 257402 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 257402 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 257432 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 257454 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 257464 INFO  (zkCallback-175-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@23e363a3 
name:ZooKeeperConnection Watcher:127.0.0.1:58662/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 257464 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 257464 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 257464 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1
   [junit4]   2> 257473 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
   [junit4]   2> 257474 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
   [junit4]   2> 257474 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
   [junit4]   2> 257475 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
 to /configs/conf1/solrconfig.xml
   [junit4]   2> 257475 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
   [junit4]   2> 257476 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/schema.xml
 to /configs/conf1/schema.xml
   [junit4]   2> 257476 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
   [junit4]   2> 257477 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 257477 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 257478 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf1/stopwords.txt
   [junit4]   2> 257478 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
   [junit4]   2> 257478 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf1/protwords.txt
   [junit4]   2> 257478 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
   [junit4]   2> 257479 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf1/currency.xml
   [junit4]   2> 257479 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
   [junit4]   2> 257480 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf1/enumsConfig.xml
   [junit4]   2> 257480 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
   [junit4]   2> 257480 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 257480 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
   [junit4]   2> 257481 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 257481 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 257482 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf1/old_synonyms.txt
   [junit4]   2> 257482 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
   [junit4]   2> 257483 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf1/synonyms.txt
   [junit4]   2> 257483 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
   [junit4]   2> 257551 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/control-001/cores/collection1
   [junit4]   2> 257552 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 257555 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@34eff71c{/,null,AVAILABLE}
   [junit4]   2> 257557 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@5e3c3dab{HTTP/1.1,[http/1.1]}{127.0.0.1:60967}
   [junit4]   2> 257557 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.e.j.s.Server Started @261024ms
   [junit4]   2> 257557 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/tempDir-001/control/data,
 hostContext=/, hostPort=60967, 
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/control-001/cores}
   [junit4]   2> 257557 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@73d16e93
   [junit4]   2> 257557 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/control-001'
   [junit4]   2> 257557 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 257557 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 257557 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 257565 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 257566 INFO  (zkCallback-176-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@688758fb 
name:ZooKeeperConnection Watcher:127.0.0.1:58662/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 257566 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 257566 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 257567 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 257567 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/control-001/solr.xml
   [junit4]   2> 257571 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.CorePropertiesLocator Config-defined core root directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/control-001/cores
   [junit4]   2> 257571 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.CoreContainer New CoreContainer 965763780
   [junit4]   2> 257571 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/control-001]
   [junit4]   2> 257571 WARN  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.CoreContainer Couldn't add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/control-001/lib
 to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/control-001/lib
   [junit4]   2> 257571 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
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> 257572 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 257572 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 257572 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.l.LogWatcher Registering Log Listener [Log4j 
(org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 257573 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58662/solr
   [junit4]   2> 257573 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.ZkController zkHost includes chroot
   [junit4]   2> 257573 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 257592 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 257604 INFO  (zkCallback-179-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@480cb530 
name:ZooKeeperConnection Watcher:127.0.0.1:58662 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 257606 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 257606 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 257608 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.ZkController Added new OnReconnect listener 
org.apache.solr.cloud.ZkController$$Lambda$18/1514911253@2106bb08
   [junit4]   2> 257628 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 257628 INFO  
(zkCallback-180-thread-1-processing-n:127.0.0.1:60967_) [n:127.0.0.1:60967_    
] o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@68364c40 
name:ZooKeeperConnection Watcher:127.0.0.1:58662/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 257628 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.c.ConnectionManager Client is connected to 
ZooKeeper
   [junit4]   2> 257629 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
   [junit4]   2> 257630 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-queue-work
   [junit4]   2> 257632 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-running
   [junit4]   2> 257632 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-completed
   [junit4]   2> 257633 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-failure
   [junit4]   2> 257634 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 257644 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 257645 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 257645 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 257648 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.c.ZkStateReader Updating cluster state from 
ZooKeeper... 
   [junit4]   2> 257648 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 257649 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (0)
   [junit4]   2> 257650 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
   [junit4]   2> 257673 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer_elect/election
   [junit4]   2> 257674 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 257674 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.LeaderElector Joined leadership election with 
path: /overseer_elect/election/96104653177028612-127.0.0.1:60967_-n_0000000000
   [junit4]   2> 257674 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.OverseerElectionContext I am going to be the 
leader 127.0.0.1:60967_
   [junit4]   2> 257674 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
   [junit4]   2> 257675 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.Overseer Overseer 
(id=96104653177028612-127.0.0.1:60967_-n_0000000000) starting
   [junit4]   2> 257675 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
   [junit4]   2> 257744 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting 
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=30000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 257745 INFO  
(OverseerStateUpdate-96104653177028612-127.0.0.1:60967_-n_0000000000) 
[n:127.0.0.1:60967_    ] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 257757 INFO  
(OverseerStateUpdate-96104653177028612-127.0.0.1:60967_-n_0000000000) 
[n:127.0.0.1:60967_    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (0)
   [junit4]   2> 257759 INFO  
(OverseerCollectionConfigSetProcessor-96104653177028612-127.0.0.1:60967_-n_0000000000)
 [n:127.0.0.1:60967_    ] o.a.s.c.OverseerTaskProcessor Process current queue 
of overseer operations
   [junit4]   2> 257761 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:60967_
   [junit4]   2> 257772 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.c.SolrZkClient makePath: 
/live_nodes/127.0.0.1:60967_
   [junit4]   2> 257773 INFO  
(zkCallback-180-thread-1-processing-n:127.0.0.1:60967_) [n:127.0.0.1:60967_    
] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live 
nodes size: [0])
   [junit4]   2> 257773 INFO  
(zkCallback-180-thread-1-processing-n:127.0.0.1:60967_) [n:127.0.0.1:60967_    
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 257797 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.CoreContainer Security conf doesn't exist. 
Skipping setup for authorization module.
   [junit4]   2> 257797 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 257798 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.CorePropertiesLocator Looking for core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/control-001/cores
   [junit4]   2> 257798 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.CoreDescriptor Created CoreDescriptor: 
{name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, 
loadOnStartup=true, configSetProperties=configsetprops.json, 
collection=control_collection, coreNodeName=, dataDir=data/, shard=}
   [junit4]   2> 257798 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.CorePropertiesLocator Found core collection1 
in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/control-001/cores/collection1
   [junit4]   2> 257799 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
   [junit4]   2> 257808 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection   x:collection1] o.a.s.c.ZkController 
publishing state=down
   [junit4]   2> 257808 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection   x:collection1] o.a.s.c.ZkController 
numShards not found on descriptor - reading it from system property
   [junit4]   2> 257810 INFO  
(OverseerStateUpdate-96104653177028612-127.0.0.1:60967_-n_0000000000) 
[n:127.0.0.1:60967_    ] o.a.s.c.Overseer processMessage: queueSize: 1, message 
= {
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:60967";,
   [junit4]   2>   "node_name":"127.0.0.1:60967_",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":null,
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 257810 INFO  
(OverseerStateUpdate-96104653177028612-127.0.0.1:60967_-n_0000000000) 
[n:127.0.0.1:60967_    ] o.a.s.c.o.ReplicaMutator Update state numShards=1 
message={
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:60967";,
   [junit4]   2>   "node_name":"127.0.0.1:60967_",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":null,
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 257810 INFO  
(OverseerStateUpdate-96104653177028612-127.0.0.1:60967_-n_0000000000) 
[n:127.0.0.1:60967_    ] o.a.s.c.o.ClusterStateMutator building a new cName: 
control_collection
   [junit4]   2> 257811 INFO  
(OverseerStateUpdate-96104653177028612-127.0.0.1:60967_-n_0000000000) 
[n:127.0.0.1:60967_    ] o.a.s.c.o.ReplicaMutator Assigning new node to shard 
shard=shard1
   [junit4]   2> 257812 INFO  
(zkCallback-180-thread-1-processing-n:127.0.0.1:60967_) [n:127.0.0.1:60967_    
] 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> 257816 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection   x:collection1] o.a.s.c.ZkController 
Collection control_collection not visible yet, but flagging it so a watch is 
registered when it becomes visible
   [junit4]   2> 257824 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader Deleting data for [control_collection]
   [junit4]   2> 257985 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.s.SolrDispatchFilter 
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2
   [junit4]   2> 257985 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:60967_    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() 
done
   [junit4]   2> 258000 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection   x:collection1] o.a.s.c.ZkController 
look for our core node name
   [junit4]   2> 258000 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection   x:collection1] o.a.s.c.ZkController 
waiting to find shard id in clusterstate for collection1
   [junit4]   2> 258000 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection   x:collection1] o.a.s.c.ZkController 
Check for collection zkNode:control_collection
   [junit4]   2> 258001 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection   x:collection1] o.a.s.c.ZkController 
Collection zkNode exists
   [junit4]   2> 258001 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader Load collection config from: 
[/collections/control_collection]
   [junit4]   2> 258002 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader path=[/collections/control_collection] 
[configName]=[conf1] specified config exists in ZooKeeper
   [junit4]   2> 258002 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/control-001/cores/collection1'
   [junit4]   2> 258002 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 258002 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 258003 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection   x:collection1] o.a.s.c.Config loaded 
config solrconfig.xml with version 0 
   [junit4]   2> 258018 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection   x:collection1] o.a.s.c.SolrConfig 
current version of requestparams : -1
   [junit4]   2> 258021 WARN  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection   x:collection1] o.a.s.c.Config 
Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> 
instead.
   [junit4]   2> 258032 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection   x:collection1] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 6.2.0
   [junit4]   2> 258045 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection   x:collection1] o.a.s.c.SolrConfig 
Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 258049 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection   x:collection1] o.a.s.s.IndexSchema 
[collection1] Schema name=test
   [junit4]   2> 258134 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Initialized with 
rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 258139 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection   x:collection1] o.a.s.s.IndexSchema 
default search field in schema is text
   [junit4]   2> 258140 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection   x:collection1] o.a.s.s.IndexSchema 
unique key field: id
   [junit4]   2> 258154 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection   x:collection1] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 258156 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection   x:collection1] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 258157 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 258157 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 258158 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection   x:collection1] 
o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default 
properties: Can't find resource 'configsetprops.json' in classpath or 
'/configs/conf1', 
cwd=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2
   [junit4]   2> 258158 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection   x:collection1] o.a.s.c.CoreContainer 
Creating SolrCore 'collection1' using configuration from collection 
control_collection
   [junit4]   2> 258158 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 258158 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/control-001/cores/collection1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/control-001/cores/collection1/data/]
   [junit4]   2> 258158 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ 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@7ea635e2
   [junit4]   2> 258159 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.CachingDirectoryFactory return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/control-001/cores/collection1/data
   [junit4]   2> 258159 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrCore New index directory detected: old=null 
new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/control-001/cores/collection1/data/index/
   [junit4]   2> 258159 WARN  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrCore [collection1] Solr index directory 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/control-001/cores/collection1/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 258159 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.CachingDirectoryFactory return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/control-001/cores/collection1/data/index
   [junit4]   2> 258159 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ 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=46, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=1.6826171875, noCFSRatio=0.0]
   [junit4]   2> 258164 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>        
commit{dir=MockDirectoryWrapper(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/index-SimpleFSDirectory-001
 
lockFactory=org.apache.lucene.store.NativeFSLockFactory@6806428d),segFN=segments_1,generation=1}
   [junit4]   2> 258165 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 258167 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"nodistrib"
   [junit4]   2> 258167 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"dedupe"
   [junit4]   2> 258167 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 258167 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"stored_sig"
   [junit4]   2> 258167 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 258167 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ 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> 258167 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ 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> 258167 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ 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> 258167 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ 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> 258167 WARN  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = 
requestHandler,name = /dump,class = DumpRequestHandler,args = 
{defaults={a=A,b=B}}}
   [junit4]   2> 258168 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 258169 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 258170 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 258170 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 258174 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.RequestHandlers Registered paths: 
/admin/mbeans,standard,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/dump,/update/csv,/sql,/graph,/admin/segments,/admin/system,/replication,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file
   [junit4]   2> 258174 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ 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> 258175 INFO  
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:60967_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore 
Looking for old index directories to cleanup for core collection1 in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/control-001/cores/collection1/data/
   [junit4]   2> 258175 WARN  
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:60967_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.DirectoryFactory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/control-001/cores/collection1/data/
 does not point to a valid data directory; skipping clean-up of old index 
directories.
   [junit4]   2> 258176 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ 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> 258176 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ 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> 258177 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 258177 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 258177 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ 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=12, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.7650192623566264]
   [junit4]   2> 258178 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>        
commit{dir=MockDirectoryWrapper(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/index-SimpleFSDirectory-001
 
lockFactory=org.apache.lucene.store.NativeFSLockFactory@6806428d),segFN=segments_1,generation=1}
   [junit4]   2> 258178 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 258178 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@7753b578[collection1] main]
   [junit4]   2> 258179 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ 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> 258179 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ 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> 258179 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ 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> 258180 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 258180 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.r.RestManager Initializing RestManager with initArgs: {}
   [junit4]   2> 258180 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ 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> 258180 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ 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> 258180 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ 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> 258180 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 258180 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 258180 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ 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> 258180 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ 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> 258181 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ 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> 258181 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ 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 1537674451747864576
   [junit4]   2> 258182 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.UpdateLog Took 1.0ms to seed version buckets with highest version 
1537674451747864576
   [junit4]   2> 258182 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ZkController watch zkdir /configs/conf1
   [junit4]   2> 258183 INFO  
(coreLoadExecutor-422-thread-1-processing-n:127.0.0.1:60967_) 
[n:127.0.0.1:60967_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 258183 INFO  
(searcherExecutor-423-thread-1-processing-n:127.0.0.1:60967_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60967_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore 
[collection1] Registered new searcher Searcher@7753b578[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 258184 INFO  
(coreZkRegister-416-thread-1-processing-n:127.0.0.1:60967_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60967_ 
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:60967 
collection:control_collection shard:shard1
   [junit4]   2> 258184 INFO  
(coreZkRegister-416-thread-1-processing-n:127.0.0.1:60967_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60967_ 
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> 258186 INFO  
(coreZkRegister-416-thread-1-processing-n:127.0.0.1:60967_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60967_ 
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/96104653177028612-core_node1-n_0000000000
   [junit4]   2> 258186 INFO  
(coreZkRegister-416-thread-1-processing-n:127.0.0.1:60967_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60967_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ShardLeaderElectionContext Running the leader process for shard=shard1 
and weAreReplacement=false and leaderVoteWait=10000
   [junit4]   2> 258187 INFO  
(coreZkRegister-416-thread-1-processing-n:127.0.0.1:60967_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60967_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 258187 INFO  
(coreZkRegister-416-thread-1-processing-n:127.0.0.1:60967_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60967_ 
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> 258187 INFO  
(coreZkRegister-416-thread-1-processing-n:127.0.0.1:60967_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60967_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy 
Sync replicas to http://127.0.0.1:60967/collection1/
   [junit4]   2> 258187 INFO  
(coreZkRegister-416-thread-1-processing-n:127.0.0.1:60967_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60967_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 258187 INFO  
(coreZkRegister-416-thread-1-processing-n:127.0.0.1:60967_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60967_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy 
http://127.0.0.1:60967/collection1/ has no replicas
   [junit4]   2> 258187 INFO  
(OverseerStateUpdate-96104653177028612-127.0.0.1:60967_-n_0000000000) 
[n:127.0.0.1:60967_    ] 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> 258188 INFO  
(coreZkRegister-416-thread-1-processing-n:127.0.0.1:60967_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60967_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1
   [junit4]   2> 258189 INFO  
(coreZkRegister-416-thread-1-processing-n:127.0.0.1:60967_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60967_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node 
/collections/control_collection/leaders/shard1/leader after winning as 
/collections/control_collection/leader_elect/shard1/election/96104653177028612-core_node1-n_0000000000
   [junit4]   2> 258190 INFO  
(coreZkRegister-416-thread-1-processing-n:127.0.0.1:60967_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60967_ 
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:60967/collection1/ shard1
   [junit4]   2> 258191 INFO  
(OverseerStateUpdate-96104653177028612-127.0.0.1:60967_-n_0000000000) 
[n:127.0.0.1:60967_    ] 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:60967";,
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "state":"active"} current state version: 1
   [junit4]   2> 258293 INFO  
(zkCallback-180-thread-1-processing-n:127.0.0.1:60967_) [n:127.0.0.1:60967_    
] 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> 258384 INFO  
(coreZkRegister-416-thread-1-processing-n:127.0.0.1:60967_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60967_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
We are http://127.0.0.1:60967/collection1/ and leader is 
http://127.0.0.1:60967/collection1/
   [junit4]   2> 258384 INFO  
(coreZkRegister-416-thread-1-processing-n:127.0.0.1:60967_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60967_ 
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:60967
   [junit4]   2> 258384 INFO  
(coreZkRegister-416-thread-1-processing-n:127.0.0.1:60967_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60967_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
I am the leader, no recovery necessary
   [junit4]   2> 258384 INFO  
(coreZkRegister-416-thread-1-processing-n:127.0.0.1:60967_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60967_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
publishing state=active
   [junit4]   2> 258384 INFO  
(coreZkRegister-416-thread-1-processing-n:127.0.0.1:60967_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60967_ 
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> 258392 INFO  
(OverseerStateUpdate-96104653177028612-127.0.0.1:60967_-n_0000000000) 
[n:127.0.0.1:60967_    ] o.a.s.c.Overseer processMessage: queueSize: 1, message 
= {
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "core_node_name":"core_node1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:60967";,
   [junit4]   2>   "node_name":"127.0.0.1:60967_",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"} current state version: 2
   [junit4]   2> 258392 INFO  
(OverseerStateUpdate-96104653177028612-127.0.0.1:60967_-n_0000000000) 
[n:127.0.0.1:60967_    ] o.a.s.c.o.ReplicaMutator Update state numShards=1 
message={
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "core_node_name":"core_node1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:60967";,
   [junit4]   2>   "node_name":"127.0.0.1:60967_",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 258486 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.s.i.CloudSolrClient Final constructed zkHost string: 
127.0.0.1:58662/solr
   [junit4]   2> 258487 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 258494 INFO  
(zkCallback-180-thread-2-processing-n:127.0.0.1:60967_) [n:127.0.0.1:60967_    
] 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> 258496 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 258498 INFO  (zkCallback-184-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@1ee23908 
name:ZooKeeperConnection Watcher:127.0.0.1:58662/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 258498 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 258498 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 258498 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 258498 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 258498 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 258499 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection 
loss:false
   [junit4]   2> 258558 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/shard-1-001/cores/collection1
   [junit4]   2> 258559 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/shard-1-001
   [junit4]   2> 258560 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 258564 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@45875388{/,null,AVAILABLE}
   [junit4]   2> 258565 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@2254da9f{HTTP/1.1,[http/1.1]}{127.0.0.1:42627}
   [junit4]   2> 258565 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.e.j.s.Server Started @262032ms
   [junit4]   2> 258565 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/tempDir-001/jetty1,
 solrconfig=solrconfig.xml, hostContext=/, hostPort=42627, 
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/shard-1-001/cores}
   [junit4]   2> 258565 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@73d16e93
   [junit4]   2> 258565 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/shard-1-001'
   [junit4]   2> 258565 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 258565 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 258566 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 258566 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 258573 INFO  (zkCallback-185-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@1d781b68 
name:ZooKeeperConnection Watcher:127.0.0.1:58662/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 258573 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 258574 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 258576 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 258576 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/shard-1-001/solr.xml
   [junit4]   2> 258580 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.CorePropertiesLocator Config-defined core root directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/shard-1-001/cores
   [junit4]   2> 258580 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.CoreContainer New CoreContainer 553688482
   [junit4]   2> 258580 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/shard-1-001]
   [junit4]   2> 258580 WARN  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.CoreContainer Couldn't add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/shard-1-001/lib
 to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/shard-1-001/lib
   [junit4]   2> 258580 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
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> 258581 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 258581 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 258581 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.l.LogWatcher Registering Log Listener [Log4j 
(org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 258581 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58662/solr
   [junit4]   2> 258581 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.ZkController zkHost includes chroot
   [junit4]   2> 258581 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 258584 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 258591 INFO  (zkCallback-188-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@68aa53fc 
name:ZooKeeperConnection Watcher:127.0.0.1:58662 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 258595 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 258596 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 258605 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:42627_    ] o.a.s.c.ZkController Added new OnReconnect listener 
org.apache.solr.cloud.ZkController$$Lambda$18/1514911253@eef5de1
   [junit4]   2> 258605 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:42627_    ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 258616 INFO  
(zkCallback-189-thread-1-processing-n:127.0.0.1:42627_) [n:127.0.0.1:42627_    
] o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@4fa71f28 
name:ZooKeeperConnection Watcher:127.0.0.1:58662/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 258616 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:42627_    ] o.a.s.c.c.ConnectionManager Client is connected to 
ZooKeeper
   [junit4]   2> 258620 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:42627_    ] o.a.s.c.c.ZkStateReader Updating cluster state from 
ZooKeeper... 
   [junit4]   2> 258621 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:42627_    ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 258621 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:42627_    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 258625 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:42627_    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 258625 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:42627_    ] o.a.s.c.LeaderElector Joined leadership election with 
path: /overseer_elect/election/96104653177028616-127.0.0.1:42627_-n_0000000001
   [junit4]   2> 258625 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:42627_    ] o.a.s.c.LeaderElector Watching path 
/overseer_elect/election/96104653177028612-127.0.0.1:60967_-n_0000000000 to 
know if I could be the leader
   [junit4]   2> 258625 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:42627_    ] o.a.s.c.ZkController Publish node=127.0.0.1:42627_ as 
DOWN
   [junit4]   2> 258626 INFO  
(OverseerStateUpdate-96104653177028612-127.0.0.1:60967_-n_0000000000) 
[n:127.0.0.1:60967_    ] o.a.s.c.Overseer processMessage: queueSize: 1, message 
= {
   [junit4]   2>   "operation":"downnode",
   [junit4]   2>   "node_name":"127.0.0.1:42627_"} current state version: 3
   [junit4]   2> 258627 INFO  
(OverseerStateUpdate-96104653177028612-127.0.0.1:60967_-n_0000000000) 
[n:127.0.0.1:60967_    ] o.a.s.c.o.NodeMutator DownNode state invoked for node: 
127.0.0.1:42627_
   [junit4]   2> 258728 INFO  
(zkCallback-189-thread-1-processing-n:127.0.0.1:42627_) [n:127.0.0.1:42627_    
] 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> 258728 INFO  (zkCallback-184-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> 258729 INFO  
(zkCallback-180-thread-1-processing-n:127.0.0.1:60967_) [n:127.0.0.1:60967_    
] 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> 259626 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:42627_    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:42627_
   [junit4]   2> 259627 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:42627_    ] o.a.s.c.c.SolrZkClient makePath: 
/live_nodes/127.0.0.1:42627_
   [junit4]   2> 259628 INFO  
(zkCallback-180-thread-1-processing-n:127.0.0.1:60967_) [n:127.0.0.1:60967_    
] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live 
nodes size: [1])
   [junit4]   2> 259628 INFO  (zkCallback-184-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live 
nodes size: [1])
   [junit4]   2> 259629 INFO  (zkCallback-184-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 259629 INFO  
(zkCallback-180-thread-1-processing-n:127.0.0.1:60967_) [n:127.0.0.1:60967_    
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 259629 INFO  
(zkCallback-189-thread-1-processing-n:127.0.0.1:42627_) [n:127.0.0.1:42627_    
] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live 
nodes size: [1])
   [junit4]   2> 259629 INFO  
(zkCallback-189-thread-1-processing-n:127.0.0.1:42627_) [n:127.0.0.1:42627_    
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 259639 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:42627_    ] o.a.s.c.CoreContainer Security conf doesn't exist. 
Skipping setup for authorization module.
   [junit4]   2> 259640 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:42627_    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 259640 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:42627_    ] o.a.s.c.CorePropertiesLocator Looking for core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/shard-1-001/cores
   [junit4]   2> 259641 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:42627_    ] o.a.s.c.CoreDescriptor Created CoreDescriptor: 
{name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, 
loadOnStartup=true, configSetProperties=configsetprops.json, 
collection=collection1, coreNodeName=, dataDir=data/, shard=}
   [junit4]   2> 259641 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:42627_    ] o.a.s.c.CorePropertiesLocator Found core collection1 
in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/shard-1-001/cores/collection1
   [junit4]   2> 259641 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:42627_    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
   [junit4]   2> 259642 INFO  
(coreLoadExecutor-433-thread-1-processing-n:127.0.0.1:42627_) 
[n:127.0.0.1:42627_ c:collection1   x:collection1] o.a.s.c.ZkController 
publishing state=down
   [junit4]   2> 259643 INFO  
(coreLoadExecutor-433-thread-1-processing-n:127.0.0.1:42627_) 
[n:127.0.0.1:42627_ c:collection1   x:collection1] o.a.s.c.ZkController 
numShards not found on descriptor - reading it from system property
   [junit4]   2> 259643 INFO  
(OverseerStateUpdate-96104653177028612-127.0.0.1:60967_-n_0000000000) 
[n:127.0.0.1:60967_    ] o.a.s.c.Overseer processMessage: queueSize: 1, message 
= {
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:42627";,
   [junit4]   2>   "node_name":"127.0.0.1:42627_",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":null,
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "operation":"state"} current state version: 4
   [junit4]   2> 259643 INFO  
(OverseerStateUpdate-96104653177028612-127.0.0.1:60967_-n_0000000000) 
[n:127.0.0.1:60967_    ] o.a.s.c.o.ReplicaMutator Update state numShards=2 
message={
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:42627";,
   [junit4]   2>   "node_name":"127.0.0.1:42627_",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":null,
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 259644 INFO  
(OverseerStateUpdate-96104653177028612-127.0.0.1:60967_-n_0000000000) 
[n:127.0.0.1:60967_    ] o.a.s.c.o.ClusterStateMutator building a new cName: 
collection1
   [junit4]   2> 259644 INFO  
(OverseerStateUpdate-96104653177028612-127.0.0.1:60967_-n_0000000000) 
[n:127.0.0.1:60967_    ] o.a.s.c.o.ReplicaMutator Assigning new node to shard 
shard=shard2
   [junit4]   2> 259645 INFO  
(coreLoadExecutor-433-thread-1-processing-n:127.0.0.1:42627_) 
[n:127.0.0.1:42627_ c:collection1   x:collection1] o.a.s.c.ZkController 
Collection collection1 not visible yet, but flagging it so a watch is 
registered when it becomes visible
   [junit4]   2> 259645 INFO  
(coreLoadExecutor-433-thread-1-processing-n:127.0.0.1:42627_) 
[n:127.0.0.1:42627_ c:collection1   x:collection1] o.a.s.c.c.ZkStateReader 
Deleting data for [collection1]
   [junit4]   2> 259649 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:42627_    ] o.a.s.s.SolrDispatchFilter 
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2
   [junit4]   2> 259649 INFO  
(TEST-TestNamedUpdateProcessors.test-seed#[E7B830774568D30B]) 
[n:127.0.0.1:42627_    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() 
done
   [junit4]   2> 259649 INFO  
(coreLoadExecutor-433-thread-1-processing-n:127.0.0.1:42627_) 
[n:127.0.0.1:42627_ c:collection1   x:collection1] o.a.s.c.ZkController look 
for our core node name
   [junit4]   2> 259745 INFO  (zkCallback-184-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred 
- updating... (live nodes size: [2])
   [junit4]   2> 259746 INFO  
(zkCallback-189-thread-1-processing-n:127.0.0.1:42627_) [n:127.0.0.1:42627_    
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred 
- updating... (live nodes size: [2])
   [junit4]   2> 259746 INFO  
(zkCallback-180-thread-2-processing-n:127.0.0.1:60967_) [n:127.0.0.1:60967_    
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred 
- updating... (live nodes size: [2])
   [junit4]   2> 260651 INFO  
(coreLoadExecutor-433-thread-1-processing-n:127.0.0.1:42627_) 
[n:127.0.0.1:42627_ c:collection1   x:collection1] o.a.s.c.ZkController waiting 
to find shard id in clusterstate for collection1
   [junit4]   2> 260651 INFO  
(coreLoadExecutor-433-thread-1-processing-n:127.0.0.1:42627_) 
[n:127.0.0.1:42627_ c:collection1   x:collection1] o.a.s.c.ZkController Check 
for collection zkNode:collection1
   [junit4]   2> 260651 INFO  
(coreLoadExecutor-433-thread-1-processing-n:127.0.0.1:42627_) 
[n:127.0.0.1:42627_ c:collection1   x:collection1] o.a.s.c.ZkController 
Collection zkNode exists
   [junit4]   2> 260651 INFO  
(coreLoadExecutor-433-thread-1-processing-n:127.0.0.1:42627_) 
[n:127.0.0.1:42627_ c:collection1   x:collection1] o.a.s.c.c.ZkStateReader Load 
collection config from: [/collections/collection1]
   [junit4]   2> 260653 INFO  
(coreLoadExecutor-433-thread-1-processing-n:127.0.0.1:42627_) 
[n:127.0.0.1:42627_ c:collection1   x:collection1] o.a.s.c.c.ZkStateReader 
path=[/collections/collection1] [configName]=[conf1] specified config exists in 
ZooKeeper
   [junit4]   2> 260653 INFO  
(coreLoadExecutor-433-thread-1-processing-n:127.0.0.1:42627_) 
[n:127.0.0.1:42627_ c:collection1   x:collection1] o.a.s.c.SolrResourceLoader 
new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.update.processor.TestNamedUpdateProcessors_E7B830774568D30B-001/shard-1-001/cores/collection1'
   [junit4]   2> 260654 INFO  
(coreLoadExecutor-433-thread-1-processing-n:127.0.0.1:42627_) 
[n:127.0.0.1:42627_ c:collection1   x:collection1] o.a.s.c.SolrResourceLoader 
JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 260654 INFO  
(coreLoadExecutor-433-thread-1-processing-n:127.0.0.1:42627_) 
[n:127.0.0.1:42627_ c:collection1   x:collection1] o.a.s.c.SolrResourceLoader 
solr home defaulted to 'solr/' (could not find system property or JNDI)
   [junit4]   2> 260657 INFO  
(coreLoadExecutor-433-thread-1-processing-n:127.0.0.1:42627_) 
[n:127.0.0.1:42627_ c:collection1   x:collection1] o.a.s.c.Config loaded config 
solrconfig.xml with version 0 
   [junit4]   2> 260662 INFO  
(coreLoadExecutor-433-thread-1-processing-n:127.0.0.1:42627_) 
[n:127.0.0.1:42627_ c:collection1   x:collection1] o.a.s.c.SolrConfig current 
version of requestparams : -1
   [junit4]   2> 260665 WARN  
(coreLoadExecutor-433-thread-1-processing-n:127.0.0.1:42627_) 
[n:127.0.0.1:42627_ c:collection1   x:collection1] o.a.s.c.Config Beginning 
with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 260665 INFO  
(coreLoadExecutor-433-thread-1-processing-n:127.0.0.1:42627_) 
[n:127.0.0.1:42627_ c:collection1   x:collection1] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 6.2.0
   [junit4]   2> 260675 INFO  
(coreLoadExecutor-433-thread-1-processing-n:127.0.0.1:42627_) 
[n:127.0.0.1:42627_ c:collection1   x:collection1] o.a.s.c.SolrConfig Loaded 
SolrConfig: solrconfig.xml
   [junit4]   2> 260679 INFO  
(coreLoadExecutor-433-thread-1-processing-n:127.0.0.1:42627_) 
[n:127.0.0.1:42627_ c:collection1   x:collection1] o.a.s.s.IndexSchema 
[collection1] Schema name=test
   [junit4]   2> 260744 INFO  
(coreLoadExecutor-433-thread-1-processing-n:127.0.0.1:42627_) 
[n:127.0.0.1:42627_ c:collection1   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Initialized with 
rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 260749 INFO  
(coreLoadExecutor-433-thread-1-processing-n:127.0.0.1:42627_) 
[n:127.0.0.1:42627_ c:collection1   x:collection1] o.a.s.s.IndexSchema default 
search field in schema is text
   [junit4]   2> 260750 INFO  
(coreLoadExecutor-433-thread-1-processing-n:127.0.0.1:42627_) 
[n:127.0.0.1:42627_ c:collection1   x:collection1] o.a.s.s.IndexSchema unique 
key field: id
   [junit4]   2> 260756 INFO  (co

[...truncated too long message...]

g-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-collective-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-event-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-exception-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-journal-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-normalization-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-operational-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-referral-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-schema-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-subtree-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-trigger-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-jdbm-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-jdbm1-2.0.0-M2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-kerberos-codec-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-ldif-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-mavibot-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-protocol-kerberos-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-protocol-ldap-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-protocol-shared-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-xdbm-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/api-all-1.0.0-M20.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/bcprov-jdk15-1.45.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/cglib-nodep-2.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/commons-collections-3.2.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/commons-math3-3.4.1.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/easymock-3.0.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/ehcache-core-2.4.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/hadoop-common-2.6.0-tests.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/hadoop-hdfs-2.6.0-tests.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/hadoop-minikdc-2.6.0.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jackson-annotations-2.5.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jackson-databind-2.5.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jersey-core-1.9.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jersey-server-1.9.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jetty-6.1.26.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jetty-util-6.1.26.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/mina-core-2.0.0-M5.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/mockito-core-1.9.5.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/objenesis-1.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/presto-parser-0.122.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/slice-0.10.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/build/analysis/icu/lucene-analyzers-icu-6.2.0-SNAPSHOT.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/contrib/solr-analysis-extras/classes/java:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/build/queryparser/classes/test:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/contrib/analysis-extras/lib/icu4j-56.1.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-launcher.jar:/x1/jenkins/.ant/lib/ivy-2.3.0.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-antlr.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-regexp.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-resolver.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-commons-net.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jmf.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-oro.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-xalan2.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-commons-logging.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jsch.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-junit4.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-javamail.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jai.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jdepend.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-junit.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-bsf.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-swing.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-netrexx.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-bcel.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-testutil.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-log4j.jar:/x1/jenkins/jenkins-slave/tools/hudson.model.JDK/latest1.8/lib/tools.jar:/x1/jenkins/.ivy2/cache/com.carrotsearch.randomizedtesting/junit4-ant/jars/junit4-ant-2.3.4.jar
 com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe -eventsfile 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/temp/junit4-J1-20160620_163249_927.events
 
@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/temp/junit4-J1-20160620_163249_927.suites
 -stdin
   [junit4] ERROR: JVM J1 ended with an exception: Quit event not received from 
the forked process? This may indicate JVM crash or runner bugs.
   [junit4]     at 
com.carrotsearch.ant.tasks.junit4.JUnit4.executeSlave(JUnit4.java:1501)
   [junit4]     at 
com.carrotsearch.ant.tasks.junit4.JUnit4.access$000(JUnit4.java:121)
   [junit4]     at 
com.carrotsearch.ant.tasks.junit4.JUnit4$2.call(JUnit4.java:955)
   [junit4]     at 
com.carrotsearch.ant.tasks.junit4.JUnit4$2.call(JUnit4.java:952)
   [junit4]     at java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]     at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
   [junit4]     at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   [junit4]     at java.lang.Thread.run(Thread.java:745)

BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:747: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:684: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:59: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build.xml:233:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/common-build.xml:530:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:1427:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:984:
 At least one slave process threw an exception, first: Quit event not received 
from the forked process? This may indicate JVM crash or runner bugs.

Total time: 291 minutes 48 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

Reply via email to