Build: https://builds.apache.org/job/Lucene-Solr-Tests-5.2-Java7/19/

1 tests failed.
REGRESSION:  org.apache.solr.search.mlt.CloudMLTQParserTest.test

Error Message:
java.lang.String cannot be cast to java.util.ArrayList

Stack Trace:
java.lang.ClassCastException: java.lang.String cannot be cast to 
java.util.ArrayList
        at 
__randomizedtesting.SeedInfo.seed([C2022EB9223D4C4B:4A5611638CC121B3]:0)
        at 
org.apache.solr.search.mlt.CloudMLTQParserTest.test(CloudMLTQParserTest.java:138)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:606)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:960)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:935)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792)
        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:46)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
        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:54)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
        at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 9592 lines...]
   [junit4] Suite: org.apache.solr.search.mlt.CloudMLTQParserTest
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/init-core-data-001
   [junit4]   2> 334664 T1751 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl 
(true) and clientAuth (true)
   [junit4]   2> 334665 T1751 oas.BaseDistributedSearchTestCase.initHostContext 
Setting hostContext system property: /
   [junit4]   2> 334675 T1751 oasc.ZkTestServer.run STARTING ZK TEST SERVER
   [junit4]   2> 334678 T1752 oasc.ZkTestServer$2$1.setClientPort client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 334678 T1752 oasc.ZkTestServer$ZKServerMain.runFromConfig 
Starting server
   [junit4]   2> 334778 T1751 oasc.ZkTestServer.run start zk server on 
port:38819
   [junit4]   2> 334778 T1751 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 334779 T1751 oascc.ConnectionManager.waitForConnected Waiting 
for client to connect to ZooKeeper
   [junit4]   2> 334781 T1759 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@55a0c087 
name:ZooKeeperConnection Watcher:127.0.0.1:38819 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 334781 T1751 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 334781 T1751 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 334782 T1751 oascc.SolrZkClient.makePath makePath: /solr
   [junit4]   2> 334786 T1751 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 334793 T1751 oascc.ConnectionManager.waitForConnected Waiting 
for client to connect to ZooKeeper
   [junit4]   2> 334794 T1762 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@31f7489 name:ZooKeeperConnection 
Watcher:127.0.0.1:38819/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 334794 T1751 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 334794 T1751 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 334795 T1751 oascc.SolrZkClient.makePath makePath: 
/collections/collection1
   [junit4]   2> 334797 T1751 oascc.SolrZkClient.makePath makePath: 
/collections/collection1/shards
   [junit4]   2> 334799 T1751 oascc.SolrZkClient.makePath makePath: 
/collections/control_collection
   [junit4]   2> 334800 T1751 oascc.SolrZkClient.makePath makePath: 
/collections/control_collection/shards
   [junit4]   2> 334802 T1751 oasc.AbstractZkTestCase.putConfig put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/core/src/test-files/solr/collection1/conf/solrconfig.xml
 to /configs/conf1/solrconfig.xml
   [junit4]   2> 334802 T1751 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/solrconfig.xml
   [junit4]   2> 334805 T1751 oasc.AbstractZkTestCase.putConfig put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/core/src/test-files/solr/collection1/conf/schema.xml
 to /configs/conf1/schema.xml
   [junit4]   2> 334806 T1751 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/schema.xml
   [junit4]   2> 334808 T1751 oasc.AbstractZkTestCase.putConfig put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 334808 T1751 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 334810 T1751 oasc.AbstractZkTestCase.putConfig put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf1/stopwords.txt
   [junit4]   2> 334810 T1751 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/stopwords.txt
   [junit4]   2> 334812 T1751 oasc.AbstractZkTestCase.putConfig put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf1/protwords.txt
   [junit4]   2> 334812 T1751 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/protwords.txt
   [junit4]   2> 334814 T1751 oasc.AbstractZkTestCase.putConfig put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf1/currency.xml
   [junit4]   2> 334814 T1751 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/currency.xml
   [junit4]   2> 334817 T1751 oasc.AbstractZkTestCase.putConfig put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf1/enumsConfig.xml
   [junit4]   2> 334817 T1751 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/enumsConfig.xml
   [junit4]   2> 334819 T1751 oasc.AbstractZkTestCase.putConfig put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 334819 T1751 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/open-exchange-rates.json
   [junit4]   2> 334822 T1751 oasc.AbstractZkTestCase.putConfig put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 334822 T1751 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 334825 T1751 oasc.AbstractZkTestCase.putConfig put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf1/old_synonyms.txt
   [junit4]   2> 334826 T1751 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/old_synonyms.txt
   [junit4]   2> 334829 T1751 oasc.AbstractZkTestCase.putConfig put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf1/synonyms.txt
   [junit4]   2> 334829 T1751 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/synonyms.txt
   [junit4]   2> 334833 T1751 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 334841 T1751 oascc.ConnectionManager.waitForConnected Waiting 
for client to connect to ZooKeeper
   [junit4]   2> 334841 T1765 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@7dc2aebb 
name:ZooKeeperConnection Watcher:127.0.0.1:38819/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 334841 T1751 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 334842 T1751 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 335206 T1751 oas.SolrTestCaseJ4.writeCoreProperties Writing 
core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/control-001/cores/collection1
   [junit4]   2> 335209 T1751 oejs.Server.doStart jetty-9.2.10.v20150310
   [junit4]   2> 335214 T1751 oejsh.ContextHandler.doStart Started 
o.e.j.s.ServletContextHandler@34e30af5{/,null,AVAILABLE}
   [junit4]   2> 335226 T1751 oejs.AbstractConnector.doStart Started 
ServerConnector@5a1875df{SSL-http/1.1}{127.0.0.1:59895}
   [junit4]   2> 335226 T1751 oejs.Server.doStart Started @336919ms
   [junit4]   2> 335226 T1751 oascse.JettySolrRunner$1.lifeCycleStarted Jetty 
properties: 
{coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/control-001/cores, hostContext=/, hostPort=59895, 
solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/tempDir-001/control/data}
   [junit4]   2> 335228 T1751 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@72b5615d
   [junit4]   2> 335228 T1751 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/control-001/'
   [junit4]   2> 335243 T1751 oasc.SolrXmlConfig.fromFile Loading container 
configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/control-001/solr.xml
   [junit4]   2> 335258 T1751 oasc.CorePropertiesLocator.<init> Config-defined 
core root directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/control-001/cores
   [junit4]   2> 335258 T1751 oasc.CoreContainer.<init> New CoreContainer 
1481487736
   [junit4]   2> 335259 T1751 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/control-001/]
   [junit4]   2> 335259 T1751 oasc.CoreContainer.load loading shared library: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/control-001/lib
   [junit4]   2> 335259 T1751 oasc.SolrResourceLoader.addToClassLoader WARN 
Can't find (or read) directory to add to classloader: lib (resolved as: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/control-001/lib).
   [junit4]   2> 335267 T1751 oashc.HttpShardHandlerFactory.init 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> 335269 T1751 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 335271 T1751 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 335271 T1751 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 335271 T1751 oasc.CoreContainer.load Node Name: 127.0.0.1
   [junit4]   2> 335272 T1751 oasc.ZkContainer.initZooKeeper Zookeeper 
client=127.0.0.1:38819/solr
   [junit4]   2> 335272 T1751 oasc.ZkController.checkChrootPath zkHost includes 
chroot
   [junit4]   2> 335272 T1751 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 335278 T1751 oascc.ConnectionManager.waitForConnected Waiting 
for client to connect to ZooKeeper
   [junit4]   2> 335281 T1779 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@6883f5e4 
name:ZooKeeperConnection Watcher:127.0.0.1:38819 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 335282 T1751 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 335282 T1751 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 335284 T1751 n:127.0.0.1:59895_ 
oascc.ConnectionManager.waitForConnected Waiting for client to connect to 
ZooKeeper
   [junit4]   2> 335286 T1782 n:127.0.0.1:59895_ 
oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@77a621d8 
name:ZooKeeperConnection Watcher:127.0.0.1:38819/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 335286 T1751 n:127.0.0.1:59895_ 
oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 335290 T1751 n:127.0.0.1:59895_ oascc.SolrZkClient.makePath 
makePath: /overseer/queue
   [junit4]   2> 335298 T1751 n:127.0.0.1:59895_ oascc.SolrZkClient.makePath 
makePath: /overseer/collection-queue-work
   [junit4]   2> 335300 T1751 n:127.0.0.1:59895_ oascc.SolrZkClient.makePath 
makePath: /overseer/collection-map-running
   [junit4]   2> 335302 T1751 n:127.0.0.1:59895_ oascc.SolrZkClient.makePath 
makePath: /overseer/collection-map-completed
   [junit4]   2> 335304 T1751 n:127.0.0.1:59895_ oascc.SolrZkClient.makePath 
makePath: /overseer/collection-map-failure
   [junit4]   2> 335306 T1751 n:127.0.0.1:59895_ oascc.SolrZkClient.makePath 
makePath: /live_nodes
   [junit4]   2> 335307 T1751 n:127.0.0.1:59895_ oascc.SolrZkClient.makePath 
makePath: /aliases.json
   [junit4]   2> 335308 T1751 n:127.0.0.1:59895_ oascc.SolrZkClient.makePath 
makePath: /clusterstate.json
   [junit4]   2> 335309 T1751 n:127.0.0.1:59895_ 
oasc.ZkController.createEphemeralLiveNode Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:59895_
   [junit4]   2> 335310 T1751 n:127.0.0.1:59895_ oascc.SolrZkClient.makePath 
makePath: /live_nodes/127.0.0.1:59895_
   [junit4]   2> 335312 T1751 n:127.0.0.1:59895_ oascc.SolrZkClient.makePath 
makePath: /overseer_elect
   [junit4]   2> 335313 T1751 n:127.0.0.1:59895_ oascc.SolrZkClient.makePath 
makePath: /overseer_elect/election
   [junit4]   2> 335315 T1751 n:127.0.0.1:59895_ oasc.Overseer.close Overseer 
(id=null) closing
   [junit4]   2> 335317 T1751 n:127.0.0.1:59895_ 
oasc.OverseerElectionContext.runLeaderProcess I am going to be the leader 
127.0.0.1:59895_
   [junit4]   2> 335317 T1751 n:127.0.0.1:59895_ oascc.SolrZkClient.makePath 
makePath: /overseer_elect/leader
   [junit4]   2> 335319 T1751 n:127.0.0.1:59895_ oasc.Overseer.start Overseer 
(id=93910270714445828-127.0.0.1:59895_-n_0000000000) starting
   [junit4]   2> 335321 T1751 n:127.0.0.1:59895_ oascc.SolrZkClient.makePath 
makePath: /overseer/queue-work
   [junit4]   2> 335329 T1751 n:127.0.0.1:59895_ 
oasc.OverseerAutoReplicaFailoverThread.<init> Starting 
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=30000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 335341 T1784 n:127.0.0.1:59895_ 
oasc.OverseerCollectionProcessor.run Process current queue of collection 
creations
   [junit4]   2> 335341 T1783 n:127.0.0.1:59895_ 
oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
   [junit4]   2> 335348 T1751 n:127.0.0.1:59895_ 
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state 
from ZooKeeper... 
   [junit4]   2> 335351 T1751 n:127.0.0.1:59895_ 
oasc.CoreContainer.initializeAuthenticationPlugin No authentication plugin used.
   [junit4]   2> 335351 T1751 n:127.0.0.1:59895_ 
oasc.CoreContainer.intializeAuthorizationPlugin Security conf doesn't exist. 
Skipping setup for authorization module.
   [junit4]   2> 335353 T1751 n:127.0.0.1:59895_ 
oasc.CorePropertiesLocator.discover Looking for core definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/control-001/cores
   [junit4]   2> 335354 T1751 n:127.0.0.1:59895_ oasc.CoreDescriptor.<init> 
CORE DESCRIPTOR: {coreNodeName=, shard=, dataDir=data/, 
collection=control_collection, name=collection1, loadOnStartup=true, 
absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/control-001/cores/collection1/, schema=schema.xml, 
config=solrconfig.xml, 
instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/control-001/cores/collection1, transient=false}
   [junit4]   2> 335354 T1751 n:127.0.0.1:59895_ 
oasc.CorePropertiesLocator.discoverUnder Found core collection1 in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/control-001/cores/collection1/
   [junit4]   2> 335354 T1751 n:127.0.0.1:59895_ 
oasc.CorePropertiesLocator.discover Found 1 core definitions
   [junit4]   2> 335365 T1786 n:127.0.0.1:59895_ c:control_collection 
x:collection1 oasc.ZkController.publish publishing core=collection1 state=down 
collection=control_collection
   [junit4]   2> 335366 T1786 n:127.0.0.1:59895_ c:control_collection 
x:collection1 oasc.ZkController.publish numShards not found on descriptor - 
reading it from system property
   [junit4]   2> 335368 T1782 n:127.0.0.1:59895_ 
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path 
/overseer/queue state SyncConnected
   [junit4]   2> 335368 T1786 n:127.0.0.1:59895_ 
oasc.ZkController.waitForCoreNodeName look for our core node name
   [junit4]   2> 335369 T1783 n:127.0.0.1:59895_ 
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
   [junit4]   2>          "base_url":"https://127.0.0.1:59895";,
   [junit4]   2>          "shard":null,
   [junit4]   2>          "state":"down",
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "numShards":"1",
   [junit4]   2>          "collection":"control_collection",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "node_name":"127.0.0.1:59895_"} current state 
version: 0
   [junit4]   2> 335370 T1783 n:127.0.0.1:59895_ 
oasco.ReplicaMutator.updateState Update state numShards=1 message={
   [junit4]   2>          "base_url":"https://127.0.0.1:59895";,
   [junit4]   2>          "shard":null,
   [junit4]   2>          "state":"down",
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "numShards":"1",
   [junit4]   2>          "collection":"control_collection",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "node_name":"127.0.0.1:59895_"}
   [junit4]   2> 335370 T1783 n:127.0.0.1:59895_ 
oasco.ClusterStateMutator.createCollection building a new cName: 
control_collection
   [junit4]   2> 335370 T1783 n:127.0.0.1:59895_ 
oasco.ReplicaMutator.updateState Assigning new node to shard shard=shard1
   [junit4]   2> 335371 T1782 n:127.0.0.1:59895_ oascc.ZkStateReader$2.process 
A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
   [junit4]   2> 336369 T1786 n:127.0.0.1:59895_ 
oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for 
collection1
   [junit4]   2> 336370 T1786 n:127.0.0.1:59895_ 
oasc.ZkController.createCollectionZkNode Check for collection 
zkNode:control_collection
   [junit4]   2> 336370 T1786 n:127.0.0.1:59895_ 
oasc.ZkController.createCollectionZkNode Collection zkNode exists
   [junit4]   2> 336371 T1786 n:127.0.0.1:59895_ 
oascc.ZkStateReader.readConfigName Load collection config 
from:/collections/control_collection
   [junit4]   2> 336372 T1786 n:127.0.0.1:59895_ 
oascc.ZkStateReader.readConfigName path=/collections/control_collection 
configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 336372 T1786 n:127.0.0.1:59895_ oasc.SolrResourceLoader.<init> 
new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/control-001/cores/collection1/'
   [junit4]   2> 336388 T1786 n:127.0.0.1:59895_ oasc.Config.<init> loaded 
config solrconfig.xml with version 0 
   [junit4]   2> 336398 T1786 n:127.0.0.1:59895_ 
oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
   [junit4]   2> 336419 T1786 n:127.0.0.1:59895_ oasc.SolrConfig.<init> Using 
Lucene MatchVersion: 5.2.0
   [junit4]   2> 336474 T1786 n:127.0.0.1:59895_ oasc.SolrConfig.<init> Loaded 
SolrConfig: solrconfig.xml
   [junit4]   2> 336476 T1786 n:127.0.0.1:59895_ oass.IndexSchema.readSchema 
Reading Solr Schema from /configs/conf1/schema.xml
   [junit4]   2> 336484 T1786 n:127.0.0.1:59895_ oass.IndexSchema.readSchema 
[collection1] Schema name=test
   [junit4]   2> 336770 T1786 n:127.0.0.1:59895_ 
oass.OpenExchangeRatesOrgProvider.init Initialized with 
rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 336780 T1786 n:127.0.0.1:59895_ oass.IndexSchema.readSchema 
default search field in schema is text
   [junit4]   2> 336782 T1786 n:127.0.0.1:59895_ oass.IndexSchema.readSchema 
unique key field: id
   [junit4]   2> 336794 T1786 n:127.0.0.1:59895_ 
oass.FileExchangeRateProvider.reload Reloading exchange rates from file 
currency.xml
   [junit4]   2> 336800 T1786 n:127.0.0.1:59895_ 
oass.FileExchangeRateProvider.reload Reloading exchange rates from file 
currency.xml
   [junit4]   2> 336806 T1786 n:127.0.0.1:59895_ 
oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 336807 T1786 n:127.0.0.1:59895_ 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 336807 T1786 n:127.0.0.1:59895_ 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 336807 T1786 n:127.0.0.1:59895_ 
oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 336808 T1786 n:127.0.0.1:59895_ 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 336808 T1786 n:127.0.0.1:59895_ 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 336808 T1786 n:127.0.0.1:59895_ oasc.CoreContainer.create 
Creating SolrCore 'collection1' using configuration from collection 
control_collection
   [junit4]   2> 336809 T1786 n:127.0.0.1:59895_ x:collection1 
oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 336809 T1786 n:127.0.0.1:59895_ x:collection1 
oasc.SolrCore.<init> [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/control-001/cores/collection1/], dataDir=[null]
   [junit4]   2> 336809 T1786 n:127.0.0.1:59895_ x:collection1 
oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to 
JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@c23d097
   [junit4]   2> 336810 T1786 n:127.0.0.1:59895_ x:collection1 
oasc.CachingDirectoryFactory.get return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/control-001/cores/collection1/data
   [junit4]   2> 336810 T1786 n:127.0.0.1:59895_ x:collection1 
oasc.SolrCore.getNewIndexDir New index directory detected: old=null 
new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/control-001/cores/collection1/data/index/
   [junit4]   2> 336810 T1786 n:127.0.0.1:59895_ x:collection1 
oasc.SolrCore.initIndex WARN [collection1] Solr index directory 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/control-001/cores/collection1/data/index' doesn't exist. 
Creating new index...
   [junit4]   2> 336811 T1786 n:127.0.0.1:59895_ x:collection1 
oasc.CachingDirectoryFactory.get return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/control-001/cores/collection1/data/index
   [junit4]   2> 336811 T1786 n:127.0.0.1:59895_ x:collection1 
oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=30, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.36912042906390596]
   [junit4]   2> 336812 T1786 n:127.0.0.1:59895_ x:collection1 
oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@34ec4d8a 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5d6ba2b),segFN=segments_1,generation=1}
   [junit4]   2> 336812 T1786 n:127.0.0.1:59895_ x:collection1 
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 336818 T1786 n:127.0.0.1:59895_ x:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"dedupe"
   [junit4]   2> 336819 T1786 n:127.0.0.1:59895_ x:collection1 
oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 336819 T1786 n:127.0.0.1:59895_ x:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 336819 T1786 n:127.0.0.1:59895_ x:collection1 
oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 336819 T1786 n:127.0.0.1:59895_ x:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"stored_sig"
   [junit4]   2> 336820 T1786 n:127.0.0.1:59895_ x:collection1 
oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 336820 T1786 n:127.0.0.1:59895_ x:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"uniq-fields"
   [junit4]   2> 336820 T1786 n:127.0.0.1:59895_ x:collection1 
oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 336820 T1786 n:127.0.0.1:59895_ x:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"distrib-dup-test-chain-explicit"
   [junit4]   2> 336821 T1786 n:127.0.0.1:59895_ x:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 336821 T1786 n:127.0.0.1:59895_ x:collection1 
oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 336821 T1786 n:127.0.0.1:59895_ x:collection1 
oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined 
as default, creating implicit default
   [junit4]   2> 336825 T1786 n:127.0.0.1:59895_ x:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 336826 T1786 n:127.0.0.1:59895_ x:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 336828 T1786 n:127.0.0.1:59895_ x:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 336829 T1786 n:127.0.0.1:59895_ x:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 336835 T1786 n:127.0.0.1:59895_ x:collection1 
oasc.PluginBag.createPlugin requestHandler : 'lazy' created with startup=lazy 
   [junit4]   2> 336838 T1786 n:127.0.0.1:59895_ x:collection1 
oasc.RequestHandlers.initHandlersFromConfig Registered paths: 
/admin/segments,dismax,/admin/luke,/admin/ping,spellCheckWithWordbreak_Direct,mock,/get,/replication,/schema,/admin/mbeans,spellCheckCompRH,spellCheckCompRH1,/admin/threads,/update/csv,tvrh,/update,/debug/dump,/admin/plugins,/update/json,/mlt,/admin/properties,/search-facet-def,/config,/admin/file,spellCheckCompRH_Direct,spellCheckWithWordbreak,/admin/system,/terms,defaults,standard,/search-facet-invariants,lazy,/admin/logging,mltrh,/update/json/docs
   [junit4]   2> 336839 T1786 n:127.0.0.1:59895_ x:collection1 
oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated 
<admin/gettableFiles>, Please update your config to use the 
ShowFileRequestHandler.
   [junit4]   2> 336840 T1786 n:127.0.0.1:59895_ x:collection1 
oasc.SolrCore.initStatsCache Using default statsCache cache: 
org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 336841 T1786 n:127.0.0.1:59895_ x:collection1 
oasu.UpdateHandler.<init> Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 336841 T1786 n:127.0.0.1:59895_ x:collection1 
oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 336842 T1786 n:127.0.0.1:59895_ x:collection1 
oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 336842 T1786 n:127.0.0.1:59895_ x:collection1 
oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 336843 T1786 n:127.0.0.1:59895_ x:collection1 
oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=23, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6297962364776588]
   [junit4]   2> 336843 T1786 n:127.0.0.1:59895_ x:collection1 
oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@34ec4d8a 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5d6ba2b),segFN=segments_1,generation=1}
   [junit4]   2> 336844 T1786 n:127.0.0.1:59895_ x:collection1 
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 336844 T1786 n:127.0.0.1:59895_ x:collection1 
oass.SolrIndexSearcher.<init> Opening Searcher@41c9424d[collection1] main
   [junit4]   2> 336844 T1786 n:127.0.0.1:59895_ x:collection1 
oascc.ZkStateReader.readConfigName Load collection config 
from:/collections/control_collection
   [junit4]   2> 336847 T1786 n:127.0.0.1:59895_ x:collection1 
oascc.ZkStateReader.readConfigName path=/collections/control_collection 
configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 336847 T1786 n:127.0.0.1:59895_ x:collection1 
oasr.RestManager.init Initializing RestManager with initArgs: 
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 336847 T1786 n:127.0.0.1:59895_ x:collection1 
oasr.ManagedResourceStorage.load Reading _rest_managed.json using 
InMemoryStorage
   [junit4]   2> 336847 T1786 n:127.0.0.1:59895_ x:collection1 
oasr.RestManager.init Initializing 0 registered ManagedResources
   [junit4]   2> 336847 T1786 n:127.0.0.1:59895_ x:collection1 
oashc.SpellCheckComponent.inform Initializing spell checkers
   [junit4]   2> 336855 T1786 n:127.0.0.1:59895_ x:collection1 
oass.DirectSolrSpellChecker.init init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 336887 T1786 n:127.0.0.1:59895_ x:collection1 
oash.ReplicationHandler.inform Commits will be reserved for  10000
   [junit4]   2> 336888 T1787 n:127.0.0.1:59895_ x:collection1 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: default
   [junit4]   2> 336888 T1787 n:127.0.0.1:59895_ x:collection1 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: direct
   [junit4]   2> 336888 T1787 n:127.0.0.1:59895_ x:collection1 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: wordbreak
   [junit4]   2> 336888 T1787 n:127.0.0.1:59895_ x:collection1 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: multipleFields
   [junit4]   2> 336889 T1787 n:127.0.0.1:59895_ x:collection1 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: jarowinkler
   [junit4]   2> 336890 T1787 n:127.0.0.1:59895_ x:collection1 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: external
   [junit4]   2> 336890 T1787 n:127.0.0.1:59895_ x:collection1 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: freq
   [junit4]   2> 336891 T1787 n:127.0.0.1:59895_ x:collection1 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: fqcn
   [junit4]   2> 336891 T1787 n:127.0.0.1:59895_ x:collection1 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: perDict
   [junit4]   2> 336892 T1787 n:127.0.0.1:59895_ x:collection1 
oasc.SolrCore.registerSearcher [collection1] Registered new searcher 
Searcher@41c9424d[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 336893 T1786 n:127.0.0.1:59895_ x:collection1 
oasu.UpdateLog.onFirstSearcher On first searcher opened, looking up max value 
of version field
   [junit4]   2> 336893 T1786 n:127.0.0.1:59895_ x:collection1 
oasu.VersionInfo.getMaxVersionFromIndex Refreshing highest value of _version_ 
for 65536 version buckets from index
   [junit4]   2> 336893 T1786 n:127.0.0.1:59895_ x:collection1 
oasu.VersionInfo.getMaxVersionFromIndex No terms found for _version_, cannot 
seed version bucket highest value from index
   [junit4]   2> 336893 T1786 n:127.0.0.1:59895_ x:collection1 
oasu.UpdateLog.seedBucketsWithHighestVersion Could not find max version in 
index or recent updates, using new clock 1502564333745340416
   [junit4]   2> 336895 T1786 n:127.0.0.1:59895_ x:collection1 
oasu.UpdateLog.seedBucketsWithHighestVersion Took 2 ms to seed version buckets 
with highest version 1502564333745340416
   [junit4]   2> 336896 T1786 n:127.0.0.1:59895_ x:collection1 
oasc.ZkController.getConfDirListeners watch zkdir /configs/conf1
   [junit4]   2> 336897 T1786 n:127.0.0.1:59895_ x:collection1 
oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 336898 T1790 n:127.0.0.1:59895_ c:control_collection s:shard1 
x:collection1 oasc.ZkController.register Register replica - core:collection1 
address:https://127.0.0.1:59895 collection:control_collection shard:shard1
   [junit4]   2> 336898 T1751 n:127.0.0.1:59895_ oass.SolrDispatchFilter.init 
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2
   [junit4]   2> 336898 T1751 n:127.0.0.1:59895_ oass.SolrDispatchFilter.init 
SolrDispatchFilter.init() done
   [junit4]   2> 336902 T1751 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 336902 T1790 n:127.0.0.1:59895_ c:control_collection s:shard1 
x:collection1 oascc.SolrZkClient.makePath makePath: 
/collections/control_collection/leader_elect/shard1/election
   [junit4]   2> 336904 T1751 oascc.ConnectionManager.waitForConnected Waiting 
for client to connect to ZooKeeper
   [junit4]   2> 336909 T1793 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@30b0a4b6 
name:ZooKeeperConnection Watcher:127.0.0.1:38819/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 336909 T1751 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 336910 T1751 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 336910 T1790 n:127.0.0.1:59895_ c:control_collection s:shard1 
x:collection1 oasc.ShardLeaderElectionContext.runLeaderProcess Running the 
leader process for shard shard1
   [junit4]   2> 336910 T1751 
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state 
from ZooKeeper... 
   [junit4]   2> 336911 T1782 n:127.0.0.1:59895_ 
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path 
/overseer/queue state SyncConnected
   [junit4]   2> 336912 T1790 n:127.0.0.1:59895_ c:control_collection s:shard1 
x:collection1 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough 
replicas found to continue.
   [junit4]   2> 336912 T1790 n:127.0.0.1:59895_ c:control_collection s:shard1 
x:collection1 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new 
leader - try and sync
   [junit4]   2> ASYNC  NEW_CORE C225 name=collection1 
org.apache.solr.core.SolrCore@57f13254 url=https://127.0.0.1:59895/collection1 
node=127.0.0.1:59895_ C225_STATE=coll:control_collection core:collection1 
props:{base_url=https://127.0.0.1:59895, state=down, core=collection1, 
node_name=127.0.0.1:59895_}
   [junit4]   2> 336912 T1790 n:127.0.0.1:59895_ c:control_collection s:shard1 
x:collection1 C225 oasc.SyncStrategy.sync Sync replicas to 
https://127.0.0.1:59895/collection1/
   [junit4]   2> 336913 T1790 n:127.0.0.1:59895_ c:control_collection s:shard1 
x:collection1 C225 oasc.SyncStrategy.syncReplicas Sync Success - now sync 
replicas to me
   [junit4]   2> 336913 T1783 n:127.0.0.1:59895_ 
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
   [junit4]   2>          "operation":"leader",
   [junit4]   2>          "shard":"shard1",
   [junit4]   2>          "collection":"control_collection"} current state 
version: 1
   [junit4]   2> 336913 T1790 n:127.0.0.1:59895_ c:control_collection s:shard1 
x:collection1 C225 oasc.SyncStrategy.syncToMe 
https://127.0.0.1:59895/collection1/ has no replicas
   [junit4]   2> 336913 T1790 n:127.0.0.1:59895_ c:control_collection s:shard1 
x:collection1 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new 
leader: https://127.0.0.1:59895/collection1/ shard1
   [junit4]   2> 336913 T1790 n:127.0.0.1:59895_ c:control_collection s:shard1 
x:collection1 oascc.SolrZkClient.makePath makePath: 
/collections/control_collection/leaders/shard1
   [junit4]   2> 336915 T1782 n:127.0.0.1:59895_ oascc.ZkStateReader$2.process 
A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
   [junit4]   2> 336915 T1751 oasc.ChaosMonkey.monkeyLog monkey: init - expire 
sessions:false cause connection loss:false
   [junit4]   2> 336915 T1751 oasc.AbstractFullDistribZkTestBase.createJettys 
Creating collection1 with stateFormat=2
   [junit4]   2> 336915 T1751 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 336923 T1751 oascc.ConnectionManager.waitForConnected Waiting 
for client to connect to ZooKeeper
   [junit4]   2> 336923 T1782 n:127.0.0.1:59895_ 
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path 
/overseer/queue state SyncConnected
   [junit4]   2> 336924 T1783 n:127.0.0.1:59895_ 
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
   [junit4]   2>          "operation":"leader",
   [junit4]   2>          "shard":"shard1",
   [junit4]   2>          "collection":"control_collection",
   [junit4]   2>          "base_url":"https://127.0.0.1:59895";,
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "state":"active"} current state version: 2
   [junit4]   2> 336925 T1793 oascc.ZkStateReader$2.process A cluster state 
change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
   [junit4]   2> 336930 T1796 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@7ffac1be 
name:ZooKeeperConnection Watcher:127.0.0.1:38819/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 336930 T1751 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 336930 T1751 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 336932 T1782 n:127.0.0.1:59895_ 
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path 
/overseer/queue state SyncConnected
   [junit4]   2> 336933 T1783 n:127.0.0.1:59895_ 
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
   [junit4]   2>          "operation":"create",
   [junit4]   2>          "name":"collection1",
   [junit4]   2>          "numShards":"2",
   [junit4]   2>          "stateFormat":"2"} current state version: 2
   [junit4]   2> 336933 T1783 n:127.0.0.1:59895_ 
oasco.ClusterStateMutator.createCollection building a new cName: collection1
   [junit4]   2> 336934 T1793 oascc.ZkStateReader$2.process A cluster state 
change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
   [junit4]   2> 336934 T1782 n:127.0.0.1:59895_ oascc.ZkStateReader$2.process 
A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
   [junit4]   2> 336974 T1790 n:127.0.0.1:59895_ c:control_collection s:shard1 
x:collection1 oasc.ZkController.register We are 
https://127.0.0.1:59895/collection1/ and leader is 
https://127.0.0.1:59895/collection1/
   [junit4]   2> 336975 T1790 n:127.0.0.1:59895_ c:control_collection s:shard1 
x:collection1 oasc.ZkController.register No LogReplay needed for 
core=collection1 baseURL=https://127.0.0.1:59895
   [junit4]   2> 336975 T1790 n:127.0.0.1:59895_ c:control_collection s:shard1 
x:collection1 oasc.ZkController.checkRecovery I am the leader, no recovery 
necessary
   [junit4]   2> 336975 T1790 n:127.0.0.1:59895_ c:control_collection s:shard1 
x:collection1 oasc.ZkController.publish publishing core=collection1 
state=active collection=control_collection
   [junit4]   2> 336975 T1790 n:127.0.0.1:59895_ c:control_collection s:shard1 
x:collection1 oasc.ZkController.publish numShards not found on descriptor - 
reading it from system property
   [junit4]   2> 336978 T1782 n:127.0.0.1:59895_ 
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path 
/overseer/queue state SyncConnected
   [junit4]   2> 336979 T1783 n:127.0.0.1:59895_ 
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
   [junit4]   2>          "base_url":"https://127.0.0.1:59895";,
   [junit4]   2>          "shard":"shard1",
   [junit4]   2>          "core_node_name":"core_node1",
   [junit4]   2>          "state":"active",
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "numShards":"2",
   [junit4]   2>          "collection":"control_collection",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "node_name":"127.0.0.1:59895_"} current state 
version: 3
   [junit4]   2> 336980 T1783 n:127.0.0.1:59895_ 
oasco.ReplicaMutator.updateState Update state numShards=2 message={
   [junit4]   2>          "base_url":"https://127.0.0.1:59895";,
   [junit4]   2>          "shard":"shard1",
   [junit4]   2>          "core_node_name":"core_node1",
   [junit4]   2>          "state":"active",
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "numShards":"2",
   [junit4]   2>          "collection":"control_collection",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "node_name":"127.0.0.1:59895_"}
   [junit4]   2> 336981 T1783 n:127.0.0.1:59895_ 
oasco.ZkStateWriter.writePendingUpdates going to create_collection 
/collections/collection1/state.json
   [junit4]   2> 336982 T1793 oascc.ZkStateReader$2.process A cluster state 
change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
   [junit4]   2> 336982 T1782 n:127.0.0.1:59895_ oascc.ZkStateReader$2.process 
A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
   [junit4]   2> 337087 T1793 oascc.ZkStateReader$2.process A cluster state 
change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
   [junit4]   2> 337087 T1782 n:127.0.0.1:59895_ oascc.ZkStateReader$2.process 
A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
   [junit4]   2> 337286 T1751 oas.SolrTestCaseJ4.writeCoreProperties Writing 
core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-1-001/cores/collection1
   [junit4]   2> 337288 T1751 oasc.AbstractFullDistribZkTestBase.createJettys 
create jetty 1 in directory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-1-001
   [junit4]   2> 337289 T1751 oejs.Server.doStart jetty-9.2.10.v20150310
   [junit4]   2> 337291 T1751 oejsh.ContextHandler.doStart Started 
o.e.j.s.ServletContextHandler@316ec857{/,null,AVAILABLE}
   [junit4]   2> 337294 T1751 oejs.AbstractConnector.doStart Started 
ServerConnector@11e8e4ec{SSL-http/1.1}{127.0.0.1:47361}
   [junit4]   2> 337294 T1751 oejs.Server.doStart Started @338987ms
   [junit4]   2> 337294 T1751 oascse.JettySolrRunner$1.lifeCycleStarted Jetty 
properties: {hostContext=/, solrconfig=solrconfig.xml, hostPort=47361, 
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-1-001/cores, 
solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/tempDir-001/jetty1}
   [junit4]   2> 337296 T1751 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@72b5615d
   [junit4]   2> 337296 T1751 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-1-001/'
   [junit4]   2> 337311 T1751 oasc.SolrXmlConfig.fromFile Loading container 
configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-1-001/solr.xml
   [junit4]   2> 337325 T1751 oasc.CorePropertiesLocator.<init> Config-defined 
core root directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-1-001/cores
   [junit4]   2> 337325 T1751 oasc.CoreContainer.<init> New CoreContainer 
226194540
   [junit4]   2> 337325 T1751 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-1-001/]
   [junit4]   2> 337326 T1751 oasc.CoreContainer.load loading shared library: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-1-001/lib
   [junit4]   2> 337326 T1751 oasc.SolrResourceLoader.addToClassLoader WARN 
Can't find (or read) directory to add to classloader: lib (resolved as: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-1-001/lib).
   [junit4]   2> 337334 T1751 oashc.HttpShardHandlerFactory.init 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> 337336 T1751 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 337338 T1751 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 337338 T1751 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 337338 T1751 oasc.CoreContainer.load Node Name: 127.0.0.1
   [junit4]   2> 337338 T1751 oasc.ZkContainer.initZooKeeper Zookeeper 
client=127.0.0.1:38819/solr
   [junit4]   2> 337339 T1751 oasc.ZkController.checkChrootPath zkHost includes 
chroot
   [junit4]   2> 337339 T1751 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 337339 T1751 oascc.ConnectionManager.waitForConnected Waiting 
for client to connect to ZooKeeper
   [junit4]   2> 337341 T1810 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@5dbbb110 
name:ZooKeeperConnection Watcher:127.0.0.1:38819 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 337341 T1751 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 337342 T1751 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 337343 T1751 n:127.0.0.1:47361_ 
oascc.ConnectionManager.waitForConnected Waiting for client to connect to 
ZooKeeper
   [junit4]   2> 337345 T1813 n:127.0.0.1:47361_ 
oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@4628950a 
name:ZooKeeperConnection Watcher:127.0.0.1:38819/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 337345 T1751 n:127.0.0.1:47361_ 
oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 337352 T1751 n:127.0.0.1:47361_ 
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state 
from ZooKeeper... 
   [junit4]   2> 338359 T1751 n:127.0.0.1:47361_ 
oasc.ZkController.createEphemeralLiveNode Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:47361_
   [junit4]   2> 338359 T1751 n:127.0.0.1:47361_ oascc.SolrZkClient.makePath 
makePath: /live_nodes/127.0.0.1:47361_
   [junit4]   2> 338362 T1751 n:127.0.0.1:47361_ oasc.Overseer.close Overseer 
(id=null) closing
   [junit4]   2> 338364 T1751 n:127.0.0.1:47361_ 
oasc.CoreContainer.initializeAuthenticationPlugin No authentication plugin used.
   [junit4]   2> 338364 T1751 n:127.0.0.1:47361_ 
oasc.CoreContainer.intializeAuthorizationPlugin Security conf doesn't exist. 
Skipping setup for authorization module.
   [junit4]   2> 338365 T1751 n:127.0.0.1:47361_ 
oasc.CorePropertiesLocator.discover Looking for core definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-1-001/cores
   [junit4]   2> 338367 T1751 n:127.0.0.1:47361_ oasc.CoreDescriptor.<init> 
CORE DESCRIPTOR: {name=collection1, loadOnStartup=true, shard=, 
collection=collection1, 
absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-1-001/cores/collection1/, schema=schema.xml, 
coreNodeName=, transient=false, config=solrconfig.xml, 
instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-1-001/cores/collection1, dataDir=data/}
   [junit4]   2> 338367 T1751 n:127.0.0.1:47361_ 
oasc.CorePropertiesLocator.discoverUnder Found core collection1 in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-1-001/cores/collection1/
   [junit4]   2> 338367 T1751 n:127.0.0.1:47361_ 
oasc.CorePropertiesLocator.discover Found 1 core definitions
   [junit4]   2> 338375 T1814 n:127.0.0.1:47361_ c:collection1 x:collection1 
oasc.ZkController.publish publishing core=collection1 state=down 
collection=collection1
   [junit4]   2> 338375 T1814 n:127.0.0.1:47361_ c:collection1 x:collection1 
oasc.ZkController.publish numShards not found on descriptor - reading it from 
system property
   [junit4]   2> 338379 T1782 n:127.0.0.1:59895_ 
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path 
/overseer/queue state SyncConnected
   [junit4]   2> 338380 T1783 n:127.0.0.1:59895_ 
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
   [junit4]   2>          "base_url":"https://127.0.0.1:47361";,
   [junit4]   2>          "shard":null,
   [junit4]   2>          "state":"down",
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "numShards":"2",
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "node_name":"127.0.0.1:47361_"} current state 
version: 5
   [junit4]   2> 338381 T1783 n:127.0.0.1:59895_ 
oasco.ReplicaMutator.updateState Update state numShards=2 message={
   [junit4]   2>          "base_url":"https://127.0.0.1:47361";,
   [junit4]   2>          "shard":null,
   [junit4]   2>          "state":"down",
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "numShards":"2",
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "node_name":"127.0.0.1:47361_"}
   [junit4]   2> 338381 T1783 n:127.0.0.1:59895_ 
oasco.ReplicaMutator.updateState Collection already exists with numShards=2
   [junit4]   2> 338381 T1783 n:127.0.0.1:59895_ 
oasco.ReplicaMutator.updateState Assigning new node to shard shard=shard1
   [junit4]   2> 338387 T1814 n:127.0.0.1:47361_ oasc.ZkController.preRegister 
Registering watch for external collection collection1
   [junit4]   2> 338387 T1814 n:127.0.0.1:47361_ oascc.ZkStateReader.addZkWatch 
addZkWatch collection1
   [junit4]   2> 338387 T1814 n:127.0.0.1:47361_ oascc.ZkStateReader.addZkWatch 
Updating collection state at /collections/collection1/state.json from 
ZooKeeper... 
   [junit4]   2> 338391 T1814 n:127.0.0.1:47361_ 
oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to 
ver 0 
   [junit4]   2> 338391 T1814 n:127.0.0.1:47361_ 
oasc.ZkController.waitForCoreNodeName look for our core node name
   [junit4]   2> 338483 T1783 n:127.0.0.1:59895_ 
oasco.ZkStateWriter.writePendingUpdates going to update_collection 
/collections/collection1/state.json version: 0
   [junit4]   2> 338484 T1813 n:127.0.0.1:47361_ oascc.ZkStateReader$7.process 
A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json for collection collection1 has 
occurred - updating... (live nodes size: 2)
   [junit4]   2> 338485 T1813 n:127.0.0.1:47361_ 
oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to 
ver 1 
   [junit4]   2> 339392 T1814 n:127.0.0.1:47361_ 
oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for 
collection1
   [junit4]   2> 339392 T1814 n:127.0.0.1:47361_ 
oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
   [junit4]   2> 339393 T1814 n:127.0.0.1:47361_ 
oasc.ZkController.createCollectionZkNode Collection zkNode exists
   [junit4]   2> 339393 T1814 n:127.0.0.1:47361_ 
oascc.ZkStateReader.readConfigName Load collection config 
from:/collections/collection1
   [junit4]   2> 339394 T1814 n:127.0.0.1:47361_ 
oascc.ZkStateReader.readConfigName path=/collections/collection1 
configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 339394 T1814 n:127.0.0.1:47361_ oasc.SolrResourceLoader.<init> 
new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-1-001/cores/collection1/'
   [junit4]   2> 339410 T1814 n:127.0.0.1:47361_ oasc.Config.<init> loaded 
config solrconfig.xml with version 0 
   [junit4]   2> 339419 T1814 n:127.0.0.1:47361_ 
oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
   [junit4]   2> 339440 T1814 n:127.0.0.1:47361_ oasc.SolrConfig.<init> Using 
Lucene MatchVersion: 5.2.0
   [junit4]   2> 339487 T1814 n:127.0.0.1:47361_ oasc.SolrConfig.<init> Loaded 
SolrConfig: solrconfig.xml
   [junit4]   2> 339488 T1814 n:127.0.0.1:47361_ oass.IndexSchema.readSchema 
Reading Solr Schema from /configs/conf1/schema.xml
   [junit4]   2> 339516 T1814 n:127.0.0.1:47361_ oass.IndexSchema.readSchema 
[collection1] Schema name=test
   [junit4]   2> 339795 T1814 n:127.0.0.1:47361_ 
oass.OpenExchangeRatesOrgProvider.init Initialized with 
rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 339804 T1814 n:127.0.0.1:47361_ oass.IndexSchema.readSchema 
default search field in schema is text
   [junit4]   2> 339806 T1814 n:127.0.0.1:47361_ oass.IndexSchema.readSchema 
unique key field: id
   [junit4]   2> 339819 T1814 n:127.0.0.1:47361_ 
oass.FileExchangeRateProvider.reload Reloading exchange rates from file 
currency.xml
   [junit4]   2> 339823 T1814 n:127.0.0.1:47361_ 
oass.FileExchangeRateProvider.reload Reloading exchange rates from file 
currency.xml
   [junit4]   2> 339826 T1814 n:127.0.0.1:47361_ 
oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 339827 T1814 n:127.0.0.1:47361_ 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 339827 T1814 n:127.0.0.1:47361_ 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 339828 T1814 n:127.0.0.1:47361_ 
oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 339828 T1814 n:127.0.0.1:47361_ 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 339829 T1814 n:127.0.0.1:47361_ 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 339829 T1814 n:127.0.0.1:47361_ oasc.CoreContainer.create 
Creating SolrCore 'collection1' using configuration from collection collection1
   [junit4]   2> 339829 T1814 n:127.0.0.1:47361_ x:collection1 
oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 339829 T1814 n:127.0.0.1:47361_ x:collection1 
oasc.SolrCore.<init> [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-1-001/cores/collection1/], dataDir=[null]
   [junit4]   2> 339830 T1814 n:127.0.0.1:47361_ x:collection1 
oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to 
JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@c23d097
   [junit4]   2> 339830 T1814 n:127.0.0.1:47361_ x:collection1 
oasc.CachingDirectoryFactory.get return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-1-001/cores/collection1/data
   [junit4]   2> 339831 T1814 n:127.0.0.1:47361_ x:collection1 
oasc.SolrCore.getNewIndexDir New index directory detected: old=null 
new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-1-001/cores/collection1/data/index/
   [junit4]   2> 339831 T1814 n:127.0.0.1:47361_ x:collection1 
oasc.SolrCore.initIndex WARN [collection1] Solr index directory 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-1-001/cores/collection1/data/index' doesn't exist. 
Creating new index...
   [junit4]   2> 339831 T1814 n:127.0.0.1:47361_ x:collection1 
oasc.CachingDirectoryFactory.get return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-1-001/cores/collection1/data/index
   [junit4]   2> 339832 T1814 n:127.0.0.1:47361_ x:collection1 
oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=30, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.36912042906390596]
   [junit4]   2> 339832 T1814 n:127.0.0.1:47361_ x:collection1 
oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@338c2ac9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@374d0c8f),segFN=segments_1,generation=1}
   [junit4]   2> 339833 T1814 n:127.0.0.1:47361_ x:collection1 
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 339840 T1814 n:127.0.0.1:47361_ x:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"dedupe"
   [junit4]   2> 339840 T1814 n:127.0.0.1:47361_ x:collection1 
oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 339841 T1814 n:127.0.0.1:47361_ x:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 339841 T1814 n:127.0.0.1:47361_ x:collection1 
oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 339841 T1814 n:127.0.0.1:47361_ x:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"stored_sig"
   [junit4]   2> 339841 T1814 n:127.0.0.1:47361_ x:collection1 
oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 339841 T1814 n:127.0.0.1:47361_ x:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"uniq-fields"
   [junit4]   2> 339842 T1814 n:127.0.0.1:47361_ x:collection1 
oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 339842 T1814 n:127.0.0.1:47361_ x:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"distrib-dup-test-chain-explicit"
   [junit4]   2> 339842 T1814 n:127.0.0.1:47361_ x:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 339843 T1814 n:127.0.0.1:47361_ x:collection1 
oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 339843 T1814 n:127.0.0.1:47361_ x:collection1 
oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined 
as default, creating implicit default
   [junit4]   2> 339846 T1814 n:127.0.0.1:47361_ x:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 339848 T1814 n:127.0.0.1:47361_ x:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 339850 T1814 n:127.0.0.1:47361_ x:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 339851 T1814 n:127.0.0.1:47361_ x:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 339859 T1814 n:127.0.0.1:47361_ x:collection1 
oasc.PluginBag.createPlugin requestHandler : 'lazy' created with startup=lazy 
   [junit4]   2> 339863 T1814 n:127.0.0.1:47361_ x:collection1 
oasc.RequestHandlers.initHandlersFromConfig Registered paths: 
/admin/segments,dismax,/admin/luke,/admin/ping,spellCheckWithWordbreak_Direct,mock,/get,/replication,/schema,/admin/mbeans,spellCheckCompRH,spellCheckCompRH1,/admin/threads,/update/csv,tvrh,/update,/debug/dump,/admin/plugins,/update/json,/mlt,/admin/properties,/search-facet-def,/config,/admin/file,spellCheckCompRH_Direct,spellCheckWithWordbreak,/admin/system,/terms,defaults,standard,/search-facet-invariants,lazy,/admin/logging,mltrh,/update/json/docs
   [junit4]   2> 339865 T1814 n:127.0.0.1:47361_ x:collection1 
oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated 
<admin/gettableFiles>, Please update your config to use the 
ShowFileRequestHandler.
   [junit4]   2> 339866 T1814 n:127.0.0.1:47361_ x:collection1 
oasc.SolrCore.initStatsCache Using default statsCache cache: 
org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 339867 T1814 n:127.0.0.1:47361_ x:collection1 
oasu.UpdateHandler.<init> Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 339868 T1814 n:127.0.0.1:47361_ x:collection1 
oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 339869 T1814 n:127.0.0.1:47361_ x:collection1 
oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 339869 T1814 n:127.0.0.1:47361_ x:collection1 
oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 339870 T1814 n:127.0.0.1:47361_ x:collection1 
oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=23, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6297962364776588]
   [junit4]   2> 339871 T1814 n:127.0.0.1:47361_ x:collection1 
oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@338c2ac9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@374d0c8f),segFN=segments_1,generation=1}
   [junit4]   2> 339871 T1814 n:127.0.0.1:47361_ x:collection1 
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 339871 T1814 n:127.0.0.1:47361_ x:collection1 
oass.SolrIndexSearcher.<init> Opening Searcher@3dcc874a[collection1] main
   [junit4]   2> 339871 T1814 n:127.0.0.1:47361_ x:collection1 
oascc.ZkStateReader.readConfigName Load collection config 
from:/collections/collection1
   [junit4]   2> 339872 T1814 n:127.0.0.1:47361_ x:collection1 
oascc.ZkStateReader.readConfigName path=/collections/collection1 
configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 339873 T1814 n:127.0.0.1:47361_ x:collection1 
oasr.RestManager.init Initializing RestManager with initArgs: 
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 339873 T1814 n:127.0.0.1:47361_ x:collection1 
oasr.ManagedResourceStorage.load Reading _rest_managed.json using 
InMemoryStorage
   [junit4]   2> 339873 T1814 n:127.0.0.1:47361_ x:collection1 
oasr.RestManager.init Initializing 0 registered ManagedResources
   [junit4]   2> 339873 T1814 n:127.0.0.1:47361_ x:collection1 
oashc.SpellCheckComponent.inform Initializing spell checkers
   [junit4]   2> 339884 T1814 n:127.0.0.1:47361_ x:collection1 
oass.DirectSolrSpellChecker.init init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 339919 T1814 n:127.0.0.1:47361_ x:collection1 
oash.ReplicationHandler.inform Commits will be reserved for  10000
   [junit4]   2> 339920 T1815 n:127.0.0.1:47361_ x:collection1 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: default
   [junit4]   2> 339921 T1815 n:127.0.0.1:47361_ x:collection1 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: direct
   [junit4]   2> 339921 T1815 n:127.0.0.1:47361_ x:collection1 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: wordbreak
   [junit4]   2> 339921 T1815 n:127.0.0.1:47361_ x:collection1 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: multipleFields
   [junit4]   2> 339922 T1815 n:127.0.0.1:47361_ x:collection1 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: jarowinkler
   [junit4]   2> 339922 T1814 n:127.0.0.1:47361_ x:collection1 
oasu.UpdateLog.onFirstSearcher On first searcher opened, looking up max value 
of version field
   [junit4]   2> 339922 T1814 n:127.0.0.1:47361_ x:collection1 
oasu.VersionInfo.getMaxVersionFromIndex Refreshing highest value of _version_ 
for 65536 version buckets from index
   [junit4]   2> 339922 T1814 n:127.0.0.1:47361_ x:collection1 
oasu.VersionInfo.getMaxVersionFromIndex No terms found for _version_, cannot 
seed version bucket highest value from index
   [junit4]   2> 339922 T1815 n:127.0.0.1:47361_ x:collection1 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: external
   [junit4]   2> 339922 T1814 n:127.0.0.1:47361_ x:collection1 
oasu.UpdateLog.seedBucketsWithHighestVersion Could not find max version in 
index or recent updates, using new clock 1502564336921477120
   [junit4]   2> 339923 T1815 n:127.0.0.1:47361_ x:collection1 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: freq
   [junit4]   2> 339923 T1815 n:127.0.0.1:47361_ x:collection1 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: fqcn
   [junit4]   2> 339924 T1815 n:127.0.0.1:47361_ x:collection1 
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index 
for spellchecker: perDict
   [junit4]   2> 339924 T1814 n:127.0.0.1:47361_ x:collection1 
oasu.UpdateLog.seedBucketsWithHighestVersion Took 2 ms to seed version buckets 
with highest version 1502564336921477120
   [junit4]   2> 339924 T1814 n:127.0.0.1:47361_ x:collection1 
oasc.ZkController.getConfDirListeners watch zkdir /configs/conf1
   [junit4]   2> 339925 T1814 n:127.0.0.1:47361_ x:collection1 
oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 339926 T1815 n:127.0.0.1:47361_ x:collection1 
oasc.SolrCore.registerSearcher [collection1] Registered new searcher 
Searcher@3dcc874a[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 339926 T1751 n:127.0.0.1:47361_ oass.SolrDispatchFilter.init 
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2
   [junit4]   2> 339927 T1751 n:127.0.0.1:47361_ oass.SolrDispatchFilter.init 
SolrDispatchFilter.init() done
   [junit4]   2> 339930 T1818 n:127.0.0.1:47361_ c:collection1 s:shard1 
x:collection1 oasc.ZkController.register Register replica - core:collection1 
address:https://127.0.0.1:47361 collection:collection1 shard:shard1
   [junit4]   2> 339931 T1818 n:127.0.0.1:47361_ c:collection1 s:shard1 
x:collection1 oascc.SolrZkClient.makePath makePath: 
/collections/collection1/leader_elect/shard1/election
   [junit4]   2> 339936 T1818 n:127.0.0.1:47361_ c:collection1 s:shard1 
x:collection1 oasc.ShardLeaderElectionContext.runLeaderProcess Running the 
leader process for shard shard1
   [junit4]   2> 339939 T1782 n:127.0.0.1:59895_ 
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path 
/overseer/queue state SyncConnected
   [junit4]   2> 339939 T1818 n:127.0.0.1:47361_ c:collection1 s:shard1 
x:collection1 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough 
replicas found to continue.
   [junit4]   2> 339940 T1818 n:127.0.0.1:47361_ c:collection1 s:shard1 
x:collection1 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new 
leader - try and sync
   [junit4]   2> ASYNC  NEW_CORE C226 name=collection1 
org.apache.solr.core.SolrCore@2549f2c4 url=https://127.0.0.1:47361/collection1 
node=127.0.0.1:47361_ C226_STATE=coll:collection1 core:collection1 
props:{base_url=https://127.0.0.1:47361, state=down, core=collection1, 
node_name=127.0.0.1:47361_}
   [junit4]   2> 339940 T1818 n:127.0.0.1:47361_ c:collection1 s:shard1 
x:collection1 C226 oasc.SyncStrategy.sync Sync replicas to 
https://127.0.0.1:47361/collection1/
   [junit4]   2> 339940 T1783 n:127.0.0.1:59895_ 
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
   [junit4]   2>          "operation":"leader",
   [junit4]   2>          "shard":"shard1",
   [junit4]   2>          "collection":"collection1"} current state version: 5
   [junit4]   2> 339940 T1818 n:127.0.0.1:47361_ c:collection1 s:shard1 
x:collection1 C226 oasc.SyncStrategy.syncReplicas Sync Success - now sync 
replicas to me
   [junit4]   2> 339941 T1818 n:127.0.0.1:47361_ c:collection1 s:shard1 
x:collection1 C226 oasc.SyncStrategy.syncToMe 
https://127.0.0.1:47361/collection1/ has no replicas
   [junit4]   2> 339941 T1818 n:127.0.0.1:47361_ c:collection1 s:shard1 
x:collection1 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new 
leader: https://127.0.0.1:47361/collection1/ shard1
   [junit4]   2> 339941 T1818 n:127.0.0.1:47361_ c:collection1 s:shard1 
x:collection1 oascc.SolrZkClient.makePath makePath: 
/collections/collection1/leaders/shard1
   [junit4]   2> 339941 T1783 n:127.0.0.1:59895_ 
oasco.ZkStateWriter.writePendingUpdates going to update_collection 
/collections/collection1/state.json version: 1
   [junit4]   2> 339943 T1813 n:127.0.0.1:47361_ oascc.ZkStateReader$7.process 
A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json for collection collection1 has 
occurred - updating... (live nodes size: 2)
   [junit4]   2> 339944 T1813 n:127.0.0.1:47361_ 
oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to 
ver 2 
   [junit4]   2> 339949 T1782 n:127.0.0.1:59895_ 
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path 
/overseer/queue state SyncConnected
   [junit4]   2> 339950 T1783 n:127.0.0.1:59895_ 
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
   [junit4]   2>          "operation":"leader",
   [junit4]   2>          "shard":"shard1",
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "base_url":"https://127.0.0.1:47361";,
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "state":"active"} current state version: 5
   [junit4]   2> 339951 T1783 n:127.0.0.1:59895_ 
oasco.ZkStateWriter.writePendingUpdates going to update_collection 
/collections/collection1/state.json version: 2
   [junit4]   2> 339953 T1813 n:127.0.0.1:47361_ oascc.ZkStateReader$7.process 
A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json for collection collection1 has 
occurred - updating... (live nodes size: 2)
   [junit4]   2> 339954 T1813 n:127.0.0.1:47361_ 
oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to 
ver 3 
   [junit4]   2> 340000 T1818 n:127.0.0.1:47361_ c:collection1 s:shard1 
x:collection1 oasc.ZkController.register We are 
https://127.0.0.1:47361/collection1/ and leader is 
https://127.0.0.1:47361/collection1/
   [junit4]   2> 340000 T1818 n:127.0.0.1:47361_ c:collection1 s:shard1 
x:collection1 oasc.ZkController.register No LogReplay needed for 
core=collection1 baseURL=https://127.0.0.1:47361
   [junit4]   2> 340000 T1818 n:127.0.0.1:47361_ c:collection1 s:shard1 
x:collection1 oasc.ZkController.checkRecovery I am the leader, no recovery 
necessary
   [junit4]   2> 340001 T1818 n:127.0.0.1:47361_ c:collection1 s:shard1 
x:collection1 oasc.ZkController.publish publishing core=collection1 
state=active collection=collection1
   [junit4]   2> 340001 T1818 n:127.0.0.1:47361_ c:collection1 s:shard1 
x:collection1 oasc.ZkController.publish numShards not found on descriptor - 
reading it from system property
   [junit4]   2> 340002 T1782 n:127.0.0.1:59895_ 
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path 
/overseer/queue state SyncConnected
   [junit4]   2> 340003 T1783 n:127.0.0.1:59895_ 
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
   [junit4]   2>          "base_url":"https://127.0.0.1:47361";,
   [junit4]   2>          "shard":"shard1",
   [junit4]   2>          "core_node_name":"core_node1",
   [junit4]   2>          "state":"active",
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "numShards":"2",
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "node_name":"127.0.0.1:47361_"} current state 
version: 5
   [junit4]   2> 340004 T1783 n:127.0.0.1:59895_ 
oasco.ReplicaMutator.updateState Update state numShards=2 message={
   [junit4]   2>          "base_url":"https://127.0.0.1:47361";,
   [junit4]   2>          "shard":"shard1",
   [junit4]   2>          "core_node_name":"core_node1",
   [junit4]   2>          "state":"active",
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "numShards":"2",
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "node_name":"127.0.0.1:47361_"}
   [junit4]   2> 340007 T1783 n:127.0.0.1:59895_ 
oasco.ZkStateWriter.writePendingUpdates going to update_collection 
/collections/collection1/state.json version: 3
   [junit4]   2> 340007 T1818 n:127.0.0.1:47361_ c:collection1 s:shard1 
x:collection1 oascc.ZkStateReader.updateWatchedCollection Updating data for 
collection1 to ver 3 
   [junit4]   2> 340008 T1813 n:127.0.0.1:47361_ oascc.ZkStateReader$7.process 
A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json for collection collection1 has 
occurred - updating... (live nodes size: 2)
   [junit4]   2> 340009 T1813 n:127.0.0.1:47361_ 
oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to 
ver 4 
   [junit4]   2> 340277 T1751 oas.SolrTestCaseJ4.writeCoreProperties Writing 
core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-2-001/cores/collection1
   [junit4]   2> 340279 T1751 oasc.AbstractFullDistribZkTestBase.createJettys 
create jetty 2 in directory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-2-001
   [junit4]   2> 340280 T1751 oejs.Server.doStart jetty-9.2.10.v20150310
   [junit4]   2> 340283 T1751 oejsh.ContextHandler.doStart Started 
o.e.j.s.ServletContextHandler@4a6686cf{/,null,AVAILABLE}
   [junit4]   2> 340286 T1751 oejs.AbstractConnector.doStart Started 
ServerConnector@111ca632{SSL-http/1.1}{127.0.0.1:34933}
   [junit4]   2> 340287 T1751 oejs.Server.doStart Started @341980ms
   [junit4]   2> 340287 T1751 oascse.JettySolrRunner$1.lifeCycleStarted Jetty 
properties: 
{coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-2-001/cores, 
solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/tempDir-001/jetty2, solrconfig=solrconfig.xml, 
hostContext=/, hostPort=34933}
   [junit4]   2> 340289 T1751 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@72b5615d
   [junit4]   2> 340289 T1751 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-2-001/'
   [junit4]   2> 340309 T1751 oasc.SolrXmlConfig.fromFile Loading container 
configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-2-001/solr.xml
   [junit4]   2> 340327 T1751 oasc.CorePropertiesLocator.<init> Config-defined 
core root directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-2-001/cores
   [junit4]   2> 340327 T1751 oasc.CoreContainer.<init> New CoreContainer 
1936774403
   [junit4]   2> 340327 T1751 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-2-001/]
   [junit4]   2> 340328 T1751 oasc.CoreContainer.load loading shared library: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-2-001/lib
   [junit4]   2> 340328 T1751 oasc.SolrResourceLoader.addToClassLoader WARN 
Can't find (or read) directory to add to classloader: lib (resolved as: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-2-001/lib).
   [junit4]   2> 340338 T1751 oashc.HttpShardHandlerFactory.init 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> 340341 T1751 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 340343 T1751 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 340343 T1751 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 340343 T1751 oasc.CoreContainer.load Node Name: 127.0.0.1
   [junit4]   2> 340344 T1751 oasc.ZkContainer.initZooKeeper Zookeeper 
client=127.0.0.1:38819/solr
   [junit4]   2> 340344 T1751 oasc.ZkController.checkChrootPath zkHost includes 
chroot
   [junit4]   2> 340344 T1751 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 340345 T1751 oascc.ConnectionManager.waitForConnected Waiting 
for client to connect to ZooKeeper
   [junit4]   2> 340347 T1832 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@68481f6b 
name:ZooKeeperConnection Watcher:127.0.0.1:38819 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 340347 T1751 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKee

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

649_ oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader 
process for shard shard2
   [junit4]   2> 372678 T1994 n:127.0.0.1:45649_ 
oasc.ElectionContext.cancelElection canceling election 
/collections/collection1/leader_elect/shard2/election/93910271438290957-core_node4-n_0000000002
   [junit4]   2> 372679 T1994 n:127.0.0.1:45649_ oasc.SolrCore.close 
[collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@3cd62b78
   [junit4]   2> 372680 T1994 n:127.0.0.1:45649_ 
oasc.ZkController.unregisterConfListener removed listener for config directory 
[/configs/conf1]
   [junit4]   2> 372680 T1994 n:127.0.0.1:45649_ 
oasc.ZkController.unregisterConfListener No more listeners for config directory 
[/configs/conf1]
   [junit4]   2> 372680 T1994 n:127.0.0.1:45649_ 
oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=0,autocommits=0,soft 
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
   [junit4]   2> 372680 T2027 n:127.0.0.1:45649_ oascc.ZkStateReader$3.process 
WARN ZooKeeper watch triggered, but Solr cannot talk to ZK
   [junit4]   2> 372680 T1994 n:127.0.0.1:45649_ 
oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
   [junit4]   2> 372681 T1994 n:127.0.0.1:45649_ 
oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 
0 - closing IndexWriter
   [junit4]   2> 372681 T1994 n:127.0.0.1:45649_ 
oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with 
IndexWriterCloser
   [junit4]   2> 372681 T1994 n:127.0.0.1:45649_ oasc.SolrCore.closeSearcher 
[collection1] Closing main searcher on request.
   [junit4]   2> 372697 T1994 n:127.0.0.1:45649_ 
oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories 
currently being tracked
   [junit4]   2> 372697 T1994 n:127.0.0.1:45649_ 
oasc.CachingDirectoryFactory.closeCacheValue looking to close 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-4-001/cores/collection1/data/index 
[CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-4-001/cores/collection1/data/index;done=false>>]
   [junit4]   2> 372697 T1994 n:127.0.0.1:45649_ 
oasc.CachingDirectoryFactory.close Closing directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-4-001/cores/collection1/data/index
   [junit4]   2> 372697 T1994 n:127.0.0.1:45649_ 
oasc.CachingDirectoryFactory.closeCacheValue looking to close 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-4-001/cores/collection1/data 
[CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-4-001/cores/collection1/data;done=false>>]
   [junit4]   2> 372698 T1994 n:127.0.0.1:45649_ 
oasc.CachingDirectoryFactory.close Closing directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001/shard-4-001/cores/collection1/data
   [junit4]   2> 372698 T1994 n:127.0.0.1:45649_ 
oasc.LeaderElector$ElectionWatcher.process WARN  
org.apache.solr.common.SolrException: SolrCore not found:collection1 in []
   [junit4]   2>        at 
org.apache.solr.cloud.ShardLeaderElectionContext.runLeaderProcess(ElectionContext.java:215)
   [junit4]   2>        at 
org.apache.solr.cloud.LeaderElector.runIamLeaderProcess(LeaderElector.java:198)
   [junit4]   2>        at 
org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:159)
   [junit4]   2>        at 
org.apache.solr.cloud.LeaderElector.joinElection(LeaderElector.java:348)
   [junit4]   2>        at 
org.apache.solr.cloud.LeaderElector.joinElection(LeaderElector.java:256)
   [junit4]   2>        at 
org.apache.solr.cloud.ShardLeaderElectionContext.rejoinLeaderElection(ElectionContext.java:492)
   [junit4]   2>        at 
org.apache.solr.cloud.ShardLeaderElectionContext.runLeaderProcess(ElectionContext.java:248)
   [junit4]   2>        at 
org.apache.solr.cloud.LeaderElector.runIamLeaderProcess(LeaderElector.java:198)
   [junit4]   2>        at 
org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:159)
   [junit4]   2>        at 
org.apache.solr.cloud.LeaderElector.access$200(LeaderElector.java:56)
   [junit4]   2>        at 
org.apache.solr.cloud.LeaderElector$ElectionWatcher.process(LeaderElector.java:390)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient$3$1.run(SolrZkClient.java:264)
   [junit4]   2>        at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
   [junit4]   2>        at 
java.util.concurrent.FutureTask.run(FutureTask.java:262)
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:148)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 
   [junit4]   2> 372699 T1751 oejs.AbstractConnector.doStop Stopped 
ServerConnector@175afc00{SSL-http/1.1}{127.0.0.1:0}
   [junit4]   2> 372700 T1751 oejsh.ContextHandler.doStop Stopped 
o.e.j.s.ServletContextHandler@754424ce{/,null,UNAVAILABLE}
   [junit4]   2> 372713 T1751 c:control_collection s:shard1 x:collection1 
oasc.ChaosMonkey.monkeyLog monkey: stop shard! 57610
   [junit4]   2> 372714 T1751 c:control_collection s:shard1 x:collection1 
oasc.ZkTestServer.send4LetterWord connecting to 127.0.0.1:41484 41484
   [junit4]   2> 372946 T1867 c:control_collection s:shard1 x:collection1 
oasc.ZkTestServer.send4LetterWord connecting to 127.0.0.1:41484 41484
   [junit4]   2> 372948 T1867 c:control_collection s:shard1 x:collection1 
oasc.ZkTestServer$ZKServerMain.runFromConfig WARN Watch limit violations: 
   [junit4]   2>        Maximum concurrent create/delete watches above limit:
   [junit4]   2>        
   [junit4]   2>                6       /solr/aliases.json
   [junit4]   2>                6       /solr/clusterstate.json
   [junit4]   2>                5       /solr/configs/conf1
   [junit4]   2>        
   [junit4]   2>        Maximum concurrent children watches above limit:
   [junit4]   2>        
   [junit4]   2>                6       /solr/live_nodes
   [junit4]   2>                5       /solr/overseer/collection-queue-work
   [junit4]   2>                4       /solr/overseer/queue
   [junit4]   2>        
   [junit4]   2> 372949 T1751 c:control_collection s:shard1 x:collection1 
oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build/solr-core/test/J2/temp/solr.search.mlt.CloudMLTQParserTest
 C2022EB9223D4C4B-001
   [junit4]   2> 38288 T1750 ccr.ThreadLeakControl.checkThreadLeaks WARNING 
Will linger awaiting termination of 1 leaked thread(s).
   [junit4]   2> NOTE: test params are: codec=CheapBastard, 
sim=DefaultSimilarity, locale=en_IN, timezone=Europe/Volgograd
   [junit4]   2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 
1.7.0_72 (64-bit)/cpus=4,threads=1,free=276866488,total=372768768
   [junit4]   2> NOTE: All tests run in this JVM: [DateFieldTest, 
NotRequiredUniqueKeyTest, DirectSolrSpellCheckerTest, OverseerTest, 
HardAutoCommitTest, RulesTest, TestComplexPhraseQParserPlugin, 
AlternateDirectoryTest, OverseerCollectionProcessorTest, ZkControllerTest, 
DisMaxRequestHandlerTest, TestManagedSchema, StatsComponentTest, 
TestSuggestSpellingConverter, ReplicationFactorTest, SuggesterTSTTest, 
BadIndexSchemaTest, MinimalSchemaTest, TestHighlightDedupGrouping, 
TestPerFieldSimilarity, BufferStoreTest, ConvertedLegacyTest, 
TestManagedSchemaFieldTypeResource, UUIDFieldTest, TestAuthorizationFramework, 
TestSchemaResource, LeaderFailoverAfterPartitionTest, AutoCommitTest, 
TestStressLucene, TestOrdValues, CloudMLTQParserTest]
   [junit4] Completed [89/497] on J2 in 38.57s, 2 tests, 1 error <<< FAILURES!

[...truncated 1268 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/build.xml:536: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/build.xml:484: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/build.xml:61: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/extra-targets.xml:39:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/build.xml:229:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/solr/common-build.xml:511:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/lucene/common-build.xml:1436:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.2-Java7/lucene/common-build.xml:991:
 There were test failures: 497 suites, 1974 tests, 1 error, 58 ignored (25 
assumptions)

Total time: 49 minutes 52 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Sending artifact delta relative to Lucene-Solr-Tests-5.2-Java7 #18
Archived 4 artifacts
Archive block size is 32768
Received 0 blocks and 240673158 bytes
Compression is 0.0%
Took 46 sec
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure


---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to