Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-MacOSX/2053/
Java: 64bit/jdk1.7.0 -XX:-UseCompressedOops -XX:+UseSerialGC

1 tests failed.
FAILED:  org.apache.solr.handler.TestSolrConfigHandlerCloud.test

Error Message:
Could not get expected value  'org.apache.solr.spelling.SpellingQueryConverter' 
for path 'config/queryConverter/qc/class' full output: {   "responseHeader":{   
  "status":0,     "QTime":0},   "config":{     "znodeVersion":0,     
"luceneMatchVersion":"org.apache.lucene.util.Version:5.1.0",     
"updateHandler":{       "class":"solr.DirectUpdateHandler2",       
"autoCommmitMaxDocs":-1,       "indexWriterCloseWaitsForMerges":true,       
"openSearcher":true,       "commitIntervalLowerBound":-1,       
"commitWithinSoftCommit":true,       "autoCommit":{         "maxDocs":-1,       
  "maxTime":-1,         "commitIntervalLowerBound":-1},       
"autoSoftCommit":{         "maxDocs":-1,         "maxTime":-1}},     "query":{  
     "useFilterForSortedQuery":false,       "queryResultWindowSize":1,       
"queryResultMaxDocsCached":2147483647,       "enableLazyFieldLoading":false,    
   "maxBooleanClauses":1024,       "":{         "size":"10000",         
"initialSize":"10",         "showItems":"-1",         
"name":"fieldValueCache"}},     "requestHandler":{       "standard":{         
"class":"solr.StandardRequestHandler",         "name":"standard"},       
"/admin/file":{         "class":"solr.admin.ShowFileRequestHandler",         
"name":"/admin/file",         "invariants":{"hidden":"bogus.txt"}},       
"/update":{         "name":"/update",         
"class":"org.apache.solr.handler.UpdateRequestHandler",         "defaults":{}}, 
      "/update/json":{         "name":"/update/json",         
"class":"org.apache.solr.handler.UpdateRequestHandler",         
"defaults":{"update.contentType":"application/json"}},       "/update/csv":{    
     "name":"/update/csv",         
"class":"org.apache.solr.handler.UpdateRequestHandler",         
"defaults":{"update.contentType":"application/csv"}},       
"/update/json/docs":{         "name":"/update/json/docs",         
"class":"org.apache.solr.handler.UpdateRequestHandler",         "defaults":{    
       "update.contentType":"application/json",           
"json.command":"false"}},       "/config":{         "name":"/config",         
"class":"org.apache.solr.handler.SolrConfigHandler",         "defaults":{}},    
   "/schema":{         "name":"/schema",         
"class":"org.apache.solr.handler.SchemaHandler",         "defaults":{}},       
"/replication":{         "name":"/replication",         
"class":"org.apache.solr.handler.ReplicationHandler",         "defaults":{}},   
    "/get":{         "name":"/get",         
"class":"org.apache.solr.handler.RealTimeGetHandler",         "defaults":{      
     "omitHeader":"true",           "wt":"json",           "indent":"true"}},   
    "/admin/luke":{         "name":"/admin/luke",         
"class":"org.apache.solr.handler.admin.LukeRequestHandler",         
"defaults":{}},       "/admin/system":{         "name":"/admin/system",         
"class":"org.apache.solr.handler.admin.SystemInfoHandler",         
"defaults":{}},       "/admin/mbeans":{         "name":"/admin/mbeans",         
"class":"org.apache.solr.handler.admin.SolrInfoMBeanHandler",         
"defaults":{}},       "/admin/plugins":{         "name":"/admin/plugins",       
  "class":"org.apache.solr.handler.admin.PluginInfoHandler",         
"defaults":{}},       "/admin/threads":{         "name":"/admin/threads",       
  "class":"org.apache.solr.handler.admin.ThreadDumpHandler",         
"defaults":{}},       "/admin/properties":{         "name":"/admin/properties", 
        "class":"org.apache.solr.handler.admin.PropertiesRequestHandler",       
  "defaults":{}},       "/admin/logging":{         "name":"/admin/logging",     
    "class":"org.apache.solr.handler.admin.LoggingHandler",         
"defaults":{}},       "/admin/ping":{         "name":"/admin/ping",         
"class":"org.apache.solr.handler.PingRequestHandler",         "defaults":{},    
     "invariants":{           "echoParams":"all",           
"q":"solrpingquery"}},       "/admin/segments":{         
"name":"/admin/segments",         
"class":"org.apache.solr.handler.admin.SegmentsInfoRequestHandler",         
"defaults":{}}},     "directoryFactory":{       
"class":"org.apache.solr.core.MockDirectoryFactory",       
"name":"DirectoryFactory",       "solr.hdfs.blockcache.enabled":true,       
"solr.hdfs.blockcache.blocksperbank":1024,       "solr.hdfs.home":"",       
"solr.hdfs.confdir":"",       "solr.hdfs.blockcache.global":"false"},     
"updateRequestProcessorChain":[       {         "name":"nodistrib",         
"":[           {"class":"solr.NoOpDistributingUpdateProcessorFactory"},         
  {"class":"solr.RunUpdateProcessorFactory"}]},       {         
"name":"dedupe",         "":[           {             
"class":"org.apache.solr.update.processor.SignatureUpdateProcessorFactory",     
        "enabled":true,             "overwriteDupes":true,             
"fields":"v_t,t_field",             
"signatureClass":"org.apache.solr.update.processor.TextProfileSignature"},      
     {"class":"solr.RunUpdateProcessorFactory"}]},       {         
"name":"stored_sig",         "":[           {             
"class":"org.apache.solr.update.processor.SignatureUpdateProcessorFactory",     
        "enabled":true,             
"signatureField":"non_indexed_signature_sS",             
"overwriteDupes":false,             "fields":"v_t,t_field",             
"signatureClass":"org.apache.solr.update.processor.TextProfileSignature"},      
     {"class":"solr.RunUpdateProcessorFactory"}]},       {         
"name":"distrib-dup-test-chain-explicit",         "":[           
{"class":"solr.RegexReplaceProcessorFactory"},           
{"class":"solr.DistributedUpdateProcessorFactory"},           
{"class":"solr.RegexReplaceProcessorFactory"},           
{"class":"solr.RunUpdateProcessorFactory"}]},       {         
"name":"distrib-dup-test-chain-implicit",         "":[           
{"class":"solr.RegexReplaceProcessorFactory"},           
{"class":"solr.RegexReplaceProcessorFactory"},           
{"class":"solr.RunUpdateProcessorFactory"}]}],     
"updateHandlerupdateLog":{"dir":""},     "jmx":{       "agentId":null,       
"serviceUrl":null,       "rootName":null},     "requestDispatcher":{       
"handleSelect":true,       "httpCaching":{         "never304":false,         
"etagSeed":"Solr",         "lastModFrom":"opentime",         
"cacheControl":null},       "requestParsers":{         
"multipartUploadLimitKB":2048,         "formUploadLimitKB":2048,         
"addHttpRequestToContext":false}},     "indexConfig":{       
"maxBufferedDocs":192,       "maxMergeDocs":-1,       "maxIndexingThreads":2,   
    "mergeFactor":-1,       "ramBufferSizeMB":16.0,       
"writeLockTimeout":1000,       "lockType":"single",       
"mergeScheduler":{"class":"org.apache.solr.util.RandomMergePolicy"}}}}

Stack Trace:
java.lang.AssertionError: Could not get expected value  
'org.apache.solr.spelling.SpellingQueryConverter' for path 
'config/queryConverter/qc/class' full output: {
  "responseHeader":{
    "status":0,
    "QTime":0},
  "config":{
    "znodeVersion":0,
    "luceneMatchVersion":"org.apache.lucene.util.Version:5.1.0",
    "updateHandler":{
      "class":"solr.DirectUpdateHandler2",
      "autoCommmitMaxDocs":-1,
      "indexWriterCloseWaitsForMerges":true,
      "openSearcher":true,
      "commitIntervalLowerBound":-1,
      "commitWithinSoftCommit":true,
      "autoCommit":{
        "maxDocs":-1,
        "maxTime":-1,
        "commitIntervalLowerBound":-1},
      "autoSoftCommit":{
        "maxDocs":-1,
        "maxTime":-1}},
    "query":{
      "useFilterForSortedQuery":false,
      "queryResultWindowSize":1,
      "queryResultMaxDocsCached":2147483647,
      "enableLazyFieldLoading":false,
      "maxBooleanClauses":1024,
      "":{
        "size":"10000",
        "initialSize":"10",
        "showItems":"-1",
        "name":"fieldValueCache"}},
    "requestHandler":{
      "standard":{
        "class":"solr.StandardRequestHandler",
        "name":"standard"},
      "/admin/file":{
        "class":"solr.admin.ShowFileRequestHandler",
        "name":"/admin/file",
        "invariants":{"hidden":"bogus.txt"}},
      "/update":{
        "name":"/update",
        "class":"org.apache.solr.handler.UpdateRequestHandler",
        "defaults":{}},
      "/update/json":{
        "name":"/update/json",
        "class":"org.apache.solr.handler.UpdateRequestHandler",
        "defaults":{"update.contentType":"application/json"}},
      "/update/csv":{
        "name":"/update/csv",
        "class":"org.apache.solr.handler.UpdateRequestHandler",
        "defaults":{"update.contentType":"application/csv"}},
      "/update/json/docs":{
        "name":"/update/json/docs",
        "class":"org.apache.solr.handler.UpdateRequestHandler",
        "defaults":{
          "update.contentType":"application/json",
          "json.command":"false"}},
      "/config":{
        "name":"/config",
        "class":"org.apache.solr.handler.SolrConfigHandler",
        "defaults":{}},
      "/schema":{
        "name":"/schema",
        "class":"org.apache.solr.handler.SchemaHandler",
        "defaults":{}},
      "/replication":{
        "name":"/replication",
        "class":"org.apache.solr.handler.ReplicationHandler",
        "defaults":{}},
      "/get":{
        "name":"/get",
        "class":"org.apache.solr.handler.RealTimeGetHandler",
        "defaults":{
          "omitHeader":"true",
          "wt":"json",
          "indent":"true"}},
      "/admin/luke":{
        "name":"/admin/luke",
        "class":"org.apache.solr.handler.admin.LukeRequestHandler",
        "defaults":{}},
      "/admin/system":{
        "name":"/admin/system",
        "class":"org.apache.solr.handler.admin.SystemInfoHandler",
        "defaults":{}},
      "/admin/mbeans":{
        "name":"/admin/mbeans",
        "class":"org.apache.solr.handler.admin.SolrInfoMBeanHandler",
        "defaults":{}},
      "/admin/plugins":{
        "name":"/admin/plugins",
        "class":"org.apache.solr.handler.admin.PluginInfoHandler",
        "defaults":{}},
      "/admin/threads":{
        "name":"/admin/threads",
        "class":"org.apache.solr.handler.admin.ThreadDumpHandler",
        "defaults":{}},
      "/admin/properties":{
        "name":"/admin/properties",
        "class":"org.apache.solr.handler.admin.PropertiesRequestHandler",
        "defaults":{}},
      "/admin/logging":{
        "name":"/admin/logging",
        "class":"org.apache.solr.handler.admin.LoggingHandler",
        "defaults":{}},
      "/admin/ping":{
        "name":"/admin/ping",
        "class":"org.apache.solr.handler.PingRequestHandler",
        "defaults":{},
        "invariants":{
          "echoParams":"all",
          "q":"solrpingquery"}},
      "/admin/segments":{
        "name":"/admin/segments",
        "class":"org.apache.solr.handler.admin.SegmentsInfoRequestHandler",
        "defaults":{}}},
    "directoryFactory":{
      "class":"org.apache.solr.core.MockDirectoryFactory",
      "name":"DirectoryFactory",
      "solr.hdfs.blockcache.enabled":true,
      "solr.hdfs.blockcache.blocksperbank":1024,
      "solr.hdfs.home":"",
      "solr.hdfs.confdir":"",
      "solr.hdfs.blockcache.global":"false"},
    "updateRequestProcessorChain":[
      {
        "name":"nodistrib",
        "":[
          {"class":"solr.NoOpDistributingUpdateProcessorFactory"},
          {"class":"solr.RunUpdateProcessorFactory"}]},
      {
        "name":"dedupe",
        "":[
          {
            
"class":"org.apache.solr.update.processor.SignatureUpdateProcessorFactory",
            "enabled":true,
            "overwriteDupes":true,
            "fields":"v_t,t_field",
            
"signatureClass":"org.apache.solr.update.processor.TextProfileSignature"},
          {"class":"solr.RunUpdateProcessorFactory"}]},
      {
        "name":"stored_sig",
        "":[
          {
            
"class":"org.apache.solr.update.processor.SignatureUpdateProcessorFactory",
            "enabled":true,
            "signatureField":"non_indexed_signature_sS",
            "overwriteDupes":false,
            "fields":"v_t,t_field",
            
"signatureClass":"org.apache.solr.update.processor.TextProfileSignature"},
          {"class":"solr.RunUpdateProcessorFactory"}]},
      {
        "name":"distrib-dup-test-chain-explicit",
        "":[
          {"class":"solr.RegexReplaceProcessorFactory"},
          {"class":"solr.DistributedUpdateProcessorFactory"},
          {"class":"solr.RegexReplaceProcessorFactory"},
          {"class":"solr.RunUpdateProcessorFactory"}]},
      {
        "name":"distrib-dup-test-chain-implicit",
        "":[
          {"class":"solr.RegexReplaceProcessorFactory"},
          {"class":"solr.RegexReplaceProcessorFactory"},
          {"class":"solr.RunUpdateProcessorFactory"}]}],
    "updateHandlerupdateLog":{"dir":""},
    "jmx":{
      "agentId":null,
      "serviceUrl":null,
      "rootName":null},
    "requestDispatcher":{
      "handleSelect":true,
      "httpCaching":{
        "never304":false,
        "etagSeed":"Solr",
        "lastModFrom":"opentime",
        "cacheControl":null},
      "requestParsers":{
        "multipartUploadLimitKB":2048,
        "formUploadLimitKB":2048,
        "addHttpRequestToContext":false}},
    "indexConfig":{
      "maxBufferedDocs":192,
      "maxMergeDocs":-1,
      "maxIndexingThreads":2,
      "mergeFactor":-1,
      "ramBufferSizeMB":16.0,
      "writeLockTimeout":1000,
      "lockType":"single",
      "mergeScheduler":{"class":"org.apache.solr.util.RandomMergePolicy"}}}}
        at 
__randomizedtesting.SeedInfo.seed([8DFDE37F2589727C:5A9DCA58B751F84]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at 
org.apache.solr.core.TestSolrConfigHandler.testForResponseElement(TestSolrConfigHandler.java:399)
        at 
org.apache.solr.core.TestSolrConfigHandler.reqhandlertests(TestSolrConfigHandler.java:228)
        at 
org.apache.solr.handler.TestSolrConfigHandlerCloud.testReqHandlerAPIs(TestSolrConfigHandlerCloud.java:91)
        at 
org.apache.solr.handler.TestSolrConfigHandlerCloud.test(TestSolrConfigHandlerCloud.java:77)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:606)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:958)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:933)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
        at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 10667 lines...]
   [junit4] Suite: org.apache.solr.handler.TestSolrConfigHandlerCloud
   [junit4]   2> Creating dataDir: 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/init-core-data-001
   [junit4]   2> 2613359 T10484 oas.SolrTestCaseJ4.buildSSLConfig Randomized 
ssl (false) and clientAuth (false)
   [junit4]   2> 2613359 T10484 
oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system 
property: /
   [junit4]   2> 2613367 T10484 oasc.ZkTestServer.run STARTING ZK TEST SERVER
   [junit4]   1> client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2613369 T10485 oasc.ZkTestServer$ZKServerMain.runFromConfig 
Starting server
   [junit4]   2> 2613470 T10484 oasc.ZkTestServer.run start zk server on 
port:64548
   [junit4]   2> 2613470 T10484 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 2613472 T10484 oascc.ConnectionManager.waitForConnected 
Waiting for client to connect to ZooKeeper
   [junit4]   2> 2613479 T10492 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@4ae06aae 
name:ZooKeeperConnection Watcher:127.0.0.1:64548 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2613479 T10484 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 2613479 T10484 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 2613479 T10484 oascc.SolrZkClient.makePath makePath: /solr
   [junit4]   2> 2613487 T10484 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 2613489 T10484 oascc.ConnectionManager.waitForConnected 
Waiting for client to connect to ZooKeeper
   [junit4]   2> 2613494 T10495 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@3c2159e1 
name:ZooKeeperConnection Watcher:127.0.0.1:64548/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2613495 T10484 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 2613495 T10484 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 2613495 T10484 oascc.SolrZkClient.makePath makePath: 
/collections/collection1
   [junit4]   2> 2613502 T10484 oascc.SolrZkClient.makePath makePath: 
/collections/collection1/shards
   [junit4]   2> 2613509 T10484 oascc.SolrZkClient.makePath makePath: 
/collections/control_collection
   [junit4]   2> 2613515 T10484 oascc.SolrZkClient.makePath makePath: 
/collections/control_collection/shards
   [junit4]   2> 2613520 T10484 oasc.AbstractZkTestCase.putConfig put 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
 to /configs/conf1/solrconfig.xml
   [junit4]   2> 2613521 T10484 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/solrconfig.xml
   [junit4]   2> 2613528 T10484 oasc.AbstractZkTestCase.putConfig put 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/schema.xml
 to /configs/conf1/schema.xml
   [junit4]   2> 2613529 T10484 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/schema.xml
   [junit4]   2> 2613534 T10484 oasc.AbstractZkTestCase.putConfig put 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 2613535 T10484 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 2613540 T10484 oasc.AbstractZkTestCase.putConfig put 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf1/stopwords.txt
   [junit4]   2> 2613541 T10484 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/stopwords.txt
   [junit4]   2> 2613546 T10484 oasc.AbstractZkTestCase.putConfig put 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf1/protwords.txt
   [junit4]   2> 2613546 T10484 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/protwords.txt
   [junit4]   2> 2613550 T10484 oasc.AbstractZkTestCase.putConfig put 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf1/currency.xml
   [junit4]   2> 2613551 T10484 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/currency.xml
   [junit4]   2> 2613556 T10484 oasc.AbstractZkTestCase.putConfig put 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf1/enumsConfig.xml
   [junit4]   2> 2613557 T10484 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/enumsConfig.xml
   [junit4]   2> 2613562 T10484 oasc.AbstractZkTestCase.putConfig put 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 2613562 T10484 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/open-exchange-rates.json
   [junit4]   2> 2613566 T10484 oasc.AbstractZkTestCase.putConfig put 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 2613567 T10484 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 2613571 T10484 oasc.AbstractZkTestCase.putConfig put 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf1/old_synonyms.txt
   [junit4]   2> 2613572 T10484 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/old_synonyms.txt
   [junit4]   2> 2613578 T10484 oasc.AbstractZkTestCase.putConfig put 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf1/synonyms.txt
   [junit4]   2> 2613579 T10484 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/synonyms.txt
   [junit4]   2> 2613945 T10484 oas.SolrTestCaseJ4.writeCoreProperties Writing 
core.properties file to 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/control-001/cores/collection1
   [junit4]   2> 2613948 T10484 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 2613954 T10484 oejs.AbstractConnector.doStart Started 
[email protected]:64551
   [junit4]   2> 2613954 T10484 oascse.JettySolrRunner$1.lifeCycleStarted Jetty 
properties: {hostPort=64551, 
solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/tempDir-001/control/data, hostContext=/, 
coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/control-001/cores}
   [junit4]   2> 2613954 T10484 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@5472fe25
   [junit4]   2> 2613955 T10484 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/control-001/'
   [junit4]   2> 2613990 T10484 oasc.SolrXmlConfig.fromFile Loading container 
configuration from 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/control-001/solr.xml
   [junit4]   2> 2614024 T10484 oasc.CorePropertiesLocator.<init> 
Config-defined core root directory: 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/control-001/cores
   [junit4]   2> 2614024 T10484 oasc.CoreContainer.<init> New CoreContainer 
1969606060
   [junit4]   2> 2614024 T10484 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/control-001/]
   [junit4]   2> 2614025 T10484 oasc.CoreContainer.load loading shared library: 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/control-001/lib
   [junit4]   2> 2614025 T10484 oasc.SolrResourceLoader.addToClassLoader WARN 
Can't find (or read) directory to add to classloader: lib (resolved as: 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/control-001/lib).
   [junit4]   2> 2614048 T10484 oashc.HttpShardHandlerFactory.getParameter 
Setting socketTimeout to: 90000
   [junit4]   2> 2614049 T10484 oashc.HttpShardHandlerFactory.getParameter 
Setting urlScheme to: 
   [junit4]   2> 2614049 T10484 oashc.HttpShardHandlerFactory.getParameter 
Setting connTimeout to: 15000
   [junit4]   2> 2614049 T10484 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnectionsPerHost to: 20
   [junit4]   2> 2614049 T10484 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnections to: 10000
   [junit4]   2> 2614049 T10484 oashc.HttpShardHandlerFactory.getParameter 
Setting corePoolSize to: 0
   [junit4]   2> 2614050 T10484 oashc.HttpShardHandlerFactory.getParameter 
Setting maximumPoolSize to: 2147483647
   [junit4]   2> 2614050 T10484 oashc.HttpShardHandlerFactory.getParameter 
Setting maxThreadIdleTime to: 5
   [junit4]   2> 2614050 T10484 oashc.HttpShardHandlerFactory.getParameter 
Setting sizeOfQueue to: -1
   [junit4]   2> 2614050 T10484 oashc.HttpShardHandlerFactory.getParameter 
Setting fairnessPolicy to: false
   [junit4]   2> 2614050 T10484 oashc.HttpShardHandlerFactory.getParameter 
Setting useRetries to: false
   [junit4]   2> 2614050 T10484 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 2614051 T10484 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 2614051 T10484 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 2614051 T10484 oasc.CoreContainer.load Node Name: 127.0.0.1
   [junit4]   2> 2614051 T10484 oasc.ZkContainer.initZooKeeper Zookeeper 
client=127.0.0.1:64548/solr
   [junit4]   2> 2614052 T10484 oasc.ZkController.checkChrootPath zkHost 
includes chroot
   [junit4]   2> 2614052 T10484 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 2614053 T10484 oascc.ConnectionManager.waitForConnected 
Waiting for client to connect to ZooKeeper
   [junit4]   2> 2614056 T10507 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@441cc6e7 
name:ZooKeeperConnection Watcher:127.0.0.1:64548 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2614057 T10484 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 2614057 T10484 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 2614061 T10484 oascc.ConnectionManager.waitForConnected 
Waiting for client to connect to ZooKeeper
   [junit4]   2> 2614064 T10510 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@663d5fd2 
name:ZooKeeperConnection Watcher:127.0.0.1:64548/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2614065 T10484 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 2614068 T10484 oascc.SolrZkClient.makePath makePath: 
/overseer/queue
   [junit4]   2> 2614074 T10484 oascc.SolrZkClient.makePath makePath: 
/overseer/collection-queue-work
   [junit4]   2> 2614080 T10484 oascc.SolrZkClient.makePath makePath: 
/overseer/collection-map-running
   [junit4]   2> 2614087 T10484 oascc.SolrZkClient.makePath makePath: 
/overseer/collection-map-completed
   [junit4]   2> 2614094 T10484 oascc.SolrZkClient.makePath makePath: 
/overseer/collection-map-failure
   [junit4]   2> 2614100 T10484 oascc.SolrZkClient.makePath makePath: 
/live_nodes
   [junit4]   2> 2614107 T10484 oascc.SolrZkClient.makePath makePath: 
/aliases.json
   [junit4]   2> 2614111 T10484 oascc.SolrZkClient.makePath makePath: 
/clusterstate.json
   [junit4]   2> 2614115 T10484 oasc.ZkController.createEphemeralLiveNode 
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:64551_
   [junit4]   2> 2614117 T10484 oascc.SolrZkClient.makePath makePath: 
/live_nodes/127.0.0.1:64551_
   [junit4]   2> 2614122 T10484 oascc.SolrZkClient.makePath makePath: 
/overseer_elect
   [junit4]   2> 2614126 T10484 oascc.SolrZkClient.makePath makePath: 
/overseer_elect/election
   [junit4]   2> 2614131 T10484 oasc.Overseer.close Overseer (id=null) closing
   [junit4]   2> 2614134 T10484 oasc.OverseerElectionContext.runLeaderProcess I 
am going to be the leader 127.0.0.1:64551_
   [junit4]   2> 2614135 T10484 oascc.SolrZkClient.makePath makePath: 
/overseer_elect/leader
   [junit4]   2> 2614139 T10484 oasc.Overseer.start Overseer 
(id=93545514108780547-127.0.0.1:64551_-n_0000000000) starting
   [junit4]   2> 2614144 T10484 oascc.SolrZkClient.makePath makePath: 
/overseer/queue-work
   [junit4]   2> 2614165 T10484 oasc.OverseerAutoReplicaFailoverThread.<init> 
Starting OverseerAutoReplicaFailoverThread 
autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=30000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 2614166 T10484 
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state 
from ZooKeeper... 
   [junit4]   2> 2614166 T10512 oasc.OverseerCollectionProcessor.run Process 
current queue of collection creations
   [junit4]   2> 2614167 T10511 oasc.Overseer$ClusterStateUpdater.run Starting 
to work on the main queue
   [junit4]   2> 2614184 T10484 oasc.CorePropertiesLocator.discover Looking for 
core definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/control-001/cores
   [junit4]   2> 2614186 T10484 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: 
{absoluteInstDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/control-001/cores/collection1/, transient=false, 
coreNodeName=, name=collection1, loadOnStartup=true, shard=, dataDir=data/, 
schema=schema.xml, config=solrconfig.xml, collection=control_collection, 
instanceDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/control-001/cores/collection1}
   [junit4]   2> 2614187 T10484 oasc.CorePropertiesLocator.discoverUnder Found 
core collection1 in 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/control-001/cores/collection1/
   [junit4]   2> 2614187 T10484 oasc.CorePropertiesLocator.discover Found 1 
core definitions
   [junit4]   2> 2614189 T10514 C:control_collection c:collection1 
oasc.ZkController.publish publishing core=collection1 state=down 
collection=control_collection
   [junit4]   2> 2614189 T10514 C:control_collection c:collection1 
oasc.ZkController.publish numShards not found on descriptor - reading it from 
system property
   [junit4]   2> 2614191 T10510 oasc.DistributedQueue$LatchWatcher.process 
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
   [junit4]   2> 2614191 T10514 C:control_collection c:collection1 
oasc.ZkController.waitForCoreNodeName look for our core node name
   [junit4]   2> 2614193 T10511 oasc.Overseer$ClusterStateUpdater.run 
processMessage: queueSize: 1, message = {
   [junit4]   2>          "base_url":"http://127.0.0.1:64551";,
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "collection":"control_collection",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "state":"down",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "numShards":"1",
   [junit4]   2>          "node_name":"127.0.0.1:64551_",
   [junit4]   2>          "shard":null} current state version: 0
   [junit4]   2> 2614194 T10511 oasco.ReplicaMutator.updateState Update state 
numShards=1 message={
   [junit4]   2>          "base_url":"http://127.0.0.1:64551";,
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "collection":"control_collection",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "state":"down",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "numShards":"1",
   [junit4]   2>          "node_name":"127.0.0.1:64551_",
   [junit4]   2>          "shard":null}
   [junit4]   2> 2614195 T10511 oasco.ClusterStateMutator.createCollection 
building a new cName: control_collection
   [junit4]   2> 2614195 T10511 oasco.ReplicaMutator.updateState Assigning new 
node to shard shard=shard1
   [junit4]   2> 2614198 T10510 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> 2615194 T10514 C:control_collection c:collection1 
oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for 
collection1
   [junit4]   2> 2615194 T10514 C:control_collection c:collection1 
oasc.ZkController.createCollectionZkNode Check for collection 
zkNode:control_collection
   [junit4]   2> 2615195 T10514 C:control_collection c:collection1 
oasc.ZkController.createCollectionZkNode Collection zkNode exists
   [junit4]   2> 2615195 T10514 C:control_collection c:collection1 
oascc.ZkStateReader.readConfigName Load collection config 
from:/collections/control_collection
   [junit4]   2> 2615198 T10514 C:control_collection c:collection1 
oascc.ZkStateReader.readConfigName path=/collections/control_collection 
configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 2615198 T10514 C:control_collection c:collection1 
oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/control-001/cores/collection1/'
   [junit4]   2> 2615219 T10514 C:control_collection c:collection1 
oasc.ZkController.watchZKConfDir watch zkdir /configs/conf1
   [junit4]   2> 2615223 T10514 C:control_collection c:collection1 
oasc.Config.<init> loaded config solrconfig.xml with version 0 
   [junit4]   2> 2615234 T10514 C:control_collection c:collection1 
oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
   [junit4]   2> 2615255 T10514 C:control_collection c:collection1 
oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.1.0
   [junit4]   2> 2615299 T10514 C:control_collection c:collection1 
oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 2615301 T10514 C:control_collection c:collection1 
oass.IndexSchema.readSchema Reading Solr Schema from /configs/conf1/schema.xml
   [junit4]   2> 2615309 T10514 C:control_collection c:collection1 
oass.IndexSchema.readSchema [collection1] Schema name=test
   [junit4]   2> 2615622 T10514 C:control_collection c:collection1 
oass.OpenExchangeRatesOrgProvider.init Initialized with 
rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 2615633 T10514 C:control_collection c:collection1 
oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 2615635 T10514 C:control_collection c:collection1 
oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 2615659 T10514 C:control_collection c:collection1 
oass.FileExchangeRateProvider.reload Reloading exchange rates from file 
currency.xml
   [junit4]   2> 2615664 T10514 C:control_collection c:collection1 
oass.FileExchangeRateProvider.reload Reloading exchange rates from file 
currency.xml
   [junit4]   2> 2615670 T10514 C:control_collection c:collection1 
oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 2615672 T10514 C:control_collection c:collection1 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 2615672 T10514 C:control_collection c:collection1 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 2615673 T10514 C:control_collection c:collection1 
oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 2615675 T10514 C:control_collection c:collection1 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 2615675 T10514 C:control_collection c:collection1 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 2615675 T10514 C:control_collection c:collection1 
oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration 
from collection control_collection
   [junit4]   2> 2615676 T10514 C:control_collection c:collection1 
oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 2615676 T10514 C:control_collection c:collection1 
oasc.SolrCore.<init> [collection1] Opening new SolrCore at 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/control-001/cores/collection1/, 
dataDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/control-001/cores/collection1/data/
   [junit4]   2> 2615676 T10514 C:control_collection c:collection1 
oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to 
JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@34bba4df
   [junit4]   2> 2615677 T10514 C:control_collection c:collection1 
oasc.CachingDirectoryFactory.get return new directory for 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/control-001/cores/collection1/data
   [junit4]   2> 2615677 T10514 C:control_collection c:collection1 
oasc.SolrCore.getNewIndexDir New index directory detected: old=null 
new=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/control-001/cores/collection1/data/index/
   [junit4]   2> 2615677 T10514 C:control_collection c:collection1 
oasc.SolrCore.initIndex WARN [collection1] Solr index directory 
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/control-001/cores/collection1/data/index' doesn't exist. 
Creating new index...
   [junit4]   2> 2615677 T10514 C:control_collection c:collection1 
oasc.CachingDirectoryFactory.get return new directory for 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/control-001/cores/collection1/data/index
   [junit4]   2> 2615678 T10514 C:control_collection c:collection1 
oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=10, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.10401229674745834]
   [junit4]   2> 2615679 T10514 C:control_collection c:collection1 
oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@43fc8d98 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@79b41906),segFN=segments_1,generation=1}
   [junit4]   2> 2615679 T10514 C:control_collection c:collection1 
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 2615686 T10514 C:control_collection c:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"nodistrib"
   [junit4]   2> 2615686 T10514 C:control_collection c:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"dedupe"
   [junit4]   2> 2615686 T10514 C:control_collection c:collection1 
oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 2615687 T10514 C:control_collection c:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"stored_sig"
   [junit4]   2> 2615687 T10514 C:control_collection c:collection1 
oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 2615688 T10514 C:control_collection c:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"distrib-dup-test-chain-explicit"
   [junit4]   2> 2615688 T10514 C:control_collection c:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 2615688 T10514 C:control_collection c:collection1 
oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 2615688 T10514 C:control_collection c:collection1 
oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined 
as default, creating implicit default
   [junit4]   2> 2615702 T10514 C:control_collection c:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 2615705 T10514 C:control_collection c:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 2615707 T10514 C:control_collection c:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 2615709 T10514 C:control_collection c:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 2615715 T10514 C:control_collection c:collection1 
oasc.RequestHandlers.initHandlersFromConfig Registered paths: 
/schema,/admin/luke,/admin/plugins,/admin/system,/admin/logging,/replication,/config,/admin/properties,/admin/mbeans,/update/json/docs,/admin/threads,/update,standard,/update/json,/admin/ping,/admin/file,/update/csv,/get,/admin/segments
   [junit4]   2> 2615716 T10514 C:control_collection c:collection1 
oasc.SolrCore.initStatsCache Using default statsCache cache: 
org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 2615718 T10514 C:control_collection c:collection1 
oasu.UpdateHandler.<init> Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2615718 T10514 C:control_collection c:collection1 
oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10
   [junit4]   2> 2615721 T10514 C:control_collection c:collection1 
oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 2615721 T10514 C:control_collection c:collection1 
oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 2615721 T10514 C:control_collection c:collection1 
oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=34, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=25.697265625, 
floorSegmentMB=1.0810546875, forceMergeDeletesPctAllowed=21.70150786920577, 
segmentsPerTier=16.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.7655854857509908
   [junit4]   2> 2615722 T10514 C:control_collection c:collection1 
oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@43fc8d98 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@79b41906),segFN=segments_1,generation=1}
   [junit4]   2> 2615722 T10514 C:control_collection c:collection1 
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 2615722 T10514 C:control_collection c:collection1 
oass.SolrIndexSearcher.<init> Opening Searcher@221a29d9[collection1] main
   [junit4]   2> 2615723 T10514 C:control_collection c:collection1 
oascc.ZkStateReader.readConfigName Load collection config 
from:/collections/control_collection
   [junit4]   2> 2615725 T10514 C:control_collection c:collection1 
oascc.ZkStateReader.readConfigName path=/collections/control_collection 
configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 2615725 T10514 C:control_collection c:collection1 
oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for 
the RestManager with znodeBase: /configs/conf1
   [junit4]   2> 2615727 T10514 C:control_collection c:collection1 
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured 
ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 2615727 T10514 C:control_collection c:collection1 
oasr.RestManager.init Initializing RestManager with initArgs: {}
   [junit4]   2> 2615727 T10514 C:control_collection c:collection1 
oasr.ManagedResourceStorage.load Reading _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 2615728 T10514 C:control_collection c:collection1 
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found 
for znode /configs/conf1/_rest_managed.json
   [junit4]   2> 2615728 T10514 C:control_collection c:collection1 
oasr.ManagedResourceStorage.load Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 2615728 T10514 C:control_collection c:collection1 
oasr.RestManager.init Initializing 0 registered ManagedResources
   [junit4]   2> 2615729 T10514 C:control_collection c:collection1 
oash.ReplicationHandler.inform Commits will be reserved for  10000
   [junit4]   2> 2615729 T10514 C:control_collection c:collection1 
oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 2615729 T10515 C:control_collection c:collection1 
oasc.SolrCore.registerSearcher [collection1] Registered new searcher 
Searcher@221a29d9[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2615731 T10518 C:control_collection S:shard1 
oasc.ZkController.register Register replica - core:collection1 
address:http://127.0.0.1:64551 collection:control_collection shard:shard1
   [junit4]   2> 2615732 T10484 oass.SolrDispatchFilter.init 
user.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1
   [junit4]   2> 2615732 T10484 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init() done
   [junit4]   2> 2615733 T10484 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 2615734 T10484 oascc.ConnectionManager.waitForConnected 
Waiting for client to connect to ZooKeeper
   [junit4]   2> 2615734 T10518 C:control_collection S:shard1 
oascc.SolrZkClient.makePath makePath: 
/collections/control_collection/leader_elect/shard1/election
   [junit4]   2> 2615737 T10521 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@4a4e8116 
name:ZooKeeperConnection Watcher:127.0.0.1:64548/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2615737 T10484 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 2615738 T10484 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 2615738 T10484 
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state 
from ZooKeeper... 
   [junit4]   2> 2615746 T10484 oasc.ChaosMonkey.monkeyLog monkey: init - 
expire sessions:false cause connection loss:false
   [junit4]   2> 2615747 T10518 C:control_collection S:shard1 
oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for 
shard shard1
   [junit4]   2> 2615750 T10510 oasc.DistributedQueue$LatchWatcher.process 
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
   [junit4]   2> 2615751 T10518 C:control_collection S:shard1 
oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found 
to continue.
   [junit4]   2> 2615751 T10518 C:control_collection S:shard1 
oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try 
and sync
   [junit4]   2> ASYNC  NEW_CORE C2701 name=collection1 
org.apache.solr.core.SolrCore@3076a365 url=http://127.0.0.1:64551/collection1 
node=127.0.0.1:64551_ C2701_STATE=coll:control_collection core:collection1 
props:{base_url=http://127.0.0.1:64551, core=collection1, state=down, 
node_name=127.0.0.1:64551_}
   [junit4]   2> 2615751 T10518 C:control_collection S:shard1 C2701 P64551 
oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:64551/collection1/
   [junit4]   2> 2615752 T10518 C:control_collection S:shard1 C2701 P64551 
oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
   [junit4]   2> 2615752 T10518 C:control_collection S:shard1 C2701 P64551 
oasc.SyncStrategy.syncToMe http://127.0.0.1:64551/collection1/ has no replicas
   [junit4]   2> 2615752 T10518 C:control_collection S:shard1 
oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: 
http://127.0.0.1:64551/collection1/ shard1
   [junit4]   2> 2615752 T10518 C:control_collection S:shard1 
oascc.SolrZkClient.makePath makePath: 
/collections/control_collection/leaders/shard1
   [junit4]   2> 2615752 T10511 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> 2615755 T10521 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> 2615755 T10510 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> 2615774 T10511 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:64551";,
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "state":"active"} current state version: 2
   [junit4]   2> 2615778 T10510 oasc.DistributedQueue$LatchWatcher.process 
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
   [junit4]   2> 2615782 T10521 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> 2615782 T10510 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> 2615824 T10518 C:control_collection S:shard1 
oasc.ZkController.register We are http://127.0.0.1:64551/collection1/ and 
leader is http://127.0.0.1:64551/collection1/
   [junit4]   2> 2615825 T10518 C:control_collection S:shard1 
oasc.ZkController.register No LogReplay needed for core=collection1 
baseURL=http://127.0.0.1:64551
   [junit4]   2> 2615825 T10518 C:control_collection S:shard1 
oasc.ZkController.checkRecovery I am the leader, no recovery necessary
   [junit4]   2> 2615825 T10518 C:control_collection S:shard1 c:collection1 
oasc.ZkController.publish publishing core=collection1 state=active 
collection=control_collection
   [junit4]   2> 2615825 T10518 C:control_collection S:shard1 c:collection1 
oasc.ZkController.publish numShards not found on descriptor - reading it from 
system property
   [junit4]   2> 2615828 T10510 oasc.DistributedQueue$LatchWatcher.process 
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
   [junit4]   2> 2615831 T10511 oasc.Overseer$ClusterStateUpdater.run 
processMessage: queueSize: 1, message = {
   [junit4]   2>          "base_url":"http://127.0.0.1:64551";,
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "collection":"control_collection",
   [junit4]   2>          "core_node_name":"core_node1",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "state":"active",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "numShards":"2",
   [junit4]   2>          "node_name":"127.0.0.1:64551_",
   [junit4]   2>          "shard":"shard1"} current state version: 3
   [junit4]   2> 2615833 T10511 oasco.ReplicaMutator.updateState Update state 
numShards=2 message={
   [junit4]   2>          "base_url":"http://127.0.0.1:64551";,
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "collection":"control_collection",
   [junit4]   2>          "core_node_name":"core_node1",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "state":"active",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "numShards":"2",
   [junit4]   2>          "node_name":"127.0.0.1:64551_",
   [junit4]   2>          "shard":"shard1"}
   [junit4]   2> 2615944 T10521 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> 2615944 T10510 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> 2616159 T10484 oas.SolrTestCaseJ4.writeCoreProperties Writing 
core.properties file to 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/shard-1-001/cores/collection1
   [junit4]   2> 2616163 T10484 oasc.AbstractFullDistribZkTestBase.createJettys 
create jetty 1 in directory 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/shard-1-001
   [junit4]   2> 2616164 T10484 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 2616171 T10484 oejs.AbstractConnector.doStart Started 
[email protected]:64556
   [junit4]   2> 2616172 T10484 oascse.JettySolrRunner$1.lifeCycleStarted Jetty 
properties: 
{coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/shard-1-001/cores, hostContext=/, hostPort=64556, 
solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/tempDir-001/jetty1, solrconfig=solrconfig.xml}
   [junit4]   2> 2616172 T10484 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@5472fe25
   [junit4]   2> 2616173 T10484 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/shard-1-001/'
   [junit4]   2> 2616208 T10484 oasc.SolrXmlConfig.fromFile Loading container 
configuration from 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/shard-1-001/solr.xml
   [junit4]   2> 2616239 T10484 oasc.CorePropertiesLocator.<init> 
Config-defined core root directory: 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/shard-1-001/cores
   [junit4]   2> 2616240 T10484 oasc.CoreContainer.<init> New CoreContainer 
599334287
   [junit4]   2> 2616240 T10484 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/shard-1-001/]
   [junit4]   2> 2616240 T10484 oasc.CoreContainer.load loading shared library: 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/shard-1-001/lib
   [junit4]   2> 2616241 T10484 oasc.SolrResourceLoader.addToClassLoader WARN 
Can't find (or read) directory to add to classloader: lib (resolved as: 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/shard-1-001/lib).
   [junit4]   2> 2616251 T10484 oashc.HttpShardHandlerFactory.getParameter 
Setting socketTimeout to: 90000
   [junit4]   2> 2616251 T10484 oashc.HttpShardHandlerFactory.getParameter 
Setting urlScheme to: 
   [junit4]   2> 2616251 T10484 oashc.HttpShardHandlerFactory.getParameter 
Setting connTimeout to: 15000
   [junit4]   2> 2616252 T10484 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnectionsPerHost to: 20
   [junit4]   2> 2616252 T10484 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnections to: 10000
   [junit4]   2> 2616252 T10484 oashc.HttpShardHandlerFactory.getParameter 
Setting corePoolSize to: 0
   [junit4]   2> 2616253 T10484 oashc.HttpShardHandlerFactory.getParameter 
Setting maximumPoolSize to: 2147483647
   [junit4]   2> 2616253 T10484 oashc.HttpShardHandlerFactory.getParameter 
Setting maxThreadIdleTime to: 5
   [junit4]   2> 2616253 T10484 oashc.HttpShardHandlerFactory.getParameter 
Setting sizeOfQueue to: -1
   [junit4]   2> 2616253 T10484 oashc.HttpShardHandlerFactory.getParameter 
Setting fairnessPolicy to: false
   [junit4]   2> 2616253 T10484 oashc.HttpShardHandlerFactory.getParameter 
Setting useRetries to: false
   [junit4]   2> 2616254 T10484 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 2616254 T10484 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 2616254 T10484 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 2616254 T10484 oasc.CoreContainer.load Node Name: 127.0.0.1
   [junit4]   2> 2616255 T10484 oasc.ZkContainer.initZooKeeper Zookeeper 
client=127.0.0.1:64548/solr
   [junit4]   2> 2616255 T10484 oasc.ZkController.checkChrootPath zkHost 
includes chroot
   [junit4]   2> 2616255 T10484 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 2616256 T10484 oascc.ConnectionManager.waitForConnected 
Waiting for client to connect to ZooKeeper
   [junit4]   2> 2616260 T10533 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@3bcc6ecf 
name:ZooKeeperConnection Watcher:127.0.0.1:64548 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2616260 T10484 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 2616260 T10484 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 2616264 T10484 oascc.ConnectionManager.waitForConnected 
Waiting for client to connect to ZooKeeper
   [junit4]   2> 2616268 T10536 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@3c7aee2a 
name:ZooKeeperConnection Watcher:127.0.0.1:64548/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2616268 T10484 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 2616281 T10484 
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state 
from ZooKeeper... 
   [junit4]   2> 2617294 T10484 oasc.ZkController.createEphemeralLiveNode 
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:64556_
   [junit4]   2> 2617295 T10484 oascc.SolrZkClient.makePath makePath: 
/live_nodes/127.0.0.1:64556_
   [junit4]   2> 2617303 T10484 oasc.Overseer.close Overseer (id=null) closing
   [junit4]   2> 2617309 T10484 oasc.CorePropertiesLocator.discover Looking for 
core definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/shard-1-001/cores
   [junit4]   2> 2617310 T10484 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: 
{shard=, collection=collection1, 
absoluteInstDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/shard-1-001/cores/collection1/, coreNodeName=, 
config=solrconfig.xml, dataDir=data/, transient=false, name=collection1, 
schema=schema.xml, 
instanceDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/shard-1-001/cores/collection1, loadOnStartup=true}
   [junit4]   2> 2617310 T10484 oasc.CorePropertiesLocator.discoverUnder Found 
core collection1 in 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/shard-1-001/cores/collection1/
   [junit4]   2> 2617310 T10484 oasc.CorePropertiesLocator.discover Found 1 
core definitions
   [junit4]   2> 2617312 T10537 C:collection1 c:collection1 
oasc.ZkController.publish publishing core=collection1 state=down 
collection=collection1
   [junit4]   2> 2617312 T10537 C:collection1 c:collection1 
oasc.ZkController.publish numShards not found on descriptor - reading it from 
system property
   [junit4]   2> 2617314 T10510 oasc.DistributedQueue$LatchWatcher.process 
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
   [junit4]   2> 2617314 T10537 C:collection1 c:collection1 
oasc.ZkController.waitForCoreNodeName look for our core node name
   [junit4]   2> 2617317 T10511 oasc.Overseer$ClusterStateUpdater.run 
processMessage: queueSize: 1, message = {
   [junit4]   2>          "base_url":"http://127.0.0.1:64556";,
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "state":"down",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "numShards":"2",
   [junit4]   2>          "node_name":"127.0.0.1:64556_",
   [junit4]   2>          "shard":null} current state version: 4
   [junit4]   2> 2617318 T10511 oasco.ReplicaMutator.updateState Update state 
numShards=2 message={
   [junit4]   2>          "base_url":"http://127.0.0.1:64556";,
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "state":"down",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "numShards":"2",
   [junit4]   2>          "node_name":"127.0.0.1:64556_",
   [junit4]   2>          "shard":null}
   [junit4]   2> 2617319 T10511 oasco.ClusterStateMutator.createCollection 
building a new cName: collection1
   [junit4]   2> 2617319 T10511 oasco.ReplicaMutator.updateState Assigning new 
node to shard shard=shard2
   [junit4]   2> 2617427 T10510 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> 2617428 T10536 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> 2617427 T10521 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> 2618316 T10537 C:collection1 c:collection1 
oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for 
collection1
   [junit4]   2> 2618317 T10537 C:collection1 c:collection1 
oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
   [junit4]   2> 2618319 T10537 C:collection1 c:collection1 
oasc.ZkController.createCollectionZkNode Collection zkNode exists
   [junit4]   2> 2618319 T10537 C:collection1 c:collection1 
oascc.ZkStateReader.readConfigName Load collection config 
from:/collections/collection1
   [junit4]   2> 2618322 T10537 C:collection1 c:collection1 
oascc.ZkStateReader.readConfigName path=/collections/collection1 
configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 2618322 T10537 C:collection1 c:collection1 
oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/shard-1-001/cores/collection1/'
   [junit4]   2> 2618349 T10537 C:collection1 c:collection1 
oasc.ZkController.watchZKConfDir watch zkdir /configs/conf1
   [junit4]   2> 2618355 T10537 C:collection1 c:collection1 oasc.Config.<init> 
loaded config solrconfig.xml with version 0 
   [junit4]   2> 2618372 T10537 C:collection1 c:collection1 
oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
   [junit4]   2> 2618423 T10537 C:collection1 c:collection1 
oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.1.0
   [junit4]   2> 2618486 T10537 C:collection1 c:collection1 
oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 2618490 T10537 C:collection1 c:collection1 
oass.IndexSchema.readSchema Reading Solr Schema from /configs/conf1/schema.xml
   [junit4]   2> 2618504 T10537 C:collection1 c:collection1 
oass.IndexSchema.readSchema [collection1] Schema name=test
   [junit4]   2> 2618870 T10537 C:collection1 c:collection1 
oass.OpenExchangeRatesOrgProvider.init Initialized with 
rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 2618889 T10537 C:collection1 c:collection1 
oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 2618894 T10537 C:collection1 c:collection1 
oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 2618918 T10537 C:collection1 c:collection1 
oass.FileExchangeRateProvider.reload Reloading exchange rates from file 
currency.xml
   [junit4]   2> 2618924 T10537 C:collection1 c:collection1 
oass.FileExchangeRateProvider.reload Reloading exchange rates from file 
currency.xml
   [junit4]   2> 2618931 T10537 C:collection1 c:collection1 
oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 2618933 T10537 C:collection1 c:collection1 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 2618933 T10537 C:collection1 c:collection1 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 2618934 T10537 C:collection1 c:collection1 
oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 2618936 T10537 C:collection1 c:collection1 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 2618936 T10537 C:collection1 c:collection1 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 2618937 T10537 C:collection1 c:collection1 
oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration 
from collection collection1
   [junit4]   2> 2618937 T10537 C:collection1 c:collection1 
oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 2618937 T10537 C:collection1 c:collection1 
oasc.SolrCore.<init> [collection1] Opening new SolrCore at 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/shard-1-001/cores/collection1/, 
dataDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/shard-1-001/cores/collection1/data/
   [junit4]   2> 2618938 T10537 C:collection1 c:collection1 
oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to 
JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@34bba4df
   [junit4]   2> 2618938 T10537 C:collection1 c:collection1 
oasc.CachingDirectoryFactory.get return new directory for 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/shard-1-001/cores/collection1/data
   [junit4]   2> 2618939 T10537 C:collection1 c:collection1 
oasc.SolrCore.getNewIndexDir New index directory detected: old=null 
new=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/shard-1-001/cores/collection1/data/index/
   [junit4]   2> 2618939 T10537 C:collection1 c:collection1 
oasc.SolrCore.initIndex WARN [collection1] Solr index directory 
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/shard-1-001/cores/collection1/data/index' doesn't exist. 
Creating new index...
   [junit4]   2> 2618940 T10537 C:collection1 c:collection1 
oasc.CachingDirectoryFactory.get return new directory for 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/shard-1-001/cores/collection1/data/index
   [junit4]   2> 2618940 T10537 C:collection1 c:collection1 
oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=10, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.10401229674745834]
   [junit4]   2> 2618941 T10537 C:collection1 c:collection1 
oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@953a136 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@517ce502),segFN=segments_1,generation=1}
   [junit4]   2> 2618942 T10537 C:collection1 c:collection1 
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 2618948 T10537 C:collection1 c:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"nodistrib"
   [junit4]   2> 2618948 T10537 C:collection1 c:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"dedupe"
   [junit4]   2> 2618948 T10537 C:collection1 c:collection1 
oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 2618949 T10537 C:collection1 c:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"stored_sig"
   [junit4]   2> 2618949 T10537 C:collection1 c:collection1 
oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 2618949 T10537 C:collection1 c:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"distrib-dup-test-chain-explicit"
   [junit4]   2> 2618950 T10537 C:collection1 c:collection1 
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 2618950 T10537 C:collection1 c:collection1 
oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 2618950 T10537 C:collection1 c:collection1 
oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined 
as default, creating implicit default
   [junit4]   2> 2618963 T10537 C:collection1 c:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 2618965 T10537 C:collection1 c:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 2618967 T10537 C:collection1 c:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 2618969 T10537 C:collection1 c:collection1 
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 2618978 T10537 C:collection1 c:collection1 
oasc.RequestHandlers.initHandlersFromConfig Registered paths: 
/schema,/admin/luke,/admin/plugins,/admin/system,/admin/logging,/replication,/config,/admin/properties,/admin/mbeans,/update/json/docs,/admin/threads,/update,standard,/update/json,/admin/ping,/admin/file,/update/csv,/get,/admin/segments
   [junit4]   2> 2618980 T10537 C:collection1 c:collection1 
oasc.SolrCore.initStatsCache Using default statsCache cache: 
org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 2618981 T10537 C:collection1 c:collection1 
oasu.UpdateHandler.<init> Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2618981 T10537 C:collection1 c:collection1 oasu.UpdateLog.init 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10
   [junit4]   2> 2618982 T10537 C:collection1 c:collection1 
oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 2618983 T10537 C:collection1 c:collection1 
oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 2618983 T10537 C:collection1 c:collection1 
oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=34, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=25.697265625, 
floorSegmentMB=1.0810546875, forceMergeDeletesPctAllowed=21.70150786920577, 
segmentsPerTier=16.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.7655854857509908
   [junit4]   2> 2618984 T10537 C:collection1 c:collection1 
oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@953a136 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@517ce502),segFN=segments_1,generation=1}
   [junit4]   2> 2618984 T10537 C:collection1 c:collection1 
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 2618984 T10537 C:collection1 c:collection1 
oass.SolrIndexSearcher.<init> Opening Searcher@76d71a34[collection1] main
   [junit4]   2> 2618985 T10537 C:collection1 c:collection1 
oascc.ZkStateReader.readConfigName Load collection config 
from:/collections/collection1
   [junit4]   2> 2618988 T10537 C:collection1 c:collection1 
oascc.ZkStateReader.readConfigName path=/collections/collection1 
configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 2618988 T10537 C:collection1 c:collection1 
oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for 
the RestManager with znodeBase: /configs/conf1
   [junit4]   2> 2618989 T10537 C:collection1 c:collection1 
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured 
ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 2618989 T10537 C:collection1 c:collection1 
oasr.RestManager.init Initializing RestManager with initArgs: {}
   [junit4]   2> 2618989 T10537 C:collection1 c:collection1 
oasr.ManagedResourceStorage.load Reading _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 2618991 T10537 C:collection1 c:collection1 
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found 
for znode /configs/conf1/_rest_managed.json
   [junit4]   2> 2618991 T10537 C:collection1 c:collection1 
oasr.ManagedResourceStorage.load Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 2618991 T10537 C:collection1 c:collection1 
oasr.RestManager.init Initializing 0 registered ManagedResources
   [junit4]   2> 2618991 T10537 C:collection1 c:collection1 
oash.ReplicationHandler.inform Commits will be reserved for  10000
   [junit4]   2> 2618992 T10537 C:collection1 c:collection1 
oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 2618993 T10538 C:collection1 c:collection1 
oasc.SolrCore.registerSearcher [collection1] Registered new searcher 
Searcher@76d71a34[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2618995 T10541 C:collection1 S:shard2 
oasc.ZkController.register Register replica - core:collection1 
address:http://127.0.0.1:64556 collection:collection1 shard:shard2
   [junit4]   2> 2618996 T10484 oass.SolrDispatchFilter.init 
user.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1
   [junit4]   2> 2618996 T10484 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init() done
   [junit4]   2> 2618997 T10541 C:collection1 S:shard2 
oascc.SolrZkClient.makePath makePath: 
/collections/collection1/leader_elect/shard2/election
   [junit4]   2> 2619009 T10541 C:collection1 S:shard2 
oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for 
shard shard2
   [junit4]   2> 2619013 T10510 oasc.DistributedQueue$LatchWatcher.process 
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
   [junit4]   2> 2619014 T10541 C:collection1 S:shard2 
oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found 
to continue.
   [junit4]   2> 2619014 T10541 C:collection1 S:shard2 
oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try 
and sync
   [junit4]   2> ASYNC  NEW_CORE C2702 name=collection1 
org.apache.solr.core.SolrCore@48d7bb35 url=http://127.0.0.1:64556/collection1 
node=127.0.0.1:64556_ C2702_STATE=coll:collection1 core:collection1 
props:{base_url=http://127.0.0.1:64556, core=collection1, state=down, 
node_name=127.0.0.1:64556_}
   [junit4]   2> 2619014 T10541 C:collection1 S:shard2 C2702 P64556 
oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:64556/collection1/
   [junit4]   2> 2619014 T10541 C:collection1 S:shard2 C2702 P64556 
oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
   [junit4]   2> 2619015 T10541 C:collection1 S:shard2 C2702 P64556 
oasc.SyncStrategy.syncToMe http://127.0.0.1:64556/collection1/ has no replicas
   [junit4]   2> 2619015 T10541 C:collection1 S:shard2 
oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: 
http://127.0.0.1:64556/collection1/ shard2
   [junit4]   2> 2619015 T10511 oasc.Overseer$ClusterStateUpdater.run 
processMessage: queueSize: 1, message = {
   [junit4]   2>          "operation":"leader",
   [junit4]   2>          "shard":"shard2",
   [junit4]   2>          "collection":"collection1"} current state version: 5
   [junit4]   2> 2619015 T10541 C:collection1 S:shard2 
oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard2
   [junit4]   2> 2619019 T10521 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> 2619019 T10510 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> 2619024 T10536 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> 2619033 T10510 oasc.DistributedQueue$LatchWatcher.process 
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
   [junit4]   2> 2619037 T10511 oasc.Overseer$ClusterStateUpdater.run 
processMessage: queueSize: 1, message = {
   [junit4]   2>          "operation":"leader",
   [junit4]   2>          "shard":"shard2",
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "base_url":"http://127.0.0.1:64556";,
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "state":"active"} current state version: 6
   [junit4]   2> 2619146 T10510 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> 2619147 T10521 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> 2619147 T10536 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> 2619188 T10541 C:collection1 S:shard2 
oasc.ZkController.register We are http://127.0.0.1:64556/collection1/ and 
leader is http://127.0.0.1:64556/collection1/
   [junit4]   2> 2619188 T10541 C:collection1 S:shard2 
oasc.ZkController.register No LogReplay needed for core=collection1 
baseURL=http://127.0.0.1:64556
   [junit4]   2> 2619189 T10541 C:collection1 S:shard2 
oasc.ZkController.checkRecovery I am the leader, no recovery necessary
   [junit4]   2> 2619189 T10541 C:collection1 S:shard2 c:collection1 
oasc.ZkController.publish publishing core=collection1 state=active 
collection=collection1
   [junit4]   2> 2619189 T10541 C:collection1 S:shard2 c:collection1 
oasc.ZkController.publish numShards not found on descriptor - reading it from 
system property
   [junit4]   2> 2619192 T10510 oasc.DistributedQueue$LatchWatcher.process 
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
   [junit4]   2> 2619194 T10511 oasc.Overseer$ClusterStateUpdater.run 
processMessage: queueSize: 1, message = {
   [junit4]   2>          "base_url":"http://127.0.0.1:64556";,
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "core_node_name":"core_node1",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "state":"active",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "numShards":"2",
   [junit4]   2>          "node_name":"127.0.0.1:64556_",
   [junit4]   2>          "shard":"shard2"} current state version: 7
   [junit4]   2> 2619196 T10511 oasco.ReplicaMutator.updateState Update state 
numShards=2 message={
   [junit4]   2>          "base_url":"http://127.0.0.1:64556";,
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "core_node_name":"core_node1",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "state":"active",
   [junit4]   2>          "operation":"state",
   [junit4]   2>          "numShards":"2",
   [junit4]   2>          "node_name":"127.0.0.1:64556_",
   [junit4]   2>          "shard":"shard2"}
   [junit4]   2> 2619305 T10510 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> 2619305 T10536 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> 2619305 T10521 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> 2619480 T10484 oas.SolrTestCaseJ4.writeCoreProperties Writing 
core.properties file to 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/shard-2-001/cores/collection1
   [junit4]   2> 2619483 T10484 oasc.AbstractFullDistribZkTestBase.createJettys 
create jetty 2 in directory 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/shard-2-001
   [junit4]   2> 2619484 T10484 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 2619490 T10484 oejs.AbstractConnector.doStart Started 
[email protected]:64562
   [junit4]   2> 2619491 T10484 oascse.JettySolrRunner$1.lifeCycleStarted Jetty 
properties: 
{solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/tempDir-001/jetty2, hostPort=64562, 
coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/shard-2-001/cores, hostContext=/, 
solrconfig=solrconfig.xml}
   [junit4]   2> 2619492 T10484 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@5472fe25
   [junit4]   2> 2619492 T10484 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/shard-2-001/'
   [junit4]   2> 2619537 T10484 oasc.SolrXmlConfig.fromFile Loading container 
configuration from 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/shard-2-001/solr.xml
   [junit4]   2> 2619582 T10484 oasc.CorePropertiesLocator.<init> 
Config-defined core root directory: 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/shard-2-001/cores
   [junit4]   2> 2619583 T10484 oasc.CoreContainer.<init> New CoreContainer 
1830985963
   [junit4]   2> 2619583 T10484 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/shard-2-001/]
   [junit4]   2> 2619583 T10484 oasc.CoreContainer.load loading shared library: 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/shard-2-001/lib
   [junit4]   2> 2619584 T10484 oasc.SolrResourceLoader.addToClassLoader WARN 
Can't find (or read) directory to add to classloader: lib (resolved as: 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001/shar

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

n-explicit",
   [junit4]    >         "":[
   [junit4]    >           {"class":"solr.RegexReplaceProcessorFactory"},
   [junit4]    >           {"class":"solr.DistributedUpdateProcessorFactory"},
   [junit4]    >           {"class":"solr.RegexReplaceProcessorFactory"},
   [junit4]    >           {"class":"solr.RunUpdateProcessorFactory"}]},
   [junit4]    >       {
   [junit4]    >         "name":"distrib-dup-test-chain-implicit",
   [junit4]    >         "":[
   [junit4]    >           {"class":"solr.RegexReplaceProcessorFactory"},
   [junit4]    >           {"class":"solr.RegexReplaceProcessorFactory"},
   [junit4]    >           {"class":"solr.RunUpdateProcessorFactory"}]}],
   [junit4]    >     "updateHandlerupdateLog":{"dir":""},
   [junit4]    >     "jmx":{
   [junit4]    >       "agentId":null,
   [junit4]    >       "serviceUrl":null,
   [junit4]    >       "rootName":null},
   [junit4]    >     "requestDispatcher":{
   [junit4]    >       "handleSelect":true,
   [junit4]    >       "httpCaching":{
   [junit4]    >         "never304":false,
   [junit4]    >         "etagSeed":"Solr",
   [junit4]    >         "lastModFrom":"opentime",
   [junit4]    >         "cacheControl":null},
   [junit4]    >       "requestParsers":{
   [junit4]    >         "multipartUploadLimitKB":2048,
   [junit4]    >         "formUploadLimitKB":2048,
   [junit4]    >         "addHttpRequestToContext":false}},
   [junit4]    >     "indexConfig":{
   [junit4]    >       "maxBufferedDocs":192,
   [junit4]    >       "maxMergeDocs":-1,
   [junit4]    >       "maxIndexingThreads":2,
   [junit4]    >       "mergeFactor":-1,
   [junit4]    >       "ramBufferSizeMB":16.0,
   [junit4]    >       "writeLockTimeout":1000,
   [junit4]    >       "lockType":"single",
   [junit4]    >       
"mergeScheduler":{"class":"org.apache.solr.util.RandomMergePolicy"}}}}
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([8DFDE37F2589727C:5A9DCA58B751F84]:0)
   [junit4]    >        at 
org.apache.solr.core.TestSolrConfigHandler.testForResponseElement(TestSolrConfigHandler.java:399)
   [junit4]    >        at 
org.apache.solr.core.TestSolrConfigHandler.reqhandlertests(TestSolrConfigHandler.java:228)
   [junit4]    >        at 
org.apache.solr.handler.TestSolrConfigHandlerCloud.testReqHandlerAPIs(TestSolrConfigHandlerCloud.java:91)
   [junit4]    >        at 
org.apache.solr.handler.TestSolrConfigHandlerCloud.test(TestSolrConfigHandlerCloud.java:77)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:958)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:933)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 2653822 T10484 C:control_collection S:shard1 c:collection1 
oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSolrConfigHandlerCloud
 8DFDE37F2589727C-001
   [junit4]   2> 40467 T10483 ccr.ThreadLeakControl.checkThreadLeaks WARNING 
Will linger awaiting termination of 1 leaked thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene50), 
sim=DefaultSimilarity, locale=es_PA, timezone=Africa/Tunis
   [junit4]   2> NOTE: Mac OS X 10.8.5 x86_64/Oracle Corporation 1.7.0_76 
(64-bit)/cpus=3,threads=1,free=109118496,total=332890112
   [junit4]   2> NOTE: All tests run in this JVM: [TestLFUCache, 
SimplePostToolTest, TestReplicaProperties, CSVRequestHandlerTest, 
RAMDirectoryFactoryTest, ShardSplitTest, ConvertedLegacyTest, 
DistributedDebugComponentTest, TestCollationField, 
CollectionsAPIAsyncDistributedZkTest, ConnectionManagerTest, CursorPagingTest, 
CursorMarkTest, UpdateParamsTest, TestTolerantSearch, DisMaxRequestHandlerTest, 
TestSuggestSpellingConverter, TestComponentsName, TestFreeTextSuggestions, 
TestRemoteStreaming, SpellingQueryConverterTest, TestReload, 
DistributedQueryComponentCustomSortTest, CollectionsAPIDistributedZkTest, 
ActionThrottleTest, DirectSolrSpellCheckerTest, TestFoldingMultitermQuery, 
TestRawResponseWriter, FieldMutatingUpdateProcessorTest, HdfsDirectoryTest, 
PreAnalyzedFieldTest, TestClusterStateMutator, TestSearchPerf, 
QueryParsingTest, FullSolrCloudDistribCmdsTest, 
TestReversedWildcardFilterFactory, TestHdfsUpdateLog, TestCloudPivotFacet, 
DistributedTermsComponentTest, FacetPivotSmallTest, 
TestLMJelinekMercerSimilarityFactory, TermVectorComponentDistributedTest, 
TestUtils, TestLRUStatsCache, TestDefaultSimilarityFactory, 
SynonymTokenizerTest, TestCharFilters, TestSimpleTrackingShardHandler, 
TestJoin, TestDynamicFieldCollectionResource, TestLeaderElectionZkExpiry, 
TermVectorComponentTest, JSONWriterTest, AtomicUpdatesTest, QueryEqualityTest, 
RemoteQueryErrorTest, RankQueryTest, TestMiniSolrCloudCluster, TestRestManager, 
TestDefaultSearchFieldResource, TestManagedSchema, TestZkChroot, 
EchoParamsTest, StandardRequestHandlerTest, TestPseudoReturnFields, 
TestQuerySenderNoQuery, RequestLoggingTest, SolrIndexConfigTest, 
ZkSolrClientTest, EnumFieldTest, AsyncMigrateRouteKeyTest, 
DirectUpdateHandlerOptimizeTest, SpellCheckComponentTest, DocumentBuilderTest, 
TestJettySolrRunner, DistribDocExpirationUpdateProcessorTest, 
TestCollectionAPI, TestFiltering, TermsComponentTest, 
UUIDUpdateProcessorFallbackTest, 
IgnoreCommitOptimizeUpdateProcessorFactoryTest, CustomCollectionTest, 
SampleTest, FastVectorHighlighterTest, TestShardHandlerFactory, TestConfig, 
LoggingHandlerTest, TestSolrDeletionPolicy1, DistributedExpandComponentTest, 
XsltUpdateRequestHandlerTest, TestSchemaManager, 
StatelessScriptUpdateProcessorFactoryTest, PrimitiveFieldTypeTest, 
TestDynamicFieldResource, BlockDirectoryTest, TestSortingResponseWriter, 
ResponseHeaderTest, TestHighlightDedupGrouping, TestShortCircuitedRequests, 
TestStandardQParsers, TestJsonFacets, TestDistributedGrouping, PolyFieldTest, 
RecoveryAfterSoftCommitTest, HighlighterTest, AutoCommitTest, 
TestMergePolicyConfig, TestCoreDiscovery, DeleteReplicaTest, 
DateMathParserTest, TestCryptoKeys, TestExactStatsCache, 
TestNamedUpdateProcessors, TimeZoneUtilsTest, BasicDistributedZkTest, 
ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test, SyncSliceTest, 
OpenCloseCoreStressTest, OverseerTest, LeaderElectionIntegrationTest, 
BasicZkTest, ClusterStateUpdateTest, TestRandomFaceting, 
ShardRoutingCustomTest, DistributedSpellCheckComponentTest, ZkControllerTest, 
HardAutoCommitTest, TestRangeQuery, TestSolr4Spatial, StatsComponentTest, 
TestFunctionQuery, BasicFunctionalityTest, DirectUpdateHandlerTest, 
TestBadConfig, TestIndexSearcher, CurrencyFieldOpenExchangeTest, 
CurrencyFieldXmlFileTest, SolrIndexSplitterTest, TestExtendedDismaxParser, 
SuggesterFSTTest, DocValuesTest, SuggesterTSTTest, SpatialFilterTest, 
WordBreakSolrSpellCheckerTest, DefaultValueUpdateProcessorTest, 
SolrInfoMBeanTest, IndexBasedSpellCheckerTest, FileBasedSpellCheckerTest, 
TestValueSourceCache, FieldAnalysisRequestHandlerTest, TestArbitraryIndexDir, 
TestJmxIntegration, MBeansHandlerTest, UniqFieldsUpdateProcessorFactoryTest, 
TestPartialUpdateDeduplication, TestPHPSerializedResponseWriter, 
HighlighterConfigTest, TestQuerySenderListener, CopyFieldTest, 
BadComponentTest, TestDocSet, TestElisionMultitermQuery, 
TestFuzzyAnalyzedSuggestions, TestSolrCoreProperties, DirectSolrConnectionTest, 
NotRequiredUniqueKeyTest, TestPhraseSuggestions, TestXIncludeConfig, 
TestPerFieldSimilarity, TestBM25SimilarityFactory, TestJmxMonitoredMap, 
OpenExchangeRatesOrgProviderTest, TestFastLRUCache, PrimUtilsTest, DOMUtilTest, 
ClusterStateTest, TestLRUCache, TestDocumentBuilder, SliceStateTest, 
SystemInfoHandlerTest, UUIDFieldTest, CircularListTest, TestRTGBase, 
DistributedIntervalFacetingTest, SolrTestCaseJ4Test, 
TestCursorMarkWithoutUniqueKey, TestDistributedMissingSort, 
CloudExitableDirectoryReaderTest, DistribCursorPagingTest, 
LeaderFailoverAfterPartitionTest, OutOfBoxZkACLAndCredentialsProvidersTest, 
OverriddenZkACLAndCredentialsProvidersTest, OverseerRolesTest, 
RollingRestartTest, SaslZkACLProviderTest, SharedFSAutoReplicaFailoverTest, 
SolrXmlInZkTest, TestCloudInspectUtil, TestDistribDocBasedVersion, 
TriLevelCompositeIdRoutingTest, HdfsDirectoryFactoryTest, QueryResultKeyTest, 
TestConfigOverlay, TestConfigSets, TestImplicitCoreProperties, 
TestInfoStreamLogging, TestInitParams, TestNRTOpen, TestSolrDynamicMBean, 
TestSolrXml, TestBlobHandler, TestReplicationHandlerBackup, 
TestSolrConfigHandlerCloud]
   [junit4] Completed on J1 in 40.76s, 1 test, 1 failure <<< FAILURES!

[...truncated 217 lines...]
BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:529: The following 
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:477: The following 
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:61: The following 
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/extra-targets.xml:39: The 
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build.xml:191: The 
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/common-build.xml:509: The 
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/lucene/common-build.xml:1370: 
The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/lucene/common-build.xml:976: 
There were test failures: 478 suites, 1900 tests, 1 failure, 53 ignored (20 
assumptions)

Total time: 85 minutes 25 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 64bit/jdk1.7.0 
-XX:-UseCompressedOops -XX:+UseSerialGC
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