Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Windows/4670/
Java: 64bit/jdk1.7.0_80 -XX:+UseCompressedOops -XX:+UseG1GC

1 tests failed.
FAILED:  org.apache.solr.cloud.MultiThreadedOCPTest.test

Error Message:
Captured an uncaught exception in thread: Thread[id=10620, 
name=parallelCoreAdminExecutor-5389-thread-21, state=RUNNABLE, 
group=TGRP-MultiThreadedOCPTest]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=10620, 
name=parallelCoreAdminExecutor-5389-thread-21, state=RUNNABLE, 
group=TGRP-MultiThreadedOCPTest]
        at 
__randomizedtesting.SeedInfo.seed([AC584D1A3DA75869:240C72C0935B3591]:0)
Caused by: java.lang.AssertionError: Too many closes on SolrCore
        at __randomizedtesting.SeedInfo.seed([AC584D1A3DA75869]:0)
        at org.apache.solr.core.SolrCore.close(SolrCore.java:1138)
        at org.apache.solr.common.util.IOUtils.closeQuietly(IOUtils.java:31)
        at org.apache.solr.core.CoreContainer.create(CoreContainer.java:535)
        at org.apache.solr.core.CoreContainer.create(CoreContainer.java:494)
        at 
org.apache.solr.handler.admin.CoreAdminHandler.handleCreateAction(CoreAdminHandler.java:628)
        at 
org.apache.solr.handler.admin.CoreAdminHandler.handleRequestInternal(CoreAdminHandler.java:213)
        at 
org.apache.solr.handler.admin.CoreAdminHandler$ParallelCoreAdminHandlerThread.run(CoreAdminHandler.java:1249)
        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:148)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
        at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 10850 lines...]
   [junit4] Suite: org.apache.solr.cloud.MultiThreadedOCPTest
   [junit4]   2> Creating dataDir: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\init-core-data-001
   [junit4]   2> 2057973 T10319 oas.SolrTestCaseJ4.buildSSLConfig Randomized 
ssl (false) and clientAuth (false)
   [junit4]   2> 2057973 T10319 
oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system 
property: /tsc/mg
   [junit4]   2> 2057977 T10319 oasc.ZkTestServer.run STARTING ZK TEST SERVER
   [junit4]   2> 2057978 T10320 oasc.ZkTestServer$2$1.setClientPort client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2057978 T10320 oasc.ZkTestServer$ZKServerMain.runFromConfig 
Starting server
   [junit4]   2> 2058065 T10319 oasc.ZkTestServer.run start zk server on 
port:52039
   [junit4]   2> 2058065 T10319 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 2058066 T10319 oascc.ConnectionManager.waitForConnected 
Waiting for client to connect to ZooKeeper
   [junit4]   2> 2058069 T10327 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@6a2c75b3 
name:ZooKeeperConnection Watcher:127.0.0.1:52039 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2058069 T10319 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 2058069 T10319 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 2058069 T10319 oascc.SolrZkClient.makePath makePath: /solr
   [junit4]   2> 2058071 T10319 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 2058071 T10321 oazs.NIOServerCnxn.doIO WARN caught end of 
stream exception EndOfStreamException: Unable to read additional data from 
client sessionid 0x14d3b7798c40000, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 
   [junit4]   2> 2058072 T10319 oascc.ConnectionManager.waitForConnected 
Waiting for client to connect to ZooKeeper
   [junit4]   2> 2058075 T10330 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@50ad942e 
name:ZooKeeperConnection Watcher:127.0.0.1:52039/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2058075 T10319 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 2058075 T10319 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 2058075 T10319 oascc.SolrZkClient.makePath makePath: 
/collections/collection1
   [junit4]   2> 2058077 T10319 oascc.SolrZkClient.makePath makePath: 
/collections/collection1/shards
   [junit4]   2> 2058079 T10319 oascc.SolrZkClient.makePath makePath: 
/collections/control_collection
   [junit4]   2> 2058082 T10319 oascc.SolrZkClient.makePath makePath: 
/collections/control_collection/shards
   [junit4]   2> 2058084 T10319 oasc.AbstractZkTestCase.putConfig put 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig-tlog.xml
 to /configs/conf1/solrconfig.xml
   [junit4]   2> 2058085 T10319 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/solrconfig.xml
   [junit4]   2> 2058088 T10319 oasc.AbstractZkTestCase.putConfig put 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\schema.xml
 to /configs/conf1/schema.xml
   [junit4]   2> 2058088 T10319 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/schema.xml
   [junit4]   2> 2058091 T10319 oasc.AbstractZkTestCase.putConfig put 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig.snippet.randomindexconfig.xml
 to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 2058092 T10319 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 2058093 T10319 oasc.AbstractZkTestCase.putConfig put 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\stopwords.txt
 to /configs/conf1/stopwords.txt
   [junit4]   2> 2058094 T10319 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/stopwords.txt
   [junit4]   2> 2058096 T10319 oasc.AbstractZkTestCase.putConfig put 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\protwords.txt
 to /configs/conf1/protwords.txt
   [junit4]   2> 2058096 T10319 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/protwords.txt
   [junit4]   2> 2058098 T10319 oasc.AbstractZkTestCase.putConfig put 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\currency.xml
 to /configs/conf1/currency.xml
   [junit4]   2> 2058098 T10319 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/currency.xml
   [junit4]   2> 2058101 T10319 oasc.AbstractZkTestCase.putConfig put 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\enumsConfig.xml
 to /configs/conf1/enumsConfig.xml
   [junit4]   2> 2058101 T10319 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/enumsConfig.xml
   [junit4]   2> 2058104 T10319 oasc.AbstractZkTestCase.putConfig put 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\open-exchange-rates.json
 to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 2058104 T10319 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/open-exchange-rates.json
   [junit4]   2> 2058106 T10319 oasc.AbstractZkTestCase.putConfig put 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\mapping-ISOLatin1Accent.txt
 to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 2058106 T10319 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 2058109 T10319 oasc.AbstractZkTestCase.putConfig put 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\old_synonyms.txt
 to /configs/conf1/old_synonyms.txt
   [junit4]   2> 2058109 T10319 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/old_synonyms.txt
   [junit4]   2> 2058111 T10319 oasc.AbstractZkTestCase.putConfig put 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\synonyms.txt
 to /configs/conf1/synonyms.txt
   [junit4]   2> 2058111 T10319 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/synonyms.txt
   [junit4]   2> 2058114 T10321 oazs.NIOServerCnxn.doIO WARN caught end of 
stream exception EndOfStreamException: Unable to read additional data from 
client sessionid 0x14d3b7798c40001, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 
   [junit4]   2> 2058356 T10319 oas.SolrTestCaseJ4.writeCoreProperties Writing 
core.properties file to 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\control-001\cores\collection1
   [junit4]   2> 2058359 T10319 oejs.Server.doStart jetty-9.2.10.v20150310
   [junit4]   2> 2058360 T10319 oejsh.ContextHandler.doStart Started 
o.e.j.s.ServletContextHandler@390984ae{/tsc/mg,null,AVAILABLE}
   [junit4]   2> 2058364 T10319 oejs.AbstractConnector.doStart Started 
ServerConnector@1fe5d8c3{HTTP/1.1}{127.0.0.1:52046}
   [junit4]   2> 2058364 T10319 oejs.Server.doStart Started @2060424ms
   [junit4]   2> 2058364 T10319 oascse.JettySolrRunner$1.lifeCycleStarted Jetty 
properties: {hostPort=52046, hostContext=/tsc/mg, 
coreRootDirectory=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\control-001\cores}
   [junit4]   2> 2058364 T10319 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@305f387c
   [junit4]   2> 2058364 T10319 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\control-001\'
   [junit4]   2> 2058394 T10319 oasc.SolrXmlConfig.fromFile Loading container 
configuration from 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\control-001\solr.xml
   [junit4]   2> 2058413 T10319 oasc.CorePropertiesLocator.<init> 
Config-defined core root directory: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\control-001\cores
   [junit4]   2> 2058413 T10319 oasc.CoreContainer.<init> New CoreContainer 
869153475
   [junit4]   2> 2058414 T10319 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\control-001\]
   [junit4]   2> 2058414 T10319 oasc.CoreContainer.load loading shared library: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\control-001\lib
   [junit4]   2> 2058414 T10319 oasc.SolrResourceLoader.addToClassLoader WARN 
Can't find (or read) directory to add to classloader: lib (resolved as: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\control-001\lib).
   [junit4]   2> 2058423 T10319 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> 2058425 T10319 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 2058425 T10319 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 2058426 T10319 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 2058426 T10319 oasc.CoreContainer.load Node Name: 127.0.0.1
   [junit4]   2> 2058426 T10319 oasc.ZkContainer.initZooKeeper Zookeeper 
client=127.0.0.1:52039/solr
   [junit4]   2> 2058426 T10319 oasc.ZkController.checkChrootPath zkHost 
includes chroot
   [junit4]   2> 2058426 T10319 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 2058428 T10319 oascc.ConnectionManager.waitForConnected 
Waiting for client to connect to ZooKeeper
   [junit4]   2> 2058429 T10344 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@6156036a 
name:ZooKeeperConnection Watcher:127.0.0.1:52039 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2058430 T10319 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 2058430 T10319 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 2058433 T10319 n:127.0.0.1:52046_tsc%2Fmg 
oascc.ConnectionManager.waitForConnected Waiting for client to connect to 
ZooKeeper
   [junit4]   2> 2058435 T10347 n:127.0.0.1:52046_tsc%2Fmg 
oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@39ab5365 
name:ZooKeeperConnection Watcher:127.0.0.1:52039/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2058435 T10319 n:127.0.0.1:52046_tsc%2Fmg 
oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 2058436 T10319 n:127.0.0.1:52046_tsc%2Fmg 
oascc.SolrZkClient.makePath makePath: /overseer/queue
   [junit4]   2> 2058439 T10319 n:127.0.0.1:52046_tsc%2Fmg 
oascc.SolrZkClient.makePath makePath: /overseer/collection-queue-work
   [junit4]   2> 2058441 T10319 n:127.0.0.1:52046_tsc%2Fmg 
oascc.SolrZkClient.makePath makePath: /overseer/collection-map-running
   [junit4]   2> 2058444 T10319 n:127.0.0.1:52046_tsc%2Fmg 
oascc.SolrZkClient.makePath makePath: /overseer/collection-map-completed
   [junit4]   2> 2058446 T10319 n:127.0.0.1:52046_tsc%2Fmg 
oascc.SolrZkClient.makePath makePath: /overseer/collection-map-failure
   [junit4]   2> 2058449 T10319 n:127.0.0.1:52046_tsc%2Fmg 
oascc.SolrZkClient.makePath makePath: /live_nodes
   [junit4]   2> 2058451 T10319 n:127.0.0.1:52046_tsc%2Fmg 
oascc.SolrZkClient.makePath makePath: /aliases.json
   [junit4]   2> 2058453 T10319 n:127.0.0.1:52046_tsc%2Fmg 
oascc.SolrZkClient.makePath makePath: /clusterstate.json
   [junit4]   2> 2058454 T10319 n:127.0.0.1:52046_tsc%2Fmg 
oasc.ZkController.createEphemeralLiveNode Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:52046_tsc%2Fmg
   [junit4]   2> 2058455 T10319 n:127.0.0.1:52046_tsc%2Fmg 
oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:52046_tsc%2Fmg
   [junit4]   2> 2058456 T10319 n:127.0.0.1:52046_tsc%2Fmg 
oascc.SolrZkClient.makePath makePath: /overseer_elect
   [junit4]   2> 2058458 T10319 n:127.0.0.1:52046_tsc%2Fmg 
oascc.SolrZkClient.makePath makePath: /overseer_elect/election
   [junit4]   2> 2058460 T10319 n:127.0.0.1:52046_tsc%2Fmg oasc.Overseer.close 
Overseer (id=null) closing
   [junit4]   2> 2058462 T10319 n:127.0.0.1:52046_tsc%2Fmg 
oasc.OverseerElectionContext.runLeaderProcess I am going to be the leader 
127.0.0.1:52046_tsc%2Fmg
   [junit4]   2> 2058462 T10319 n:127.0.0.1:52046_tsc%2Fmg 
oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
   [junit4]   2> 2058463 T10319 n:127.0.0.1:52046_tsc%2Fmg oasc.Overseer.start 
Overseer (id=93796552094777347-127.0.0.1:52046_tsc%2Fmg-n_0000000000) starting
   [junit4]   2> 2058466 T10319 n:127.0.0.1:52046_tsc%2Fmg 
oascc.SolrZkClient.makePath makePath: /overseer/queue-work
   [junit4]   2> 2058472 T10319 n:127.0.0.1:52046_tsc%2Fmg 
oasc.OverseerAutoReplicaFailoverThread.<init> Starting 
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=30000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 2058472 T10349 n:127.0.0.1:52046_tsc%2Fmg 
oasc.OverseerCollectionProcessor.run Process current queue of collection 
creations
   [junit4]   2> 2058472 T10319 n:127.0.0.1:52046_tsc%2Fmg 
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state 
from ZooKeeper... 
   [junit4]   2> 2058473 T10348 n:127.0.0.1:52046_tsc%2Fmg 
oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
   [junit4]   2> 2058478 T10319 n:127.0.0.1:52046_tsc%2Fmg 
oasc.CorePropertiesLocator.discover Looking for core definitions underneath 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\control-001\cores
   [junit4]   2> 2058480 T10319 n:127.0.0.1:52046_tsc%2Fmg 
oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {shard=, name=collection1, 
absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\control-001\cores\collection1\, schema=schema.xml, 
transient=false, loadOnStartup=true, collection=control_collection, 
instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\control-001\cores\collection1, dataDir=data\, 
config=solrconfig.xml, coreNodeName=}
   [junit4]   2> 2058480 T10319 n:127.0.0.1:52046_tsc%2Fmg 
oasc.CorePropertiesLocator.discoverUnder Found core collection1 in 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\control-001\cores\collection1\
   [junit4]   2> 2058480 T10319 n:127.0.0.1:52046_tsc%2Fmg 
oasc.CorePropertiesLocator.discover Found 1 core definitions
   [junit4]   2> 2058482 T10351 n:127.0.0.1:52046_tsc%2Fmg c:control_collection 
x:collection1 oasc.ZkController.publish publishing core=collection1 state=down 
collection=control_collection
   [junit4]   2> 2058482 T10351 n:127.0.0.1:52046_tsc%2Fmg c:control_collection 
x:collection1 oasc.ZkController.publish numShards not found on descriptor - 
reading it from system property
   [junit4]   2> 2058483 T10351 n:127.0.0.1:52046_tsc%2Fmg 
oasc.ZkController.waitForCoreNodeName look for our core node name
   [junit4]   2> 2058483 T10347 n:127.0.0.1:52046_tsc%2Fmg 
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path 
/overseer/queue state SyncConnected
   [junit4]   2> 2058484 T10348 n:127.0.0.1:52046_tsc%2Fmg 
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
   [junit4]   2>          "base_url":"http://127.0.0.1:52046/tsc/mg";,
   [junit4]   2>          "state":"down",
   [junit4]   2>          "shard":null,
   [junit4]   2>          "roles":null,
   [junit4]   2>          "numShards":"1",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "node_name":"127.0.0.1:52046_tsc%2Fmg",
   [junit4]   2>          "collection":"control_collection",
   [junit4]   2>          "core":"collection1"} current state version: 0
   [junit4]   2> 2058485 T10348 n:127.0.0.1:52046_tsc%2Fmg 
oasco.ReplicaMutator.updateState Update state numShards=1 message={
   [junit4]   2>          "base_url":"http://127.0.0.1:52046/tsc/mg";,
   [junit4]   2>          "state":"down",
   [junit4]   2>          "shard":null,
   [junit4]   2>          "roles":null,
   [junit4]   2>          "numShards":"1",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "node_name":"127.0.0.1:52046_tsc%2Fmg",
   [junit4]   2>          "collection":"control_collection",
   [junit4]   2>          "core":"collection1"}
   [junit4]   2> 2058485 T10348 n:127.0.0.1:52046_tsc%2Fmg 
oasco.ClusterStateMutator.createCollection building a new cName: 
control_collection
   [junit4]   2> 2058485 T10348 n:127.0.0.1:52046_tsc%2Fmg 
oasco.ReplicaMutator.updateState Assigning new node to shard shard=shard1
   [junit4]   2> 2058487 T10347 n:127.0.0.1:52046_tsc%2Fmg 
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> 2059348 T10351 n:127.0.0.1:52046_tsc%2Fmg 
oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for 
collection1
   [junit4]   2> 2059348 T10351 n:127.0.0.1:52046_tsc%2Fmg 
oasc.ZkController.createCollectionZkNode Check for collection 
zkNode:control_collection
   [junit4]   2> 2059348 T10351 n:127.0.0.1:52046_tsc%2Fmg 
oasc.ZkController.createCollectionZkNode Collection zkNode exists
   [junit4]   2> 2059349 T10351 n:127.0.0.1:52046_tsc%2Fmg 
oascc.ZkStateReader.readConfigName Load collection config 
from:/collections/control_collection
   [junit4]   2> 2059350 T10351 n:127.0.0.1:52046_tsc%2Fmg 
oascc.ZkStateReader.readConfigName path=/collections/control_collection 
configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 2059351 T10351 n:127.0.0.1:52046_tsc%2Fmg 
oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\control-001\cores\collection1\'
   [junit4]   2> 2059371 T10351 n:127.0.0.1:52046_tsc%2Fmg oasc.Config.<init> 
loaded config solrconfig.xml with version 0 
   [junit4]   2> 2059381 T10351 n:127.0.0.1:52046_tsc%2Fmg 
oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
   [junit4]   2> 2059396 T10351 n:127.0.0.1:52046_tsc%2Fmg 
oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0
   [junit4]   2> 2059427 T10351 n:127.0.0.1:52046_tsc%2Fmg 
oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 2059429 T10351 n:127.0.0.1:52046_tsc%2Fmg 
oass.IndexSchema.readSchema Reading Solr Schema from /configs/conf1/schema.xml
   [junit4]   2> 2059435 T10351 n:127.0.0.1:52046_tsc%2Fmg 
oass.IndexSchema.readSchema [collection1] Schema name=test
   [junit4]   2> 2059770 T10351 n:127.0.0.1:52046_tsc%2Fmg 
oass.OpenExchangeRatesOrgProvider.init Initialized with 
rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 2059823 T10351 n:127.0.0.1:52046_tsc%2Fmg 
oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 2059826 T10351 n:127.0.0.1:52046_tsc%2Fmg 
oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 2059842 T10351 n:127.0.0.1:52046_tsc%2Fmg 
oass.FileExchangeRateProvider.reload Reloading exchange rates from file 
currency.xml
   [junit4]   2> 2059845 T10351 n:127.0.0.1:52046_tsc%2Fmg 
oass.FileExchangeRateProvider.reload Reloading exchange rates from file 
currency.xml
   [junit4]   2> 2059850 T10351 n:127.0.0.1:52046_tsc%2Fmg 
oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 2059853 T10351 n:127.0.0.1:52046_tsc%2Fmg 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 2059853 T10351 n:127.0.0.1:52046_tsc%2Fmg 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 2059853 T10351 n:127.0.0.1:52046_tsc%2Fmg 
oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 2059855 T10351 n:127.0.0.1:52046_tsc%2Fmg 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 2059855 T10351 n:127.0.0.1:52046_tsc%2Fmg 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 2059855 T10351 n:127.0.0.1:52046_tsc%2Fmg 
oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration 
from collection control_collection
   [junit4]   2> 2059855 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 2059855 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasc.SolrCore.<init> [[collection1] ] Opening new SolrCore at 
[C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\control-001\cores\collection1\], dataDir=[null]
   [junit4]   2> 2059855 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to 
JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@27bf11d2
   [junit4]   2> 2059856 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasc.CachingDirectoryFactory.get return new directory for 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\control-001\cores\collection1\data\
   [junit4]   2> 2059856 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasc.SolrCore.getNewIndexDir New index directory detected: old=null 
new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\control-001\cores\collection1\data\index/
   [junit4]   2> 2059856 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasc.SolrCore.initIndex WARN [collection1] Solr index directory 
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\control-001\cores\collection1\data\index' doesn't exist. 
Creating new index...
   [junit4]   2> 2059856 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasc.CachingDirectoryFactory.get return new directory for 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\control-001\cores\collection1\data\index
   [junit4]   2> 2059857 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=10, maxMergeAtOnceExplicit=40, maxMergedSegmentMB=41.5302734375, 
floorSegmentMB=2.056640625, forceMergeDeletesPctAllowed=22.22031014376461, 
segmentsPerTier=45.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.3533984190452294
   [junit4]   2> 2059857 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@619cc145 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7a54cb13),segFN=segments_1,generation=1}
   [junit4]   2> 2059858 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 2059865 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"nodistrib"
   [junit4]   2> 2059866 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"dedupe"
   [junit4]   2> 2059866 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 2059866 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"stored_sig"
   [junit4]   2> 2059866 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 2059866 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"distrib-dup-test-chain-explicit"
   [junit4]   2> 2059866 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 2059867 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 2059867 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined 
as default, creating implicit default
   [junit4]   2> 2059873 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 2059877 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 2059878 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 2059880 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 2059885 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasc.RequestHandlers.initHandlersFromConfig Registered paths: 
/replication,/admin/threads,/admin/segments,/admin/properties,/update,/update/json/docs,/admin/plugins,/admin/mbeans,/update/csv,/admin/logging,standard,/get,/admin/luke,/config,/admin/file,/admin/system,/schema,/admin/ping,/update/json
   [junit4]   2> 2059888 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasc.SolrCore.initStatsCache Using default statsCache cache: 
org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 2059889 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasu.UpdateHandler.<init> Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2059889 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10
   [junit4]   2> 2059891 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 2059891 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 2059892 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=43, maxMergeAtOnceExplicit=44, maxMergedSegmentMB=17.2802734375, 
floorSegmentMB=1.326171875, forceMergeDeletesPctAllowed=26.73872094097295, 
segmentsPerTier=42.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.4845124496024623
   [junit4]   2> 2059893 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@619cc145 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7a54cb13),segFN=segments_1,generation=1}
   [junit4]   2> 2059893 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 2059893 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oass.SolrIndexSearcher.<init> Opening Searcher@1d58658a[collection1] main
   [junit4]   2> 2059893 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oascc.ZkStateReader.readConfigName Load collection config 
from:/collections/control_collection
   [junit4]   2> 2059894 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oascc.ZkStateReader.readConfigName path=/collections/control_collection 
configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 2059894 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for 
the RestManager with znodeBase: /configs/conf1
   [junit4]   2> 2059896 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured 
ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 2059896 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasr.RestManager.init Initializing RestManager with initArgs: {}
   [junit4]   2> 2059897 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasr.ManagedResourceStorage.load Reading _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 2059898 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found 
for znode /configs/conf1/_rest_managed.json
   [junit4]   2> 2059898 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasr.ManagedResourceStorage.load Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 2059898 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasr.RestManager.init Initializing 0 registered ManagedResources
   [junit4]   2> 2059898 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oash.ReplicationHandler.inform Commits will be reserved for  10000
   [junit4]   2> 2059899 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasc.ZkController.getConfDirListeners watch zkdir /configs/conf1
   [junit4]   2> 2059899 T10352 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasc.SolrCore.registerSearcher [collection1] Registered new searcher 
Searcher@1d58658a[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2059899 T10351 n:127.0.0.1:52046_tsc%2Fmg x:collection1 
oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 2059900 T10355 n:127.0.0.1:52046_tsc%2Fmg c:control_collection 
s:shard1 x:collection1 oasc.ZkController.register Register replica - 
core:collection1 address:http://127.0.0.1:52046/tsc/mg 
collection:control_collection shard:shard1
   [junit4]   2> 2059900 T10319 n:127.0.0.1:52046_tsc%2Fmg 
oass.SolrDispatchFilter.init 
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0
   [junit4]   2> 2059900 T10319 n:127.0.0.1:52046_tsc%2Fmg 
oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 2059901 T10355 n:127.0.0.1:52046_tsc%2Fmg c:control_collection 
s:shard1 x:collection1 oascc.SolrZkClient.makePath makePath: 
/collections/control_collection/leader_elect/shard1/election
   [junit4]   2> 2059902 T10319 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 2059908 T10319 oascc.ConnectionManager.waitForConnected 
Waiting for client to connect to ZooKeeper
   [junit4]   2> 2059909 T10358 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@7a77d080 
name:ZooKeeperConnection Watcher:127.0.0.1:52039/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2059909 T10319 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 2059909 T10319 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 2059909 T10319 
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state 
from ZooKeeper... 
   [junit4]   2> 2059910 T10355 n:127.0.0.1:52046_tsc%2Fmg c:control_collection 
s:shard1 x:collection1 oasc.ShardLeaderElectionContext.runLeaderProcess Running 
the leader process for shard shard1
   [junit4]   2> 2059912 T10347 n:127.0.0.1:52046_tsc%2Fmg 
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path 
/overseer/queue state SyncConnected
   [junit4]   2> 2059913 T10355 n:127.0.0.1:52046_tsc%2Fmg c:control_collection 
s:shard1 x:collection1 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp 
Enough replicas found to continue.
   [junit4]   2> 2059913 T10355 n:127.0.0.1:52046_tsc%2Fmg c:control_collection 
s:shard1 x:collection1 oasc.ShardLeaderElectionContext.runLeaderProcess I may 
be the new leader - try and sync
   [junit4]   2> ASYNC  NEW_CORE C1341 name=collection1 
org.apache.solr.core.SolrCore@66d4f0c 
url=http://127.0.0.1:52046/tsc/mg/collection1 node=127.0.0.1:52046_tsc%2Fmg 
C1341_STATE=coll:control_collection core:collection1 
props:{base_url=http://127.0.0.1:52046/tsc/mg, state=down, 
node_name=127.0.0.1:52046_tsc%2Fmg, core=collection1}
   [junit4]   2> 2059913 T10355 n:127.0.0.1:52046_tsc%2Fmg c:control_collection 
s:shard1 x:collection1 C1341 oasc.SyncStrategy.sync Sync replicas to 
http://127.0.0.1:52046/tsc/mg/collection1/
   [junit4]   2> 2059915 T10355 n:127.0.0.1:52046_tsc%2Fmg c:control_collection 
s:shard1 x:collection1 C1341 oasc.SyncStrategy.syncReplicas Sync Success - now 
sync replicas to me
   [junit4]   2> 2059915 T10348 n:127.0.0.1:52046_tsc%2Fmg 
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> 2059915 T10355 n:127.0.0.1:52046_tsc%2Fmg c:control_collection 
s:shard1 x:collection1 C1341 oasc.SyncStrategy.syncToMe 
http://127.0.0.1:52046/tsc/mg/collection1/ has no replicas
   [junit4]   2> 2059915 T10355 n:127.0.0.1:52046_tsc%2Fmg c:control_collection 
s:shard1 x:collection1 oasc.ShardLeaderElectionContext.runLeaderProcess I am 
the new leader: http://127.0.0.1:52046/tsc/mg/collection1/ shard1
   [junit4]   2> 2059915 T10319 oasc.ChaosMonkey.monkeyLog monkey: init - 
expire sessions:false cause connection loss:false
   [junit4]   2> 2059915 T10355 n:127.0.0.1:52046_tsc%2Fmg c:control_collection 
s:shard1 x:collection1 oascc.SolrZkClient.makePath makePath: 
/collections/control_collection/leaders/shard1
   [junit4]   2> 2059917 T10347 n:127.0.0.1:52046_tsc%2Fmg 
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> 2059917 T10358 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> 2059926 T10348 n:127.0.0.1:52046_tsc%2Fmg 
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":"http://127.0.0.1:52046/tsc/mg";,
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "state":"active"} current state version: 2
   [junit4]   2> 2059928 T10347 n:127.0.0.1:52046_tsc%2Fmg 
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path 
/overseer/queue state SyncConnected
   [junit4]   2> 2059930 T10358 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> 2059931 T10347 n:127.0.0.1:52046_tsc%2Fmg 
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> 2059970 T10355 n:127.0.0.1:52046_tsc%2Fmg c:control_collection 
s:shard1 x:collection1 oasc.ZkController.register We are 
http://127.0.0.1:52046/tsc/mg/collection1/ and leader is 
http://127.0.0.1:52046/tsc/mg/collection1/
   [junit4]   2> 2059970 T10355 n:127.0.0.1:52046_tsc%2Fmg c:control_collection 
s:shard1 x:collection1 oasc.ZkController.register No LogReplay needed for 
core=collection1 baseURL=http://127.0.0.1:52046/tsc/mg
   [junit4]   2> 2059970 T10355 n:127.0.0.1:52046_tsc%2Fmg c:control_collection 
s:shard1 x:collection1 oasc.ZkController.checkRecovery I am the leader, no 
recovery necessary
   [junit4]   2> 2059970 T10355 n:127.0.0.1:52046_tsc%2Fmg c:control_collection 
s:shard1 x:collection1 oasc.ZkController.publish publishing core=collection1 
state=active collection=control_collection
   [junit4]   2> 2059970 T10355 n:127.0.0.1:52046_tsc%2Fmg c:control_collection 
s:shard1 x:collection1 oasc.ZkController.publish numShards not found on 
descriptor - reading it from system property
   [junit4]   2> 2059972 T10347 n:127.0.0.1:52046_tsc%2Fmg 
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path 
/overseer/queue state SyncConnected
   [junit4]   2> 2059974 T10348 n:127.0.0.1:52046_tsc%2Fmg 
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
   [junit4]   2>          "base_url":"http://127.0.0.1:52046/tsc/mg";,
   [junit4]   2>          "state":"active",
   [junit4]   2>          "core_node_name":"core_node1",
   [junit4]   2>          "shard":"shard1",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "numShards":"2",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "node_name":"127.0.0.1:52046_tsc%2Fmg",
   [junit4]   2>          "collection":"control_collection",
   [junit4]   2>          "core":"collection1"} current state version: 3
   [junit4]   2> 2059975 T10348 n:127.0.0.1:52046_tsc%2Fmg 
oasco.ReplicaMutator.updateState Update state numShards=2 message={
   [junit4]   2>          "base_url":"http://127.0.0.1:52046/tsc/mg";,
   [junit4]   2>          "state":"active",
   [junit4]   2>          "core_node_name":"core_node1",
   [junit4]   2>          "shard":"shard1",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "numShards":"2",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "node_name":"127.0.0.1:52046_tsc%2Fmg",
   [junit4]   2>          "collection":"control_collection",
   [junit4]   2>          "core":"collection1"}
   [junit4]   2> 2060065 T10347 n:127.0.0.1:52046_tsc%2Fmg 
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> 2060065 T10358 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> 2060210 T10319 oas.SolrTestCaseJ4.writeCoreProperties Writing 
core.properties file to 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-1-001\cores\collection1
   [junit4]   2> 2060213 T10319 oasc.AbstractFullDistribZkTestBase.createJettys 
create jetty 1 in directory 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-1-001
   [junit4]   2> 2060213 T10319 oejs.Server.doStart jetty-9.2.10.v20150310
   [junit4]   2> 2060216 T10319 oejsh.ContextHandler.doStart Started 
o.e.j.s.ServletContextHandler@35e8537a{/tsc/mg,null,AVAILABLE}
   [junit4]   2> 2060218 T10319 oejs.AbstractConnector.doStart Started 
ServerConnector@27c08a3c{HTTP/1.1}{127.0.0.1:52067}
   [junit4]   2> 2060218 T10319 oejs.Server.doStart Started @2062278ms
   [junit4]   2> 2060218 T10319 oascse.JettySolrRunner$1.lifeCycleStarted Jetty 
properties: {solrconfig=solrconfig.xml, hostContext=/tsc/mg, hostPort=52067, 
coreRootDirectory=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-1-001\cores}
   [junit4]   2> 2060218 T10319 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@305f387c
   [junit4]   2> 2060219 T10319 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-1-001\'
   [junit4]   2> 2060246 T10319 oasc.SolrXmlConfig.fromFile Loading container 
configuration from 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-1-001\solr.xml
   [junit4]   2> 2060264 T10319 oasc.CorePropertiesLocator.<init> 
Config-defined core root directory: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-1-001\cores
   [junit4]   2> 2060265 T10319 oasc.CoreContainer.<init> New CoreContainer 
1409616674
   [junit4]   2> 2060265 T10319 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-1-001\]
   [junit4]   2> 2060265 T10319 oasc.CoreContainer.load loading shared library: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-1-001\lib
   [junit4]   2> 2060266 T10319 oasc.SolrResourceLoader.addToClassLoader WARN 
Can't find (or read) directory to add to classloader: lib (resolved as: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-1-001\lib).
   [junit4]   2> 2060274 T10319 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> 2060276 T10319 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 2060277 T10319 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 2060277 T10319 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 2060278 T10319 oasc.CoreContainer.load Node Name: 127.0.0.1
   [junit4]   2> 2060278 T10319 oasc.ZkContainer.initZooKeeper Zookeeper 
client=127.0.0.1:52039/solr
   [junit4]   2> 2060278 T10319 oasc.ZkController.checkChrootPath zkHost 
includes chroot
   [junit4]   2> 2060278 T10319 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 2060279 T10319 oascc.ConnectionManager.waitForConnected 
Waiting for client to connect to ZooKeeper
   [junit4]   2> 2060282 T10372 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@36cf0c5d 
name:ZooKeeperConnection Watcher:127.0.0.1:52039 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2060282 T10319 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 2060282 T10319 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 2060284 T10319 n:127.0.0.1:52067_tsc%2Fmg 
oascc.ConnectionManager.waitForConnected Waiting for client to connect to 
ZooKeeper
   [junit4]   2> 2060286 T10375 n:127.0.0.1:52067_tsc%2Fmg 
oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@356d9d79 
name:ZooKeeperConnection Watcher:127.0.0.1:52039/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2060287 T10319 n:127.0.0.1:52067_tsc%2Fmg 
oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 2060292 T10319 n:127.0.0.1:52067_tsc%2Fmg 
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state 
from ZooKeeper... 
   [junit4]   2> 2061169 T10319 n:127.0.0.1:52067_tsc%2Fmg 
oasc.ZkController.createEphemeralLiveNode Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:52067_tsc%2Fmg
   [junit4]   2> 2061170 T10319 n:127.0.0.1:52067_tsc%2Fmg 
oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:52067_tsc%2Fmg
   [junit4]   2> 2061178 T10319 n:127.0.0.1:52067_tsc%2Fmg oasc.Overseer.close 
Overseer (id=null) closing
   [junit4]   2> 2061197 T10319 n:127.0.0.1:52067_tsc%2Fmg 
oasc.CorePropertiesLocator.discover Looking for core definitions underneath 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-1-001\cores
   [junit4]   2> 2061198 T10319 n:127.0.0.1:52067_tsc%2Fmg 
oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {config=solrconfig.xml, 
loadOnStartup=true, name=collection1, 
absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-1-001\cores\collection1\, schema=schema.xml, 
transient=false, dataDir=data\, collection=collection1, 
instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-1-001\cores\collection1, coreNodeName=, shard=}
   [junit4]   2> 2061199 T10319 n:127.0.0.1:52067_tsc%2Fmg 
oasc.CorePropertiesLocator.discoverUnder Found core collection1 in 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-1-001\cores\collection1\
   [junit4]   2> 2061199 T10319 n:127.0.0.1:52067_tsc%2Fmg 
oasc.CorePropertiesLocator.discover Found 1 core definitions
   [junit4]   2> 2061205 T10376 n:127.0.0.1:52067_tsc%2Fmg c:collection1 
x:collection1 oasc.ZkController.publish publishing core=collection1 state=down 
collection=collection1
   [junit4]   2> 2061205 T10376 n:127.0.0.1:52067_tsc%2Fmg c:collection1 
x:collection1 oasc.ZkController.publish numShards not found on descriptor - 
reading it from system property
   [junit4]   2> 2061213 T10376 n:127.0.0.1:52067_tsc%2Fmg 
oasc.ZkController.waitForCoreNodeName look for our core node name
   [junit4]   2> 2061216 T10347 n:127.0.0.1:52046_tsc%2Fmg 
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path 
/overseer/queue state SyncConnected
   [junit4]   2> 2061220 T10348 n:127.0.0.1:52046_tsc%2Fmg 
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
   [junit4]   2>          "base_url":"http://127.0.0.1:52067/tsc/mg";,
   [junit4]   2>          "state":"down",
   [junit4]   2>          "shard":null,
   [junit4]   2>          "roles":null,
   [junit4]   2>          "numShards":"2",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "node_name":"127.0.0.1:52067_tsc%2Fmg",
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "core":"collection1"} current state version: 4
   [junit4]   2> 2061222 T10348 n:127.0.0.1:52046_tsc%2Fmg 
oasco.ReplicaMutator.updateState Update state numShards=2 message={
   [junit4]   2>          "base_url":"http://127.0.0.1:52067/tsc/mg";,
   [junit4]   2>          "state":"down",
   [junit4]   2>          "shard":null,
   [junit4]   2>          "roles":null,
   [junit4]   2>          "numShards":"2",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "node_name":"127.0.0.1:52067_tsc%2Fmg",
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "core":"collection1"}
   [junit4]   2> 2061222 T10348 n:127.0.0.1:52046_tsc%2Fmg 
oasco.ClusterStateMutator.createCollection building a new cName: collection1
   [junit4]   2> 2061222 T10348 n:127.0.0.1:52046_tsc%2Fmg 
oasco.ReplicaMutator.updateState Assigning new node to shard shard=shard1
   [junit4]   2> 2061323 T10375 n:127.0.0.1:52067_tsc%2Fmg 
oascc.ZkStateReader$2.process A cluster state change: WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred 
- updating... (live nodes size: 2)
   [junit4]   2> 2061325 T10347 n:127.0.0.1:52046_tsc%2Fmg 
oascc.ZkStateReader$2.process A cluster state change: WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred 
- updating... (live nodes size: 2)
   [junit4]   2> 2061327 T10358 oascc.ZkStateReader$2.process A cluster state 
change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
   [junit4]   2> 2062079 T10376 n:127.0.0.1:52067_tsc%2Fmg 
oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for 
collection1
   [junit4]   2> 2062079 T10376 n:127.0.0.1:52067_tsc%2Fmg 
oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
   [junit4]   2> 2062079 T10376 n:127.0.0.1:52067_tsc%2Fmg 
oasc.ZkController.createCollectionZkNode Collection zkNode exists
   [junit4]   2> 2062080 T10376 n:127.0.0.1:52067_tsc%2Fmg 
oascc.ZkStateReader.readConfigName Load collection config 
from:/collections/collection1
   [junit4]   2> 2062080 T10376 n:127.0.0.1:52067_tsc%2Fmg 
oascc.ZkStateReader.readConfigName path=/collections/collection1 
configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 2062080 T10376 n:127.0.0.1:52067_tsc%2Fmg 
oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-1-001\cores\collection1\'
   [junit4]   2> 2062107 T10376 n:127.0.0.1:52067_tsc%2Fmg oasc.Config.<init> 
loaded config solrconfig.xml with version 0 
   [junit4]   2> 2062117 T10376 n:127.0.0.1:52067_tsc%2Fmg 
oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
   [junit4]   2> 2062137 T10376 n:127.0.0.1:52067_tsc%2Fmg 
oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0
   [junit4]   2> 2062188 T10376 n:127.0.0.1:52067_tsc%2Fmg 
oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 2062190 T10376 n:127.0.0.1:52067_tsc%2Fmg 
oass.IndexSchema.readSchema Reading Solr Schema from /configs/conf1/schema.xml
   [junit4]   2> 2062200 T10376 n:127.0.0.1:52067_tsc%2Fmg 
oass.IndexSchema.readSchema [collection1] Schema name=test
   [junit4]   2> 2062700 T10376 n:127.0.0.1:52067_tsc%2Fmg 
oass.OpenExchangeRatesOrgProvider.init Initialized with 
rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 2062714 T10376 n:127.0.0.1:52067_tsc%2Fmg 
oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 2062718 T10376 n:127.0.0.1:52067_tsc%2Fmg 
oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 2062731 T10376 n:127.0.0.1:52067_tsc%2Fmg 
oass.FileExchangeRateProvider.reload Reloading exchange rates from file 
currency.xml
   [junit4]   2> 2062734 T10376 n:127.0.0.1:52067_tsc%2Fmg 
oass.FileExchangeRateProvider.reload Reloading exchange rates from file 
currency.xml
   [junit4]   2> 2062737 T10376 n:127.0.0.1:52067_tsc%2Fmg 
oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 2062740 T10376 n:127.0.0.1:52067_tsc%2Fmg 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 2062740 T10376 n:127.0.0.1:52067_tsc%2Fmg 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 2062740 T10376 n:127.0.0.1:52067_tsc%2Fmg 
oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 2062743 T10376 n:127.0.0.1:52067_tsc%2Fmg 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 2062744 T10376 n:127.0.0.1:52067_tsc%2Fmg 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 2062744 T10376 n:127.0.0.1:52067_tsc%2Fmg 
oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration 
from collection collection1
   [junit4]   2> 2062745 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 2062745 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasc.SolrCore.<init> [[collection1] ] Opening new SolrCore at 
[C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-1-001\cores\collection1\], dataDir=[null]
   [junit4]   2> 2062745 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to 
JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@27bf11d2
   [junit4]   2> 2062746 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasc.CachingDirectoryFactory.get return new directory for 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-1-001\cores\collection1\data\
   [junit4]   2> 2062746 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasc.SolrCore.getNewIndexDir New index directory detected: old=null 
new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-1-001\cores\collection1\data\index/
   [junit4]   2> 2062746 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasc.SolrCore.initIndex WARN [collection1] Solr index directory 
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-1-001\cores\collection1\data\index' doesn't exist. 
Creating new index...
   [junit4]   2> 2062747 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasc.CachingDirectoryFactory.get return new directory for 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-1-001\cores\collection1\data\index
   [junit4]   2> 2062747 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=10, maxMergeAtOnceExplicit=40, maxMergedSegmentMB=41.5302734375, 
floorSegmentMB=2.056640625, forceMergeDeletesPctAllowed=22.22031014376461, 
segmentsPerTier=45.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.3533984190452294
   [junit4]   2> 2062750 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@5ba98bc9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@58186822),segFN=segments_1,generation=1}
   [junit4]   2> 2062750 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 2062761 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"nodistrib"
   [junit4]   2> 2062762 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"dedupe"
   [junit4]   2> 2062762 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 2062762 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"stored_sig"
   [junit4]   2> 2062762 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 2062762 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"distrib-dup-test-chain-explicit"
   [junit4]   2> 2062763 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 2062763 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 2062764 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined 
as default, creating implicit default
   [junit4]   2> 2062773 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 2062775 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 2062777 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 2062779 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 2062855 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasc.RequestHandlers.initHandlersFromConfig Registered paths: 
/replication,/admin/threads,/admin/segments,/admin/properties,/update,/update/json/docs,/admin/plugins,/admin/mbeans,/update/csv,/admin/logging,standard,/get,/admin/luke,/config,/admin/file,/admin/system,/schema,/admin/ping,/update/json
   [junit4]   2> 2062855 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasc.SolrCore.initStatsCache Using default statsCache cache: 
org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 2062859 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasu.UpdateHandler.<init> Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2062859 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10
   [junit4]   2> 2062861 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 2062861 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 2062865 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=43, maxMergeAtOnceExplicit=44, maxMergedSegmentMB=17.2802734375, 
floorSegmentMB=1.326171875, forceMergeDeletesPctAllowed=26.73872094097295, 
segmentsPerTier=42.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.4845124496024623
   [junit4]   2> 2062866 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@5ba98bc9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@58186822),segFN=segments_1,generation=1}
   [junit4]   2> 2062866 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 2062867 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oass.SolrIndexSearcher.<init> Opening Searcher@4cd88a80[collection1] main
   [junit4]   2> 2062867 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oascc.ZkStateReader.readConfigName Load collection config 
from:/collections/collection1
   [junit4]   2> 2062869 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oascc.ZkStateReader.readConfigName path=/collections/collection1 
configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 2062869 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for 
the RestManager with znodeBase: /configs/conf1
   [junit4]   2> 2062870 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured 
ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 2062870 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasr.RestManager.init Initializing RestManager with initArgs: {}
   [junit4]   2> 2062870 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasr.ManagedResourceStorage.load Reading _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 2062872 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found 
for znode /configs/conf1/_rest_managed.json
   [junit4]   2> 2062872 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasr.ManagedResourceStorage.load Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 2062872 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasr.RestManager.init Initializing 0 registered ManagedResources
   [junit4]   2> 2062872 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oash.ReplicationHandler.inform Commits will be reserved for  10000
   [junit4]   2> 2062872 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasc.ZkController.getConfDirListeners watch zkdir /configs/conf1
   [junit4]   2> 2062874 T10377 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasc.SolrCore.registerSearcher [collection1] Registered new searcher 
Searcher@4cd88a80[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2062875 T10376 n:127.0.0.1:52067_tsc%2Fmg x:collection1 
oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 2062876 T10380 n:127.0.0.1:52067_tsc%2Fmg c:collection1 
s:shard1 x:collection1 oasc.ZkController.register Register replica - 
core:collection1 address:http://127.0.0.1:52067/tsc/mg collection:collection1 
shard:shard1
   [junit4]   2> 2062878 T10319 n:127.0.0.1:52067_tsc%2Fmg 
oass.SolrDispatchFilter.init 
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0
   [junit4]   2> 2062878 T10319 n:127.0.0.1:52067_tsc%2Fmg 
oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 2062886 T10380 n:127.0.0.1:52067_tsc%2Fmg c:collection1 
s:shard1 x:collection1 oascc.SolrZkClient.makePath makePath: 
/collections/collection1/leader_elect/shard1/election
   [junit4]   2> 2062914 T10380 n:127.0.0.1:52067_tsc%2Fmg c:collection1 
s:shard1 x:collection1 oasc.ShardLeaderElectionContext.runLeaderProcess Running 
the leader process for shard shard1
   [junit4]   2> 2062915 T10347 n:127.0.0.1:52046_tsc%2Fmg 
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path 
/overseer/queue state SyncConnected
   [junit4]   2> 2062918 T10380 n:127.0.0.1:52067_tsc%2Fmg c:collection1 
s:shard1 x:collection1 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp 
Enough replicas found to continue.
   [junit4]   2> 2062918 T10380 n:127.0.0.1:52067_tsc%2Fmg c:collection1 
s:shard1 x:collection1 oasc.ShardLeaderElectionContext.runLeaderProcess I may 
be the new leader - try and sync
   [junit4]   2> ASYNC  NEW_CORE C1342 name=collection1 
org.apache.solr.core.SolrCore@aaed573 
url=http://127.0.0.1:52067/tsc/mg/collection1 node=127.0.0.1:52067_tsc%2Fmg 
C1342_STATE=coll:collection1 core:collection1 
props:{base_url=http://127.0.0.1:52067/tsc/mg, state=down, 
node_name=127.0.0.1:52067_tsc%2Fmg, core=collection1}
   [junit4]   2> 2062918 T10380 n:127.0.0.1:52067_tsc%2Fmg c:collection1 
s:shard1 x:collection1 C1342 oasc.SyncStrategy.sync Sync replicas to 
http://127.0.0.1:52067/tsc/mg/collection1/
   [junit4]   2> 2062918 T10380 n:127.0.0.1:52067_tsc%2Fmg c:collection1 
s:shard1 x:collection1 C1342 oasc.SyncStrategy.syncReplicas Sync Success - now 
sync replicas to me
   [junit4]   2> 2062918 T10380 n:127.0.0.1:52067_tsc%2Fmg c:collection1 
s:shard1 x:collection1 C1342 oasc.SyncStrategy.syncToMe 
http://127.0.0.1:52067/tsc/mg/collection1/ has no replicas
   [junit4]   2> 2062918 T10380 n:127.0.0.1:52067_tsc%2Fmg c:collection1 
s:shard1 x:collection1 oasc.ShardLeaderElectionContext.runLeaderProcess I am 
the new leader: http://127.0.0.1:52067/tsc/mg/collection1/ shard1
   [junit4]   2> 2062919 T10380 n:127.0.0.1:52067_tsc%2Fmg c:collection1 
s:shard1 x:collection1 oascc.SolrZkClient.makePath makePath: 
/collections/collection1/leaders/shard1
   [junit4]   2> 2062922 T10348 n:127.0.0.1:52046_tsc%2Fmg 
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> 2062924 T10358 oascc.ZkStateReader$2.process A cluster state 
change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
   [junit4]   2> 2062924 T10375 n:127.0.0.1:52067_tsc%2Fmg 
oascc.ZkStateReader$2.process A cluster state change: WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred 
- updating... (live nodes size: 2)
   [junit4]   2> 2062924 T10347 n:127.0.0.1:52046_tsc%2Fmg 
oascc.ZkStateReader$2.process A cluster state change: WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred 
- updating... (live nodes size: 2)
   [junit4]   2> 2062929 T10348 n:127.0.0.1:52046_tsc%2Fmg 
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
   [junit4]   2>          "operation":"leader",
   [junit4]   2>          "shard":"shard1",
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "base_url":"http://127.0.0.1:52067/tsc/mg";,
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "state":"active"} current state version: 6
   [junit4]   2> 2062930 T10347 n:127.0.0.1:52046_tsc%2Fmg 
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path 
/overseer/queue state SyncConnected
   [junit4]   2> 2062932 T10358 oascc.ZkStateReader$2.process A cluster state 
change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
   [junit4]   2> 2062933 T10347 n:127.0.0.1:52046_tsc%2Fmg 
oascc.ZkStateReader$2.process A cluster state change: WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred 
- updating... (live nodes size: 2)
   [junit4]   2> 2062938 T10381 n:127.0.0.1:52067_tsc%2Fmg 
oascc.ZkStateReader$2.process A cluster state change: WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred 
- updating... (live nodes size: 2)
   [junit4]   2> 2062979 T10380 n:127.0.0.1:52067_tsc%2Fmg c:collection1 
s:shard1 x:collection1 oasc.ZkController.register We are 
http://127.0.0.1:52067/tsc/mg/collection1/ and leader is 
http://127.0.0.1:52067/tsc/mg/collection1/
   [junit4]   2> 2062979 T10380 n:127.0.0.1:52067_tsc%2Fmg c:collection1 
s:shard1 x:collection1 oasc.ZkController.register No LogReplay needed for 
core=collection1 baseURL=http://127.0.0.1:52067/tsc/mg
   [junit4]   2> 2062979 T10380 n:127.0.0.1:52067_tsc%2Fmg c:collection1 
s:shard1 x:collection1 oasc.ZkController.checkRecovery I am the leader, no 
recovery necessary
   [junit4]   2> 2062979 T10380 n:127.0.0.1:52067_tsc%2Fmg c:collection1 
s:shard1 x:collection1 oasc.ZkController.publish publishing core=collection1 
state=active collection=collection1
   [junit4]   2> 2062979 T10380 n:127.0.0.1:52067_tsc%2Fmg c:collection1 
s:shard1 x:collection1 oasc.ZkController.publish numShards not found on 
descriptor - reading it from system property
   [junit4]   2> 2062991 T10347 n:127.0.0.1:52046_tsc%2Fmg 
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path 
/overseer/queue state SyncConnected
   [junit4]   2> 2062993 T10348 n:127.0.0.1:52046_tsc%2Fmg 
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
   [junit4]   2>          "base_url":"http://127.0.0.1:52067/tsc/mg";,
   [junit4]   2>          "state":"active",
   [junit4]   2>          "core_node_name":"core_node1",
   [junit4]   2>          "shard":"shard1",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "numShards":"2",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "node_name":"127.0.0.1:52067_tsc%2Fmg",
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "core":"collection1"} current state version: 7
   [junit4]   2> 2062994 T10348 n:127.0.0.1:52046_tsc%2Fmg 
oasco.ReplicaMutator.updateState Update state numShards=2 message={
   [junit4]   2>          "base_url":"http://127.0.0.1:52067/tsc/mg";,
   [junit4]   2>          "state":"active",
   [junit4]   2>          "core_node_name":"core_node1",
   [junit4]   2>          "shard":"shard1",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "numShards":"2",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "node_name":"127.0.0.1:52067_tsc%2Fmg",
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "core":"collection1"}
   [junit4]   2> 2063099 T10358 oascc.ZkStateReader$2.process A cluster state 
change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
   [junit4]   2> 2063099 T10381 n:127.0.0.1:52067_tsc%2Fmg 
oascc.ZkStateReader$2.process A cluster state change: WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred 
- updating... (live nodes size: 2)
   [junit4]   2> 2063100 T10347 n:127.0.0.1:52046_tsc%2Fmg 
oascc.ZkStateReader$2.process A cluster state change: WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred 
- updating... (live nodes size: 2)
   [junit4]   2> 2063250 T10319 oas.SolrTestCaseJ4.writeCoreProperties Writing 
core.properties file to 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-2-001\cores\collection1
   [junit4]   2> 2063254 T10319 oasc.AbstractFullDistribZkTestBase.createJettys 
create jetty 2 in directory 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-2-001
   [junit4]   2> 2063255 T10319 oejs.Server.doStart jetty-9.2.10.v20150310
   [junit4]   2> 2063265 T10319 oejsh.ContextHandler.doStart Started 
o.e.j.s.ServletContextHandler@2d15bf20{/tsc/mg,null,AVAILABLE}
   [junit4]   2> 2063266 T10319 oejs.AbstractConnector.doStart Started 
ServerConnector@29745a22{HTTP/1.1}{127.0.0.1:52086}
   [junit4]   2> 2063267 T10319 oejs.Server.doStart Started @2065327ms
   [junit4]   2> 2063267 T10319 oascse.JettySolrRunner$1.lifeCycleStarted Jetty 
properties: {hostPort=52086, solrconfig=solrconfig.xml, 
coreRootDirectory=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-2-001\cores, hostContext=/tsc/mg}
   [junit4]   2> 2063268 T10319 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@305f387c
   [junit4]   2> 2063268 T10319 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-2-001\'
   [junit4]   2> 2063300 T10319 oasc.SolrXmlConfig.fromFile Loading container 
configuration from 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-2-001\solr.xml
   [junit4]   2> 2063325 T10319 oasc.CorePropertiesLocator.<init> 
Config-defined core root directory: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-2-001\cores
   [junit4]   2> 2063325 T10319 oasc.CoreContainer.<init> New CoreContainer 
402205445
   [junit4]   2> 2063326 T10319 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-2-001\]
   [junit4]   2> 2063326 T10319 oasc.CoreContainer.load loading shared library: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-2-001\lib
   [junit4]   2> 2063326 T10319 oasc.SolrResourceLoader.addToClassLoader WARN 
Can't find (or read) directory to add to classloader: lib (resolved as: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-2-001\lib).
   [junit4]   2> 2063335 T10319 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> 2063336 T10319 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 2063337 T10319 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 2063337 T10319 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 2063337 T10319 oasc.CoreContainer.load Node Name: 127.0.0.1
   [junit4]   2> 2063337 T10319 oasc.ZkContainer.initZooKeeper Zookeeper 
client=127.0.0.1:52039/solr
   [junit4]   2> 2063337 T10319 oasc.ZkController.checkChrootPath zkHost 
includes chroot
   [junit4]   2> 2063337 T10319 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 2063337 T10319 oascc.ConnectionManager.waitForConnected 
Waiting for client to connect to ZooKeeper
   [junit4]   2> 2063342 T10395 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@1ce92f92 
name:ZooKeeperConnection Watcher:127.0.0.1:52039 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2063342 T10319 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 2063342 T10319 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 2063346 T10319 n:127.0.0.1:52086_tsc%2Fmg 
oascc.ConnectionManager.waitForConnected Waiting for client to connect to 
ZooKeeper
   [junit4]   2> 2063353 T10398 n:127.0.0.1:52086_tsc%2Fmg 
oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@8ee68da name:ZooKeeperConnection 
Watcher:127.0.0.1:52039/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 2063353 T10319 n:127.0.0.1:52086_tsc%2Fmg 
oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 2063362 T10319 n:127.0.0.1:52086_tsc%2Fmg 
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state 
from ZooKeeper... 
   [junit4]   2> 2064240 T10319 n:127.0.0.1:52086_tsc%2Fmg 
oasc.ZkController.createEphemeralLiveNode Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:52086_tsc%2Fmg
   [junit4]   2> 2064241 T10319 n:127.0.0.1:52086_tsc%2Fmg 
oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:52086_tsc%2Fmg
   [junit4]   2> 2064248 T10319 n:127.0.0.1:52086_tsc%2Fmg oasc.Overseer.close 
Overseer (id=null) closing
   [junit4]   2> 2064257 T10319 n:127.0.0.1:52086_tsc%2Fmg 
oasc.CorePropertiesLocator.discover Looking for core definitions underneath 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-2-001\cores
   [junit4]   2> 2064260 T10319 n:127.0.0.1:52086_tsc%2Fmg 
oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {collection=collection1, 
instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-2-001\cores\collection1, dataDir=data\, 
coreNodeName=, 
absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-2-001\cores\collection1\, shard=, 
schema=schema.xml, transient=false, loadOnStartup=true, config=solrconfig.xml, 
name=collection1}
   [junit4]   2> 2064261 T10319 n:127.0.0.1:52086_tsc%2Fmg 
oasc.CorePropertiesLocator.discoverUnder Found core collection1 in 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-2-001\cores\collection1\
   [junit4]   2> 2064262 T10319 n:127.0.0.1:52086_tsc%2Fmg 
oasc.CorePropertiesLocator.discover Found 1 core definitions
   [junit4]   2> 2064265 T10399 n:127.0.0.1:52086_tsc%2Fmg c:collection1 
x:collection1 oasc.ZkController.publish publishing core=collection1 state=down 
collection=collection1
   [junit4]   2> 2064265 T10399 n:127.0.0.1:52086_tsc%2Fmg c:collection1 
x:collection1 oasc.ZkController.publish numShards not found on descriptor - 
reading it from system property
   [junit4]   2> 2064266 T10399 n:127.0.0.1:52086_tsc%2Fmg 
oasc.ZkController.waitForCoreNodeName look for our core node name
   [junit4]   2> 2064266 T10347 n:127.0.0.1:52046_tsc%2Fmg 
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path 
/overseer/queue state SyncConnected
   [junit4]   2> 2064268 T10348 n:127.0.0.1:52046_tsc%2Fmg 
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
   [junit4]   2>          "base_url":"http://127.0.0.1:52086/tsc/mg";,
   [junit4]   2>          "state":"down",
   [junit4]   2>          "shard":null,
   [junit4]   2>          "roles":null,
   [junit4]   2>          "numShards":"2",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "node_name":"127.0.0.1:52086_tsc%2Fmg",
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "core":"collection1"} current state version: 8
   [junit4]   2> 2064269 T10348 n:127.0.0.1:52046_tsc%2Fmg 
oasco.ReplicaMutator.updateState Update state numShards=2 message={
   [junit4]   2>          "base_url":"http://127.0.0.1:52086/tsc/mg";,
   [junit4]   2>          "state":"down",
   [junit4]   2>          "shard":null,
   [junit4]   2>          "roles":null,
   [junit4]   2>          "numShards":"2",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "node_name":"127.0.0.1:52086_tsc%2Fmg",
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "core":"collection1"}
   [junit4]   2> 2064269 T10348 n:127.0.0.1:52046_tsc%2Fmg 
oasco.ReplicaMutator.updateState Collection already exists with numShards=2
   [junit4]   2> 2064269 T10348 n:127.0.0.1:52046_tsc%2Fmg 
oasco.ReplicaMutator.updateState Assigning new node to shard shard=shard2
   [junit4]   2> 2064269 T10381 n:127.0.0.1:52067_tsc%2Fmg 
oascc.ZkStateReader$2.process A cluster state change: WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred 
- updating... (live nodes size: 3)
   [junit4]   2> 2064270 T10358 oascc.ZkStateReader$2.process A cluster state 
change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
   [junit4]   2> 2064270 T10398 n:127.0.0.1:52086_tsc%2Fmg 
oascc.ZkStateReader$2.process A cluster state change: WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred 
- updating... (live nodes size: 3)
   [junit4]   2> 2064270 T10347 n:127.0.0.1:52046_tsc%2Fmg 
oascc.ZkStateReader$2.process A cluster state change: WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred 
- updating... (live nodes size: 3)
   [junit4]   2> 2065132 T10399 n:127.0.0.1:52086_tsc%2Fmg 
oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for 
collection1
   [junit4]   2> 2065132 T10399 n:127.0.0.1:52086_tsc%2Fmg 
oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
   [junit4]   2> 2065133 T10399 n:127.0.0.1:52086_tsc%2Fmg 
oasc.ZkController.createCollectionZkNode Collection zkNode exists
   [junit4]   2> 2065133 T10399 n:127.0.0.1:52086_tsc%2Fmg 
oascc.ZkStateReader.readConfigName Load collection config 
from:/collections/collection1
   [junit4]   2> 2065142 T10399 n:127.0.0.1:52086_tsc%2Fmg 
oascc.ZkStateReader.readConfigName path=/collections/collection1 
configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 2065143 T10399 n:127.0.0.1:52086_tsc%2Fmg 
oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.MultiThreadedOCPTest
 AC584D1A3DA75869-001\shard-2-001\cores\collection1\'
   [junit4]   2> 2065169 T10399 n:127.0.0.1:52086_tsc%2Fmg oasc.Config.<init> 
loaded config solrconfig.xml with version 0 
   [junit4]   2> 2065184 T10399 n:127.0.0.1:52086_tsc%2Fmg 
oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
   [junit4]   2> 2065208 T10399 n:127.0.0.1:52086_tsc%2Fmg 
oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0
   [junit4]   2> 2065262 T10399 n:127.0.0.1:52086_tsc%2Fmg 
oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 2065265 T10399 n:127.0.0.1:52086_tsc%2Fmg 
oass.IndexSchema.readSchema Reading Solr Schema from /configs/conf1/schema.xml
   [junit4]   2> 2065274 T10399 n:127.0.0.1:52086_tsc%2Fmg 
oass.IndexSchema.readSchema [collection1] Schema name=test
   [junit4]   2> 2065688 T10399 n:127.0.0.1:52086_tsc%2Fmg 
oass.OpenExchangeRatesOrgProvider.init Initialized with 
rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 2065703 T10399 n:127.0.0.1:52086_tsc%2Fmg 
oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 2065706 T10399 n:127.0.0.1:52086_tsc%2Fmg 
oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 2065734 T10399 n:127.0.0.1:52086_tsc%2Fmg 
oass.FileExchangeRateProvider.reload Reloading exchange rates from file 
currency.xml
   [junit4]   2> 2065738 T10399 n:127.0.0.1:52086_tsc%2Fmg 
oass.FileExchangeRateProvider.reload Reloading exchange rates from file 
currency.xml
   [junit4]   2> 2065742 T10399 n:127.0.0.1:52086_tsc%2Fmg 
oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 2065743 T10399 n:127.0.0.1:52086_tsc%2Fmg oass.OpenE

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

junit4]   2> 2130352 T10319 oasc.ChaosMonkey.monkeyLog monkey: stop shard! 52046
   [junit4]   2> 2130354 T10319 oasc.ZkTestServer.send4LetterWord connecting to 
127.0.0.1:52039 52039
   [junit4]   2> 2132486 T10320 oasc.ZkTestServer.send4LetterWord connecting to 
127.0.0.1:52039 52039
   [junit4]   2> 2132487 T10320 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>                4       /solr/collections/ocptest3/state.json
   [junit4]   2>                4       /solr/collections/ocptest2/state.json
   [junit4]   2>                4       
/solr/collections/ocptest_shardsplit2/state.json
   [junit4]   2>                4       
/solr/collections/ocptest_shardsplit/state.json
   [junit4]   2>                4       /solr/collections/ocptest4/state.json
   [junit4]   2>                4       /solr/collections/ocptest1/state.json
   [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>                5       /solr/overseer/queue
   [junit4]   2>        
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=MultiThreadedOCPTest -Dtests.method=test 
-Dtests.seed=AC584D1A3DA75869 -Dtests.slow=true -Dtests.locale=sr_CS 
-Dtests.timezone=Antarctica/Troll -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] ERROR   74.5s J0 | MultiThreadedOCPTest.test <<<
   [junit4]    > Throwable #1: 
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=10620, 
name=parallelCoreAdminExecutor-5389-thread-21, state=RUNNABLE, 
group=TGRP-MultiThreadedOCPTest]
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([AC584D1A3DA75869:240C72C0935B3591]:0)
   [junit4]    > Caused by: java.lang.AssertionError: Too many closes on 
SolrCore
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([AC584D1A3DA75869]:0)
   [junit4]    >        at 
org.apache.solr.core.SolrCore.close(SolrCore.java:1138)
   [junit4]    >        at 
org.apache.solr.common.util.IOUtils.closeQuietly(IOUtils.java:31)
   [junit4]    >        at 
org.apache.solr.core.CoreContainer.create(CoreContainer.java:535)
   [junit4]    >        at 
org.apache.solr.core.CoreContainer.create(CoreContainer.java:494)
   [junit4]    >        at 
org.apache.solr.handler.admin.CoreAdminHandler.handleCreateAction(CoreAdminHandler.java:628)
   [junit4]    >        at 
org.apache.solr.handler.admin.CoreAdminHandler.handleRequestInternal(CoreAdminHandler.java:213)
   [junit4]    >        at 
org.apache.solr.handler.admin.CoreAdminHandler$ParallelCoreAdminHandlerThread.run(CoreAdminHandler.java:1249)
   [junit4]    >        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:148)
   [junit4]    >        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
   [junit4]    >        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 2132497 T10319 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene50): 
{range_facet_l_dv=Lucene50(blocksize=128), 
timestamp=PostingsFormat(name=Direct), 
range_facet_l=PostingsFormat(name=Direct), 
multiDefault=PostingsFormat(name=MockRandom), 
_version_=PostingsFormat(name=Direct), 
range_facet_i_dv=PostingsFormat(name=Direct), 
intDefault=PostingsFormat(name=Direct), id=Lucene50(blocksize=128)}, 
docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene50), 
timestamp=DocValuesFormat(name=Lucene50), 
range_facet_i_dv=DocValuesFormat(name=Lucene50)}, sim=DefaultSimilarity, 
locale=sr_CS, timezone=Antarctica/Troll
   [junit4]   2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.7.0_80 
(64-bit)/cpus=3,threads=1,free=314775928,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [SynonymTokenizerTest, 
SimpleFacetsTest, TestSolrConfigHandler, TestSolrDynamicMBean, 
TestGroupingSearch, TestCSVLoader, SolrPluginUtilsTest, MultiTermTest, 
TestQueryUtils, SampleTest, ConcurrentDeleteAndCreateCollectionTest, 
TestImplicitCoreProperties, SimpleCollectionCreateDeleteTest, TestLFUCache, 
TestJsonRequest, RemoteQueryErrorTest, TestPostingsSolrHighlighter, 
SolrIndexSplitterTest, ReplicationFactorTest, TestExtendedDismaxParser, 
SpatialRPTFieldTypeTest, HdfsLockFactoryTest, TestUniqueKeyFieldResource, 
TestLRUCache, DistribDocExpirationUpdateProcessorTest, TestArbitraryIndexDir, 
TestRawResponseWriter, JSONWriterTest, CollectionReloadTest, TestSort, 
CoreMergeIndexesAdminHandlerTest, TestBinaryResponseWriter, 
LukeRequestHandlerTest, AddBlockUpdateTest, RequestHandlersTest, TestLazyCores, 
SolrCoreTest, BadComponentTest, BlockCacheTest, 
OverriddenZkACLAndCredentialsProvidersTest, OverseerRolesTest, 
TestIBSimilarityFactory, ClusterStateUpdateTest, SoftAutoCommitTest, 
TestCursorMarkWithoutUniqueKey, TestUpdate, AnalysisErrorHandlingTest, 
TestChildDocTransformer, TestCustomSort, TestNamedUpdateProcessors, 
TestDefaultStatsCache, TestReplicationHandler, SolrInfoMBeanTest, 
HttpPartitionTest, TestStressVersions, TestFieldTypeCollectionResource, 
TestCSVResponseWriter, TestIndexSearcher, LeaderFailoverAfterPartitionTest, 
TestWordDelimiterFilterFactory, OutputWriterTest, RuleEngineTest, 
TestCryptoKeys, ShardRoutingTest, CachingDirectoryFactoryTest, 
TestRandomDVFaceting, URLClassifyProcessorTest, SOLR749Test, NumericFieldsTest, 
IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestFastLRUCache, 
TestXIncludeConfig, AlternateDirectoryTest, TestHashPartitioner, 
IndexSchemaRuntimeFieldTest, TestFieldSortValues, TestAnalyzedSuggestions, 
ChaosMonkeyNothingIsSafeTest, HdfsBasicDistributedZk2Test, 
PathHierarchyTokenizerFactoryTest, TestStressRecovery, 
TriLevelCompositeIdRoutingTest, FieldAnalysisRequestHandlerTest, 
DistribCursorPagingTest, TestManagedSynonymFilterFactory, CacheHeaderTest, 
TestSchemaResource, DistributedDebugComponentTest, TestFieldTypeResource, 
TestCharFilters, DocValuesTest, TestSchemaVersionResource, 
TestComplexPhraseQParserPlugin, SuggesterWFSTTest, RecoveryZkTest, 
CloudExitableDirectoryReaderTest, TestSweetSpotSimilarityFactory, 
TestDocBasedVersionConstraints, AnalyticsQueryTest, 
DefaultValueUpdateProcessorTest, TestManagedResourceStorage, DOMUtilTest, 
DistanceFunctionTest, PingRequestHandlerTest, CursorPagingTest, 
TestDefaultSearchFieldResource, TestFaceting, ShowFileRequestHandlerTest, 
SuggesterTest, TestDistributedStatsComponentCardinality, 
UniqFieldsUpdateProcessorFactoryTest, SliceStateTest, FacetPivotSmallTest, 
TestStressLucene, ResponseHeaderTest, DistributedIntervalFacetingTest, 
RankQueryTest, LeaderInitiatedRecoveryOnCommitTest, OpenCloseCoreStressTest, 
OverseerTest, FullSolrCloudDistribCmdsTest, ZkCLITest, TestRecovery, 
DistributedSpellCheckComponentTest, TermVectorComponentDistributedTest, 
ZkControllerTest, TestRealTimeGet, TestStressReorder, TestJoin, 
HardAutoCommitTest, DistributedTermsComponentTest, TestCoreContainer, 
TestSolr4Spatial, SpellCheckComponentTest, SolrCmdDistributorTest, 
QueryElevationComponentTest, PeerSyncTest, TestFunctionQuery, 
BasicFunctionalityTest, DirectUpdateHandlerTest, HighlighterTest, 
DistributedQueryElevationComponentTest, AnalysisAfterCoreReloadTest, 
SpellCheckCollatorTest, SuggesterFSTTest, CoreAdminHandlerTest, 
SuggesterTSTTest, SpatialFilterTest, PolyFieldTest, NoCacheHeaderTest, 
WordBreakSolrSpellCheckerTest, TestPseudoReturnFields, 
FieldMutatingUpdateProcessorTest, QueryEqualityTest, 
StatelessScriptUpdateProcessorFactoryTest, DocValuesMultiTest, 
TestSurroundQueryParser, DirectSolrSpellCheckerTest, 
DocumentAnalysisRequestHandlerTest, TestOmitPositions, TermsComponentTest, 
TermVectorComponentTest, RequiredFieldsTest, LoggingHandlerTest, 
TestJmxIntegration, QueryParsingTest, CSVRequestHandlerTest, SearchHandlerTest, 
UpdateParamsTest, TestQuerySenderNoQuery, SolrIndexConfigTest, TestSearchPerf, 
DirectSolrConnectionTest, TestPhraseSuggestions, 
TestLMDirichletSimilarityFactory, TestJmxMonitoredMap, TimeZoneUtilsTest, 
TestFastOutputStream, OpenExchangeRatesOrgProviderTest, PreAnalyzedFieldTest, 
DateFieldTest, TestHighlightDedupGrouping, TestEmbeddedSolrServerConstructors, 
TestJettySolrRunner, ActionThrottleTest, AssignTest, AsyncMigrateRouteKeyTest, 
ConnectionManagerTest, DeleteLastCustomShardedReplicaTest, DeleteReplicaTest, 
DistributedQueueTest, ExternalCollectionsTest, MultiThreadedOCPTest]
   [junit4] Completed [380/488] on J0 in 75.23s, 1 test, 1 error <<< FAILURES!

[...truncated 352 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:536: The 
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:484: The 
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:61: The 
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\extra-targets.xml:39: 
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build.xml:229: The 
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\common-build.xml:511:
 The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:1433:
 The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:991:
 There were test failures: 488 suites, 1958 tests, 1 error, 66 ignored (34 
assumptions)

Total time: 69 minutes 51 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any


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

Reply via email to