lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Joel Bernstein <joels...@gmail.com>
Subject Re: [JENKINS] Lucene-Solr-trunk-MacOSX (64bit/jdk1.8.0) - Build # 2471 - Still Failing!
Date Wed, 01 Jul 2015 16:10:38 GMT
Basically what the error is saying is that SortingResponseWriter did not
find the Export bitset in the request context. This implies something went
wrong with the ExportQParserPlugin. Since the seed is not reproducing, I'll
add some asserts to the ExportQParserPlugin to see if we can get to the
bottom of the issue.

Joel Bernstein
http://joelsolr.blogspot.com/

On Wed, Jul 1, 2015 at 11:48 AM, Joel Bernstein <joelsolr@gmail.com> wrote:

> Digging deeper into the log the root error seems to be the the error
> below. From the looks of things, this should cause a failure every time or
> it should never cause a failure. I'll investigate further.
>
> o.a.s.s.SolrDispatchFilter null:java.io.IOException: org.apache.solr.search.SyntaxError: xport RankQuery is required for xsort: rq={!xport}
>    [junit4]   2> 	at org.apache.solr.response.SortingResponseWriter.write(SortingResponseWriter.java:101)
>    [junit4]   2> 	at org.apache.solr.response.QueryResponseWriterUtil.writeQueryResponse(QueryResponseWriterUtil.java:53)
>
>
>
> Joel Bernstein
> http://joelsolr.blogspot.com/
>
> On Wed, Jul 1, 2015 at 11:27 AM, Joel Bernstein <joelsolr@gmail.com>
> wrote:
>
>> This doesn't reproduce for me locally with the seed. I'll some add some
>> asserts to see if I can get to the bottom of the failure.
>>
>> Joel Bernstein
>> http://joelsolr.blogspot.com/
>>
>> On Wed, Jul 1, 2015 at 10:50 AM, Policeman Jenkins Server <
>> jenkins@thetaphi.de> wrote:
>>
>>> Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-MacOSX/2471/
>>> Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseParallelGC
>>>
>>> 1 tests failed.
>>> FAILED:  org.apache.solr.handler.TestSQLHandler.doTest
>>>
>>> Error Message:
>>> JSONTupleStream: expected ARRAY_START but got EOF
>>>
>>> Stack Trace:
>>> java.io.IOException: JSONTupleStream: expected ARRAY_START but got EOF
>>>         at
>>> __randomizedtesting.SeedInfo.seed([C5ED92674EE29591:62A92AC323598628]:0)
>>>         at
>>> org.apache.solr.client.solrj.io.stream.JSONTupleStream.expect(JSONTupleStream.java:99)
>>>         at
>>> org.apache.solr.client.solrj.io.stream.JSONTupleStream.advanceToDocs(JSONTupleStream.java:159)
>>>         at
>>> org.apache.solr.client.solrj.io.stream.JSONTupleStream.next(JSONTupleStream.java:77)
>>>         at
>>> org.apache.solr.client.solrj.io.stream.SolrStream.read(SolrStream.java:149)
>>>         at
>>> org.apache.solr.handler.TestSQLHandler.getTuples(TestSQLHandler.java:833)
>>>         at
>>> org.apache.solr.handler.TestSQLHandler.testTimeSeriesGrouping(TestSQLHandler.java:613)
>>>         at
>>> org.apache.solr.handler.TestSQLHandler.doTest(TestSQLHandler.java:92)
>>>         at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>>>         at
>>> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
>>>         at
>>> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>>>         at java.lang.reflect.Method.invoke(Method.java:497)
>>>         at
>>> com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
>>>         at
>>> com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836)
>>>         at
>>> com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872)
>>>         at
>>> com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886)
>>>         at
>>> org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:960)
>>>         at
>>> org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:935)
>>>         at
>>> com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
>>>         at
>>> org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
>>>         at
>>> org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
>>>         at
>>> org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
>>>         at
>>> org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
>>>         at
>>> org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
>>>         at
>>> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>>         at
>>> com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
>>>         at
>>> com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
>>>         at
>>> com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
>>>         at
>>> com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845)
>>>         at
>>> com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747)
>>>         at
>>> com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781)
>>>         at
>>> com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792)
>>>         at
>>> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>>         at
>>> com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
>>>         at
>>> org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
>>>         at
>>> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>>         at
>>> org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
>>>         at
>>> com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
>>>         at
>>> com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
>>>         at
>>> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>>         at
>>> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>>         at
>>> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>>         at
>>> org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
>>>         at
>>> org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
>>>         at
>>> org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
>>>         at
>>> org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
>>>         at
>>> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>>         at
>>> com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
>>>         at java.lang.Thread.run(Thread.java:745)
>>>
>>>
>>>
>>>
>>> Build Log:
>>> [...truncated 9843 lines...]
>>>    [junit4] Suite: org.apache.solr.handler.TestSQLHandler
>>>    [junit4]   2> Creating dataDir:
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/init-core-data-001
>>>    [junit4]   2> 1116503 INFO
>>> (SUITE-TestSQLHandler-seed#[C5ED92674EE29591]-worker) [    ]
>>> o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
>>>    [junit4]   2> 1116503 INFO
>>> (SUITE-TestSQLHandler-seed#[C5ED92674EE29591]-worker) [    ]
>>> o.a.s.BaseDistributedSearchTestCase Setting hostContext system property:
>>> /rd/i
>>>    [junit4]   2> 1116505 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
>>>    [junit4]   2> 1116506 INFO  (Thread-2366) [    ] o.a.s.c.ZkTestServer
>>> client port:0.0.0.0/0.0.0.0:0
>>>    [junit4]   2> 1116506 INFO  (Thread-2366) [    ] o.a.s.c.ZkTestServer
>>> Starting server
>>>    [junit4]   2> 1116607 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.ZkTestServer start zk server on port:49569
>>>    [junit4]   2> 1116607 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
>>>    [junit4]   2> 1116608 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
>>>    [junit4]   2> 1116617 INFO  (zkCallback-787-thread-1) [    ]
>>> o.a.s.c.c.ConnectionManager Watcher
>>> org.apache.solr.common.cloud.ConnectionManager@7f1cd40a
>>> name:ZooKeeperConnection Watcher:127.0.0.1:49569 got event WatchedEvent
>>> state:SyncConnected type:None path:null path:null type:None
>>>    [junit4]   2> 1116617 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
>>>    [junit4]   2> 1116617 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.SolrZkClient Using default ZkACLProvider
>>>    [junit4]   2> 1116617 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.SolrZkClient makePath: /solr
>>>    [junit4]   2> 1116623 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
>>>    [junit4]   2> 1116624 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
>>>    [junit4]   2> 1116626 INFO  (zkCallback-788-thread-1) [    ]
>>> o.a.s.c.c.ConnectionManager Watcher
>>> org.apache.solr.common.cloud.ConnectionManager@7cb53aad
>>> name:ZooKeeperConnection Watcher:127.0.0.1:49569/solr got event
>>> WatchedEvent state:SyncConnected type:None path:null path:null type:None
>>>    [junit4]   2> 1116627 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
>>>    [junit4]   2> 1116627 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.SolrZkClient Using default ZkACLProvider
>>>    [junit4]   2> 1116627 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.SolrZkClient makePath: /collections/collection1
>>>    [junit4]   2> 1116633 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
>>>    [junit4]   2> 1116637 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
>>>    [junit4]   2> 1116640 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
>>>    [junit4]   2> 1116644 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.AbstractZkTestCase put
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/solrconfig-sql.xml
>>> to /configs/conf1/solrconfig.xml
>>>    [junit4]   2> 1116644 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
>>>    [junit4]   2> 1116649 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.AbstractZkTestCase put
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/schema-sql.xml
>>> to /configs/conf1/schema.xml
>>>    [junit4]   2> 1116650 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
>>>    [junit4]   2> 1116654 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.AbstractZkTestCase put
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
>>> to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
>>>    [junit4]   2> 1116655 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.SolrZkClient makePath:
>>> /configs/conf1/solrconfig.snippet.randomindexconfig.xml
>>>    [junit4]   2> 1116659 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.AbstractZkTestCase put
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
>>> to /configs/conf1/stopwords.txt
>>>    [junit4]   2> 1116659 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
>>>    [junit4]   2> 1116663 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.AbstractZkTestCase put
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/protwords.txt
>>> to /configs/conf1/protwords.txt
>>>    [junit4]   2> 1116664 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
>>>    [junit4]   2> 1116668 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.AbstractZkTestCase put
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/currency.xml
>>> to /configs/conf1/currency.xml
>>>    [junit4]   2> 1116669 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
>>>    [junit4]   2> 1116673 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.AbstractZkTestCase put
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
>>> to /configs/conf1/enumsConfig.xml
>>>    [junit4]   2> 1116673 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
>>>    [junit4]   2> 1116678 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.AbstractZkTestCase put
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
>>> to /configs/conf1/open-exchange-rates.json
>>>    [junit4]   2> 1116679 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
>>>    [junit4]   2> 1116682 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.AbstractZkTestCase put
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
>>> to /configs/conf1/mapping-ISOLatin1Accent.txt
>>>    [junit4]   2> 1116683 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
>>>    [junit4]   2> 1116687 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.AbstractZkTestCase put
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
>>> to /configs/conf1/old_synonyms.txt
>>>    [junit4]   2> 1116687 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
>>>    [junit4]   2> 1116692 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.AbstractZkTestCase put
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
>>> to /configs/conf1/synonyms.txt
>>>    [junit4]   2> 1116692 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
>>>    [junit4]   2> 1117067 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.SolrTestCaseJ4 Writing core.properties file to
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/control-001/cores/collection1
>>>    [junit4]   2> 1117070 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ] o.e.j.s.Server
>>> jetty-9.2.11.v20150529
>>>    [junit4]   2> 1117074 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6f71ee28
>>> {/rd/i,null,AVAILABLE}
>>>    [junit4]   2> 1117075 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.e.j.s.ServerConnector Started ServerConnector@1395ce86{HTTP/1.1}{
>>> 127.0.0.1:49573}
>>>    [junit4]   2> 1117075 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ] o.e.j.s.Server
>>> Started @1125747ms
>>>    [junit4]   2> 1117075 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.s.e.JettySolrRunner Jetty properties:
>>> {solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/tempDir-001/control/data,
>>> hostContext=/rd/i, hostPort=49573,
>>> coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/control-001/cores}
>>>    [junit4]   2> 1117075 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
>>> sun.misc.Launcher$AppClassLoader@74a14482
>>>    [junit4]   2> 1117075 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
>>> '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/control-001/'
>>>    [junit4]   2> 1117104 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.SolrXmlConfig Loading container configuration from
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/control-001/solr.xml
>>>    [junit4]   2> 1117120 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.CoresLocator Config-defined core root directory:
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/control-001/cores
>>>    [junit4]   2> 1117120 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.CoreContainer New CoreContainer 1828745879
>>>    [junit4]   2> 1117120 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.CoreContainer Loading cores into CoreContainer
>>> [instanceDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/control-001/]
>>>    [junit4]   2> 1117120 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.CoreContainer loading shared library:
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/control-001/lib
>>>    [junit4]   2> 1117121 WARN
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to
>>> classloader: lib (resolved as:
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/control-001/lib).
>>>    [junit4]   2> 1117130 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout :
>>> 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost :
>>> 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize :
>>> 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy :
>>> false,useRetries : false,
>>>    [junit4]   2> 1117133 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with
>>> params: socketTimeout=340000&connTimeout=45000&retry=true
>>>    [junit4]   2> 1117133 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
>>>    [junit4]   2> 1117134 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.l.LogWatcher Registering Log Listener [Log4j
>>> (org.slf4j.impl.Log4jLoggerFactory)]
>>>    [junit4]   2> 1117134 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:49569/solr
>>>    [junit4]   2> 1117134 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.ZkController zkHost includes chroot
>>>    [junit4]   2> 1117134 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
>>>    [junit4]   2> 1117135 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
>>>    [junit4]   2> 1117137 INFO  (zkCallback-790-thread-1) [    ]
>>> o.a.s.c.c.ConnectionManager Watcher
>>> org.apache.solr.common.cloud.ConnectionManager@2648469d
>>> name:ZooKeeperConnection Watcher:127.0.0.1:49569 got event WatchedEvent
>>> state:SyncConnected type:None path:null path:null type:None
>>>    [junit4]   2> 1117137 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
>>>    [junit4]   2> 1117137 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.SolrZkClient Using default ZkACLProvider
>>>    [junit4]   2> 1117140 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49573_rd%2Fi
>>>   ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
>>>    [junit4]   2> 1117142 INFO
>>> (zkCallback-791-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi    ] o.a.s.c.c.ConnectionManager Watcher
>>> org.apache.solr.common.cloud.ConnectionManager@36c3eac8
>>> name:ZooKeeperConnection Watcher:127.0.0.1:49569/solr got event
>>> WatchedEvent state:SyncConnected type:None path:null path:null type:None
>>>    [junit4]   2> 1117142 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49573_rd%2Fi
>>>   ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
>>>    [junit4]   2> 1117144 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49573_rd%2Fi
>>>   ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
>>>    [junit4]   2> 1117149 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49573_rd%2Fi
>>>   ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
>>>    [junit4]   2> 1117153 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49573_rd%2Fi
>>>   ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
>>>    [junit4]   2> 1117158 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49573_rd%2Fi
>>>   ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
>>>    [junit4]   2> 1117163 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49573_rd%2Fi
>>>   ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
>>>    [junit4]   2> 1117168 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49573_rd%2Fi
>>>   ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
>>>    [junit4]   2> 1117172 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49573_rd%2Fi
>>>   ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
>>>    [junit4]   2> 1117176 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49573_rd%2Fi
>>>   ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
>>>    [junit4]   2> 1117179 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49573_rd%2Fi
>>>   ] o.a.s.c.ZkController Register node as live in
>>> ZooKeeper:/live_nodes/127.0.0.1:49573_rd%2Fi
>>>    [junit4]   2> 1117180 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49573_rd%2Fi
>>>   ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:49573_rd%2Fi
>>>    [junit4]   2> 1117184 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49573_rd%2Fi
>>>   ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
>>>    [junit4]   2> 1117187 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49573_rd%2Fi
>>>   ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
>>>    [junit4]   2> 1117190 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49573_rd%2Fi
>>>   ] o.a.s.c.Overseer Overseer (id=null) closing
>>>    [junit4]   2> 1117191 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49573_rd%2Fi
>>>   ] o.a.s.c.LeaderElector Joined leadership election with path:
>>> /overseer_elect/election/94093993000632323-127.0.0.1:49573_rd%2Fi-n_0000000000
>>>    [junit4]   2> 1117193 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49573_rd%2Fi
>>>   ] o.a.s.c.OverseerElectionContext I am going to be the leader
>>> 127.0.0.1:49573_rd%2Fi
>>>    [junit4]   2> 1117193 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49573_rd%2Fi
>>>   ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
>>>    [junit4]   2> 1117196 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49573_rd%2Fi
>>>   ] o.a.s.c.Overseer Overseer
>>> (id=94093993000632323-127.0.0.1:49573_rd%2Fi-n_0000000000) starting
>>>    [junit4]   2> 1117201 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49573_rd%2Fi
>>>   ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
>>>    [junit4]   2> 1117216 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49573_rd%2Fi
>>>   ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting
>>> OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000
>>> autoReplicaFailoverWaitAfterExpiration=30000
>>> autoReplicaFailoverBadNodeExpiration=60000
>>>    [junit4]   2> 1117217 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49573_rd%2Fi
>>>   ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
>>>    [junit4]   2> 1117217 INFO
>>> (OverseerCollectionProcessor-94093993000632323-127.0.0.1:49573_rd%2Fi-n_0000000000)
>>> [n:127.0.0.1:49573_rd%2Fi    ] o.a.s.c.OverseerCollectionProcessor
>>> Process current queue of collection creations
>>>    [junit4]   2> 1117218 INFO
>>> (OverseerStateUpdate-94093993000632323-127.0.0.1:49573_rd%2Fi-n_0000000000)
>>> [n:127.0.0.1:49573_rd%2Fi    ] o.a.s.c.Overseer Starting to work on the
>>> main queue
>>>    [junit4]   2> 1117227 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49573_rd%2Fi
>>>   ] o.a.s.c.CoreContainer No authentication plugin used.
>>>    [junit4]   2> 1117228 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49573_rd%2Fi
>>>   ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for
>>> authorization module.
>>>    [junit4]   2> 1117229 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49573_rd%2Fi
>>>   ] o.a.s.c.CoresLocator Looking for core definitions underneath
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/control-001/cores
>>>    [junit4]   2> 1117232 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49573_rd%2Fi
>>>   ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1,
>>> config=solrconfig.xml, transient=false, schema=schema.xml,
>>> loadOnStartup=true,
>>> instanceDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/control-001/cores/collection1,
>>> collection=control_collection,
>>> absoluteInstDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/control-001/cores/collection1/,
>>> coreNodeName=, dataDir=data/, shard=}
>>>    [junit4]   2> 1117232 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49573_rd%2Fi
>>>   ] o.a.s.c.CoresLocator Found core collection1 in
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/control-001/cores/collection1/
>>>    [junit4]   2> 1117232 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49573_rd%2Fi
>>>   ] o.a.s.c.CoresLocator Found 1 core definitions
>>>    [junit4]   2> 1117234 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection   x:collection1]
>>> o.a.s.c.ZkController publishing state=down
>>>    [junit4]   2> 1117234 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection   x:collection1]
>>> o.a.s.c.ZkController numShards not found on descriptor - reading it from
>>> system property
>>>    [junit4]   2> 1117235 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49573_rd%2Fi
>>>   ] o.a.s.s.SolrDispatchFilter
>>> user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1
>>>    [junit4]   2> 1117235 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49573_rd%2Fi
>>>   ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
>>>    [junit4]   2> 1117235 INFO
>>> (zkCallback-791-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi    ] o.a.s.c.DistributedQueue
>>> NodeChildrenChanged fired on path /overseer/queue state SyncConnected
>>>    [junit4]   2> 1117236 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection   x:collection1]
>>> o.a.s.c.ZkController look for our core node name
>>>    [junit4]   2> 1117237 INFO
>>> (OverseerStateUpdate-94093993000632323-127.0.0.1:49573_rd%2Fi-n_0000000000)
>>> [n:127.0.0.1:49573_rd%2Fi    ] o.a.s.c.Overseer processMessage:
>>> queueSize: 1, message = {
>>>    [junit4]   2>   "core":"collection1",
>>>    [junit4]   2>   "roles":null,
>>>    [junit4]   2>   "base_url":"http://127.0.0.1:49573/rd/i",
>>>    [junit4]   2>   "node_name":"127.0.0.1:49573_rd%2Fi",
>>>    [junit4]   2>   "numShards":"1",
>>>    [junit4]   2>   "state":"down",
>>>    [junit4]   2>   "shard":null,
>>>    [junit4]   2>   "collection":"control_collection",
>>>    [junit4]   2>   "operation":"state"} current state version: 0
>>>    [junit4]   2> 1117238 INFO
>>> (OverseerStateUpdate-94093993000632323-127.0.0.1:49573_rd%2Fi-n_0000000000)
>>> [n:127.0.0.1:49573_rd%2Fi    ] o.a.s.c.o.ReplicaMutator Update state
>>> numShards=1 message={
>>>    [junit4]   2>   "core":"collection1",
>>>    [junit4]   2>   "roles":null,
>>>    [junit4]   2>   "base_url":"http://127.0.0.1:49573/rd/i",
>>>    [junit4]   2>   "node_name":"127.0.0.1:49573_rd%2Fi",
>>>    [junit4]   2>   "numShards":"1",
>>>    [junit4]   2>   "state":"down",
>>>    [junit4]   2>   "shard":null,
>>>    [junit4]   2>   "collection":"control_collection",
>>>    [junit4]   2>   "operation":"state"}
>>>    [junit4]   2> 1117239 INFO
>>> (OverseerStateUpdate-94093993000632323-127.0.0.1:49573_rd%2Fi-n_0000000000)
>>> [n:127.0.0.1:49573_rd%2Fi    ] o.a.s.c.o.ClusterStateMutator building a
>>> new cName: control_collection
>>>    [junit4]   2> 1117239 INFO
>>> (OverseerStateUpdate-94093993000632323-127.0.0.1:49573_rd%2Fi-n_0000000000)
>>> [n:127.0.0.1:49573_rd%2Fi    ] o.a.s.c.o.ReplicaMutator Assigning new
>>> node to shard shard=shard1
>>>    [junit4]   2> 1117241 INFO
>>> (zkCallback-791-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi    ] o.a.s.c.c.ZkStateReader A cluster state
>>> change: WatchedEvent state:SyncConnected type:NodeDataChanged
>>> path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
>>>    [junit4]   2> 1117245 INFO
>>> (zkCallback-791-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi    ] o.a.s.c.c.ZkStateReader Updated cluster
>>> state version to 1
>>>    [junit4]   2> 1118238 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection   x:collection1]
>>> o.a.s.c.ZkController waiting to find shard id in clusterstate for
>>> collection1
>>>    [junit4]   2> 1118238 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection   x:collection1]
>>> o.a.s.c.ZkController Check for collection zkNode:control_collection
>>>    [junit4]   2> 1118239 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection   x:collection1]
>>> o.a.s.c.ZkController Collection zkNode exists
>>>    [junit4]   2> 1118239 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection   x:collection1]
>>> o.a.s.c.c.ZkStateReader Load collection config
>>> from:/collections/control_collection
>>>    [junit4]   2> 1118241 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection   x:collection1]
>>> o.a.s.c.c.ZkStateReader path=/collections/control_collection
>>> configName=conf1 specified config exists in ZooKeeper
>>>    [junit4]   2> 1118241 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection   x:collection1]
>>> o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
>>> '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/control-001/cores/collection1/'
>>>    [junit4]   2> 1118256 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection   x:collection1]
>>> o.a.s.c.Config loaded config solrconfig.xml with version 0
>>>    [junit4]   2> 1118261 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection   x:collection1]
>>> o.a.s.c.SolrConfig current version of requestparams : -1
>>>    [junit4]   2> 1118263 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection   x:collection1]
>>> o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
>>>    [junit4]   2> 1118269 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection   x:collection1]
>>> o.a.s.c.Config Loaded SolrConfig: solrconfig.xml
>>>    [junit4]   2> 1118271 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection   x:collection1]
>>> o.a.s.s.IndexSchema Reading Solr Schema from /configs/conf1/schema.xml
>>>    [junit4]   2> 1118276 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection   x:collection1]
>>> o.a.s.s.IndexSchema [collection1] Schema name=test
>>>    [junit4]   2> 1118331 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection   x:collection1]
>>> o.a.s.s.IndexSchema default search field in schema is text
>>>    [junit4]   2> 1118332 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection   x:collection1]
>>> o.a.s.s.IndexSchema unique key field: id
>>>    [junit4]   2> 1118332 WARN
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection   x:collection1]
>>> o.a.s.s.IndexSchema Field lowerfilt1and2 is not multivalued and destination
>>> for multiple copyFields (2)
>>>    [junit4]   2> 1118332 WARN
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection   x:collection1]
>>> o.a.s.s.IndexSchema Field text is not multivalued and destination for
>>> multiple copyFields (3)
>>>    [junit4]   2> 1118333 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection   x:collection1]
>>> o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration
>>> from collection control_collection
>>>    [junit4]   2> 1118333 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
>>>    [junit4]   2> 1118333 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
>>> [/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/control-001/cores/collection1/],
>>> dataDir=[null]
>>>    [junit4]   2> 1118333 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core:
>>> collection1
>>>    [junit4]   2> 1118334 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/control-001/cores/collection1/data
>>>    [junit4]   2> 1118334 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.c.SolrCore New index directory detected: old=null
>>> new=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/control-001/cores/collection1/data/index/
>>>    [junit4]   2> 1118334 WARN
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory
>>> '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/control-001/cores/collection1/data/index'
>>> doesn't exist. Creating new index...
>>>    [junit4]   2> 1118334 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/control-001/cores/collection1/data/index
>>>    [junit4]   2> 1118334 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
>>>    [junit4]   2>
>>> commit{dir=MockDirectoryWrapper(RAMDirectory@503bd872
>>> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@64e2319f
>>> ),segFN=segments_1,generation=1}
>>>    [junit4]   2> 1118335 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.c.SolrCore newest commit generation = 1
>>>    [junit4]   2> 1118335 INFO
>>> (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:49573_rd%2Fi
>>> c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore
>>> Looking for old index directories to cleanup for core collection1 in
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/control-001/cores/collection1/data/
>>>    [junit4]   2> 1118336 WARN
>>> (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:49573_rd%2Fi
>>> c:control_collection s:shard1 r:core_node1 x:collection1]
>>> o.a.s.c.DirectoryFactory
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/control-001/cores/collection1/data/
>>> does not point to a valid data directory; skipping clean-up of old index
>>> directories.
>>>    [junit4]   2> 1118338 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as
>>> default, creating implicit default
>>>    [junit4]   2> 1118344 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
>>>    [junit4]   2> 1118345 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
>>>    [junit4]   2> 1118346 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
>>>    [junit4]   2> 1118348 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
>>>    [junit4]   2> 1118348 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.c.PluginBag requestHandler : '/replication' created
>>> with startup=lazy
>>>    [junit4]   2> 1118408 WARN
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.c.SolrResourceLoader Solr loaded a deprecated
>>> plugin/analysis class [org.apache.solr.handler.admin.AdminHandlers]. Please
>>> consult documentation how to replace it accordingly.
>>>    [junit4]   2> 1118408 WARN
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.c.SolrResourceLoader Solr loaded a deprecated
>>> plugin/analysis class [org.apache.solr.handler.admin.AdminHandlers]. Please
>>> consult documentation how to replace it accordingly.
>>>    [junit4]   2> 1118409 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.c.RequestHandlers Registered paths:
>>> /admin/mbeans,standard,,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/update/csv,/sql,/admin/segments,/admin/system,/replication,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin,/admin/ping,/update,/admin/file
>>>    [junit4]   2> 1118409 WARN
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.c.RequestHandlers no default request handler is
>>> registered (either '/select' or 'standard')
>>>    [junit4]   2> 1118410 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.c.SolrCore Using default statsCache cache:
>>> org.apache.solr.search.stats.LocalStatsCache
>>>    [junit4]   2> 1118412 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
>>> org.apache.solr.update.UpdateLog
>>>    [junit4]   2> 1118412 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
>>> defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
>>> numVersionBuckets=65536
>>>    [junit4]   2> 1118415 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
>>>    [junit4]   2> 1118415 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
>>>    [junit4]   2> 1118415 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
>>>    [junit4]   2>
>>> commit{dir=MockDirectoryWrapper(RAMDirectory@503bd872
>>> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@64e2319f
>>> ),segFN=segments_1,generation=1}
>>>    [junit4]   2> 1118415 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.c.SolrCore newest commit generation = 1
>>>    [junit4]   2> 1118416 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@1c32bd73[collection1]
>>> main
>>>    [junit4]   2> 1118416 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.c.c.ZkStateReader Load collection config
>>> from:/collections/control_collection
>>>    [junit4]   2> 1118418 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.c.c.ZkStateReader path=/collections/control_collection
>>> configName=conf1 specified config exists in ZooKeeper
>>>    [junit4]   2> 1118418 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.r.ManagedResourceStorage Setting up ZooKeeper-based
>>> storage for the RestManager with znodeBase: /configs/conf1
>>>    [junit4]   2> 1118419 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO
>>> with znodeBase: /configs/conf1
>>>    [junit4]   2> 1118419 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs:
>>> {}
>>>    [junit4]   2> 1118419 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json
>>> using ZooKeeperStorageIO:path=/configs/conf1
>>>    [junit4]   2> 1118420 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.r.ManagedResourceStorage No data found for znode
>>> /configs/conf1/_rest_managed.json
>>>    [junit4]   2> 1118420 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.r.ManagedResourceStorage Loaded null at path
>>> _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
>>>    [junit4]   2> 1118420 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.r.RestManager Initializing 0 registered
>>> ManagedResources
>>>    [junit4]   2> 1118431 WARN
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.h.a.AdminHandlers <requestHandler name="/admin/"
>>>    [junit4]   2>  class="solr.admin.AdminHandlers" /> is deprecated . It
>>> is not required anymore
>>>    [junit4]   2> 1118431 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to
>>> seed version buckets
>>>    [junit4]   2> 1118432 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_
>>> for 65536 version buckets from index
>>>    [junit4]   2> 1118432 INFO
>>> (searcherExecutor-2741-thread-1-processing-n:127.0.0.1:49573_rd%2Fi
>>> x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49573_rd%2Fi
>>> c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore
>>> [collection1] Registered new searcher Searcher@1c32bd73[collection1]
>>> main{ExitableDirectoryReader(UninvertingDirectoryReader())}
>>>    [junit4]   2> 1118432 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot
>>> seed version bucket highest value from index
>>>    [junit4]   2> 1118432 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.u.UpdateLog Could not find max version in index or
>>> recent updates, using new clock 1505503890026528768
>>>    [junit4]   2> 1118434 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.u.UpdateLog Took 2 ms to seed version buckets with
>>> highest version 1505503890026528768
>>>    [junit4]   2> 1118434 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1
>>>    [junit4]   2> 1118435 INFO
>>> (coreLoadExecutor-2740-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi c:control_collection s:shard1 r:core_node1
>>> x:collection1] o.a.s.c.CoreContainer registering core: collection1
>>>    [junit4]   2> 1118436 INFO
>>> (coreZkRegister-2734-thread-1-processing-n:127.0.0.1:49573_rd%2Fi
>>> x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49573_rd%2Fi
>>> c:control_collection s:shard1 r:core_node1 x:collection1]
>>> o.a.s.c.ZkController Register replica - core:collection1 address:
>>> http://127.0.0.1:49573/rd/i collection:control_collection shard:shard1
>>>    [junit4]   2> 1118438 INFO
>>> (coreZkRegister-2734-thread-1-processing-n:127.0.0.1:49573_rd%2Fi
>>> x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49573_rd%2Fi
>>> c:control_collection s:shard1 r:core_node1 x:collection1]
>>> o.a.s.c.c.SolrZkClient makePath:
>>> /collections/control_collection/leader_elect/shard1/election
>>>    [junit4]   2> 1118447 INFO
>>> (coreZkRegister-2734-thread-1-processing-n:127.0.0.1:49573_rd%2Fi
>>> x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49573_rd%2Fi
>>> c:control_collection s:shard1 r:core_node1 x:collection1]
>>> o.a.s.c.LeaderElector Joined leadership election with path:
>>> /collections/control_collection/leader_elect/shard1/election/94093993000632323-core_node1-n_0000000000
>>>    [junit4]   2> 1118450 INFO
>>> (coreZkRegister-2734-thread-1-processing-n:127.0.0.1:49573_rd%2Fi
>>> x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49573_rd%2Fi
>>> c:control_collection s:shard1 r:core_node1 x:collection1]
>>> o.a.s.c.ShardLeaderElectionContext Running the leader process for shard
>>> shard1
>>>    [junit4]   2> 1118452 INFO
>>> (zkCallback-791-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi    ] o.a.s.c.DistributedQueue
>>> NodeChildrenChanged fired on path /overseer/queue state SyncConnected
>>>    [junit4]   2> 1118453 INFO
>>> (coreZkRegister-2734-thread-1-processing-n:127.0.0.1:49573_rd%2Fi
>>> x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49573_rd%2Fi
>>> c:control_collection s:shard1 r:core_node1 x:collection1]
>>> o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
>>>    [junit4]   2> 1118453 INFO
>>> (coreZkRegister-2734-thread-1-processing-n:127.0.0.1:49573_rd%2Fi
>>> x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49573_rd%2Fi
>>> c:control_collection s:shard1 r:core_node1 x:collection1]
>>> o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
>>>    [junit4]   2> 1118453 INFO
>>> (coreZkRegister-2734-thread-1-processing-n:127.0.0.1:49573_rd%2Fi
>>> x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49573_rd%2Fi
>>> c:control_collection s:shard1 r:core_node1 x:collection1]
>>> o.a.s.c.SyncStrategy Sync replicas to
>>> http://127.0.0.1:49573/rd/i/collection1/
>>>    [junit4]   2> 1118454 INFO
>>> (coreZkRegister-2734-thread-1-processing-n:127.0.0.1:49573_rd%2Fi
>>> x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49573_rd%2Fi
>>> c:control_collection s:shard1 r:core_node1 x:collection1]
>>> o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
>>>    [junit4]   2> 1118454 INFO
>>> (coreZkRegister-2734-thread-1-processing-n:127.0.0.1:49573_rd%2Fi
>>> x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49573_rd%2Fi
>>> c:control_collection s:shard1 r:core_node1 x:collection1]
>>> o.a.s.c.SyncStrategy http://127.0.0.1:49573/rd/i/collection1/ has no
>>> replicas
>>>    [junit4]   2> 1118455 INFO
>>> (coreZkRegister-2734-thread-1-processing-n:127.0.0.1:49573_rd%2Fi
>>> x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49573_rd%2Fi
>>> c:control_collection s:shard1 r:core_node1 x:collection1]
>>> o.a.s.c.ShardLeaderElectionContext I am the new leader:
>>> http://127.0.0.1:49573/rd/i/collection1/ shard1
>>>    [junit4]   2> 1118455 INFO
>>> (coreZkRegister-2734-thread-1-processing-n:127.0.0.1:49573_rd%2Fi
>>> x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49573_rd%2Fi
>>> c:control_collection s:shard1 r:core_node1 x:collection1]
>>> o.a.s.c.c.SolrZkClient makePath:
>>> /collections/control_collection/leaders/shard1
>>>    [junit4]   2> 1118455 INFO
>>> (OverseerStateUpdate-94093993000632323-127.0.0.1:49573_rd%2Fi-n_0000000000)
>>> [n:127.0.0.1:49573_rd%2Fi    ] o.a.s.c.Overseer processMessage:
>>> queueSize: 1, message = {
>>>    [junit4]   2>   "operation":"leader",
>>>    [junit4]   2>   "shard":"shard1",
>>>    [junit4]   2>   "collection":"control_collection"} current state
>>> version: 1
>>>    [junit4]   2> 1118464 INFO
>>> (zkCallback-791-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi    ] o.a.s.c.DistributedQueue
>>> NodeChildrenChanged fired on path /overseer/queue state SyncConnected
>>>    [junit4]   2> 1118467 INFO
>>> (OverseerStateUpdate-94093993000632323-127.0.0.1:49573_rd%2Fi-n_0000000000)
>>> [n:127.0.0.1:49573_rd%2Fi    ] o.a.s.c.Overseer processMessage:
>>> queueSize: 1, message = {
>>>    [junit4]   2>   "operation":"leader",
>>>    [junit4]   2>   "shard":"shard1",
>>>    [junit4]   2>   "collection":"control_collection",
>>>    [junit4]   2>   "base_url":"http://127.0.0.1:49573/rd/i",
>>>    [junit4]   2>   "core":"collection1",
>>>    [junit4]   2>   "state":"active"} current state version: 1
>>>    [junit4]   2> 1118575 INFO
>>> (zkCallback-791-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi    ] o.a.s.c.c.ZkStateReader A cluster state
>>> change: WatchedEvent state:SyncConnected type:NodeDataChanged
>>> path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
>>>    [junit4]   2> 1118579 INFO
>>> (zkCallback-791-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi    ] o.a.s.c.c.ZkStateReader Updated cluster
>>> state version to 2
>>>    [junit4]   2> 1118621 INFO
>>> (coreZkRegister-2734-thread-1-processing-n:127.0.0.1:49573_rd%2Fi
>>> x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49573_rd%2Fi
>>> c:control_collection s:shard1 r:core_node1 x:collection1]
>>> o.a.s.c.ZkController We are http://127.0.0.1:49573/rd/i/collection1/
>>> and leader is http://127.0.0.1:49573/rd/i/collection1/
>>>    [junit4]   2> 1118621 INFO
>>> (coreZkRegister-2734-thread-1-processing-n:127.0.0.1:49573_rd%2Fi
>>> x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49573_rd%2Fi
>>> c:control_collection s:shard1 r:core_node1 x:collection1]
>>> o.a.s.c.ZkController No LogReplay needed for core=collection1 baseURL=
>>> http://127.0.0.1:49573/rd/i
>>>    [junit4]   2> 1118621 INFO
>>> (coreZkRegister-2734-thread-1-processing-n:127.0.0.1:49573_rd%2Fi
>>> x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49573_rd%2Fi
>>> c:control_collection s:shard1 r:core_node1 x:collection1]
>>> o.a.s.c.ZkController I am the leader, no recovery necessary
>>>    [junit4]   2> 1118621 INFO
>>> (coreZkRegister-2734-thread-1-processing-n:127.0.0.1:49573_rd%2Fi
>>> x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49573_rd%2Fi
>>> c:control_collection s:shard1 r:core_node1 x:collection1]
>>> o.a.s.c.ZkController publishing state=active
>>>    [junit4]   2> 1118621 INFO
>>> (coreZkRegister-2734-thread-1-processing-n:127.0.0.1:49573_rd%2Fi
>>> x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49573_rd%2Fi
>>> c:control_collection s:shard1 r:core_node1 x:collection1]
>>> o.a.s.c.ZkController numShards not found on descriptor - reading it from
>>> system property
>>>    [junit4]   2> 1118623 INFO
>>> (zkCallback-791-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi    ] o.a.s.c.DistributedQueue
>>> NodeChildrenChanged fired on path /overseer/queue state SyncConnected
>>>    [junit4]   2> 1118625 INFO
>>> (OverseerStateUpdate-94093993000632323-127.0.0.1:49573_rd%2Fi-n_0000000000)
>>> [n:127.0.0.1:49573_rd%2Fi    ] o.a.s.c.Overseer processMessage:
>>> queueSize: 1, message = {
>>>    [junit4]   2>   "core":"collection1",
>>>    [junit4]   2>   "core_node_name":"core_node1",
>>>    [junit4]   2>   "roles":null,
>>>    [junit4]   2>   "base_url":"http://127.0.0.1:49573/rd/i",
>>>    [junit4]   2>   "node_name":"127.0.0.1:49573_rd%2Fi",
>>>    [junit4]   2>   "numShards":"1",
>>>    [junit4]   2>   "state":"active",
>>>    [junit4]   2>   "shard":"shard1",
>>>    [junit4]   2>   "collection":"control_collection",
>>>    [junit4]   2>   "operation":"state"} current state version: 2
>>>    [junit4]   2> 1118626 INFO
>>> (OverseerStateUpdate-94093993000632323-127.0.0.1:49573_rd%2Fi-n_0000000000)
>>> [n:127.0.0.1:49573_rd%2Fi    ] o.a.s.c.o.ReplicaMutator Update state
>>> numShards=1 message={
>>>    [junit4]   2>   "core":"collection1",
>>>    [junit4]   2>   "core_node_name":"core_node1",
>>>    [junit4]   2>   "roles":null,
>>>    [junit4]   2>   "base_url":"http://127.0.0.1:49573/rd/i",
>>>    [junit4]   2>   "node_name":"127.0.0.1:49573_rd%2Fi",
>>>    [junit4]   2>   "numShards":"1",
>>>    [junit4]   2>   "state":"active",
>>>    [junit4]   2>   "shard":"shard1",
>>>    [junit4]   2>   "collection":"control_collection",
>>>    [junit4]   2>   "operation":"state"}
>>>    [junit4]   2> 1118733 INFO
>>> (zkCallback-791-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi    ] o.a.s.c.c.ZkStateReader A cluster state
>>> change: WatchedEvent state:SyncConnected type:NodeDataChanged
>>> path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
>>>    [junit4]   2> 1118736 INFO
>>> (zkCallback-791-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi    ] o.a.s.c.c.ZkStateReader Updated cluster
>>> state version to 3
>>>    [junit4]   2> 1118746 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
>>>    [junit4]   2> 1118747 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
>>>    [junit4]   2> 1118749 INFO  (zkCallback-793-thread-1) [    ]
>>> o.a.s.c.c.ConnectionManager Watcher
>>> org.apache.solr.common.cloud.ConnectionManager@3844969
>>> name:ZooKeeperConnection Watcher:127.0.0.1:49569/solr got event
>>> WatchedEvent state:SyncConnected type:None path:null path:null type:None
>>>    [junit4]   2> 1118750 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
>>>    [junit4]   2> 1118750 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.SolrZkClient Using default ZkACLProvider
>>>    [junit4]   2> 1118750 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
>>>    [junit4]   2> 1118756 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection
>>> loss:false
>>>    [junit4]   2> 1119095 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.SolrTestCaseJ4 Writing core.properties file to
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/shard-1-001/cores/collection1
>>>    [junit4]   2> 1119097 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/shard-1-001
>>>    [junit4]   2> 1119098 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ] o.e.j.s.Server
>>> jetty-9.2.11.v20150529
>>>    [junit4]   2> 1119103 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@17f510d7
>>> {/rd/i,null,AVAILABLE}
>>>    [junit4]   2> 1119103 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.e.j.s.ServerConnector Started ServerConnector@5bee5998{HTTP/1.1}{
>>> 127.0.0.1:49579}
>>>    [junit4]   2> 1119103 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ] o.e.j.s.Server
>>> Started @1127774ms
>>>    [junit4]   2> 1119103 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.s.e.JettySolrRunner Jetty properties:
>>> {solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/tempDir-001/jetty1,
>>> solrconfig=solrconfig.xml, hostContext=/rd/i, hostPort=49579,
>>> coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/shard-1-001/cores}
>>>    [junit4]   2> 1119104 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
>>> sun.misc.Launcher$AppClassLoader@74a14482
>>>    [junit4]   2> 1119104 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
>>> '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/shard-1-001/'
>>>    [junit4]   2> 1119134 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.SolrXmlConfig Loading container configuration from
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/shard-1-001/solr.xml
>>>    [junit4]   2> 1119141 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.CoresLocator Config-defined core root directory:
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/shard-1-001/cores
>>>    [junit4]   2> 1119142 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.CoreContainer New CoreContainer 553281600
>>>    [junit4]   2> 1119142 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.CoreContainer Loading cores into CoreContainer
>>> [instanceDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/shard-1-001/]
>>>    [junit4]   2> 1119142 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.CoreContainer loading shared library:
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/shard-1-001/lib
>>>    [junit4]   2> 1119143 WARN
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to
>>> classloader: lib (resolved as:
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/shard-1-001/lib).
>>>    [junit4]   2> 1119157 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout :
>>> 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost :
>>> 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize :
>>> 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy :
>>> false,useRetries : false,
>>>    [junit4]   2> 1119160 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with
>>> params: socketTimeout=340000&connTimeout=45000&retry=true
>>>    [junit4]   2> 1119163 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
>>>    [junit4]   2> 1119163 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.l.LogWatcher Registering Log Listener [Log4j
>>> (org.slf4j.impl.Log4jLoggerFactory)]
>>>    [junit4]   2> 1119163 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:49569/solr
>>>    [junit4]   2> 1119163 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.ZkController zkHost includes chroot
>>>    [junit4]   2> 1119163 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
>>>    [junit4]   2> 1119165 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
>>>    [junit4]   2> 1119167 INFO  (zkCallback-795-thread-1) [    ]
>>> o.a.s.c.c.ConnectionManager Watcher
>>> org.apache.solr.common.cloud.ConnectionManager@7188eb21
>>> name:ZooKeeperConnection Watcher:127.0.0.1:49569 got event WatchedEvent
>>> state:SyncConnected type:None path:null path:null type:None
>>>    [junit4]   2> 1119167 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
>>>    [junit4]   2> 1119168 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.a.s.c.c.SolrZkClient Using default ZkACLProvider
>>>    [junit4]   2> 1119172 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49579_rd%2Fi
>>>   ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
>>>    [junit4]   2> 1119174 INFO
>>> (zkCallback-796-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi    ] o.a.s.c.c.ConnectionManager Watcher
>>> org.apache.solr.common.cloud.ConnectionManager@16c35e98
>>> name:ZooKeeperConnection Watcher:127.0.0.1:49569/solr got event
>>> WatchedEvent state:SyncConnected type:None path:null path:null type:None
>>>    [junit4]   2> 1119174 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49579_rd%2Fi
>>>   ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
>>>    [junit4]   2> 1119184 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49579_rd%2Fi
>>>   ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
>>>    [junit4]   2> 1120197 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49579_rd%2Fi
>>>   ] o.a.s.c.ZkController Register node as live in
>>> ZooKeeper:/live_nodes/127.0.0.1:49579_rd%2Fi
>>>    [junit4]   2> 1120198 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49579_rd%2Fi
>>>   ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:49579_rd%2Fi
>>>    [junit4]   2> 1120206 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49579_rd%2Fi
>>>   ] o.a.s.c.Overseer Overseer (id=null) closing
>>>    [junit4]   2> 1120208 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49579_rd%2Fi
>>>   ] o.a.s.c.LeaderElector Joined leadership election with path:
>>> /overseer_elect/election/94093993000632326-127.0.0.1:49579_rd%2Fi-n_0000000001
>>>    [junit4]   2> 1120209 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49579_rd%2Fi
>>>   ] o.a.s.c.LeaderElector Watching path
>>> /overseer_elect/election/94093993000632323-127.0.0.1:49573_rd%2Fi-n_0000000000
>>> to know if I could be the leader
>>>    [junit4]   2> 1120210 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49579_rd%2Fi
>>>   ] o.a.s.c.CoreContainer No authentication plugin used.
>>>    [junit4]   2> 1120211 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49579_rd%2Fi
>>>   ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for
>>> authorization module.
>>>    [junit4]   2> 1120213 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49579_rd%2Fi
>>>   ] o.a.s.c.CoresLocator Looking for core definitions underneath
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/shard-1-001/cores
>>>    [junit4]   2> 1120215 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49579_rd%2Fi
>>>   ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1,
>>> config=solrconfig.xml, transient=false, schema=schema.xml,
>>> loadOnStartup=true,
>>> instanceDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/shard-1-001/cores/collection1,
>>> collection=collection1,
>>> absoluteInstDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/shard-1-001/cores/collection1/,
>>> coreNodeName=, dataDir=data/, shard=}
>>>    [junit4]   2> 1120215 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49579_rd%2Fi
>>>   ] o.a.s.c.CoresLocator Found core collection1 in
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/shard-1-001/cores/collection1/
>>>    [junit4]   2> 1120215 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49579_rd%2Fi
>>>   ] o.a.s.c.CoresLocator Found 1 core definitions
>>>    [junit4]   2> 1120217 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1   x:collection1]
>>> o.a.s.c.ZkController publishing state=down
>>>    [junit4]   2> 1120218 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1   x:collection1]
>>> o.a.s.c.ZkController numShards not found on descriptor - reading it from
>>> system property
>>>    [junit4]   2> 1120218 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49579_rd%2Fi
>>>   ] o.a.s.s.SolrDispatchFilter
>>> user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1
>>>    [junit4]   2> 1120218 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49579_rd%2Fi
>>>   ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
>>>    [junit4]   2> 1120219 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1   x:collection1]
>>> o.a.s.c.ZkController look for our core node name
>>>    [junit4]   2> 1120220 INFO
>>> (zkCallback-791-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi    ] o.a.s.c.DistributedQueue
>>> NodeChildrenChanged fired on path /overseer/queue state SyncConnected
>>>    [junit4]   2> 1120222 INFO
>>> (OverseerStateUpdate-94093993000632323-127.0.0.1:49573_rd%2Fi-n_0000000000)
>>> [n:127.0.0.1:49573_rd%2Fi    ] o.a.s.c.Overseer processMessage:
>>> queueSize: 1, message = {
>>>    [junit4]   2>   "core":"collection1",
>>>    [junit4]   2>   "roles":null,
>>>    [junit4]   2>   "base_url":"http://127.0.0.1:49579/rd/i",
>>>    [junit4]   2>   "node_name":"127.0.0.1:49579_rd%2Fi",
>>>    [junit4]   2>   "numShards":"2",
>>>    [junit4]   2>   "state":"down",
>>>    [junit4]   2>   "shard":null,
>>>    [junit4]   2>   "collection":"collection1",
>>>    [junit4]   2>   "operation":"state"} current state version: 3
>>>    [junit4]   2> 1120223 INFO
>>> (OverseerStateUpdate-94093993000632323-127.0.0.1:49573_rd%2Fi-n_0000000000)
>>> [n:127.0.0.1:49573_rd%2Fi    ] o.a.s.c.o.ReplicaMutator Update state
>>> numShards=2 message={
>>>    [junit4]   2>   "core":"collection1",
>>>    [junit4]   2>   "roles":null,
>>>    [junit4]   2>   "base_url":"http://127.0.0.1:49579/rd/i",
>>>    [junit4]   2>   "node_name":"127.0.0.1:49579_rd%2Fi",
>>>    [junit4]   2>   "numShards":"2",
>>>    [junit4]   2>   "state":"down",
>>>    [junit4]   2>   "shard":null,
>>>    [junit4]   2>   "collection":"collection1",
>>>    [junit4]   2>   "operation":"state"}
>>>    [junit4]   2> 1120223 INFO
>>> (OverseerStateUpdate-94093993000632323-127.0.0.1:49573_rd%2Fi-n_0000000000)
>>> [n:127.0.0.1:49573_rd%2Fi    ] o.a.s.c.o.ClusterStateMutator building a
>>> new cName: collection1
>>>    [junit4]   2> 1120223 INFO
>>> (OverseerStateUpdate-94093993000632323-127.0.0.1:49573_rd%2Fi-n_0000000000)
>>> [n:127.0.0.1:49573_rd%2Fi    ] o.a.s.c.o.ReplicaMutator Assigning new
>>> node to shard shard=shard2
>>>    [junit4]   2> 1120331 INFO  (zkCallback-793-thread-1) [    ]
>>> o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent
>>> state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has
>>> occurred - updating... (live nodes size: 2)
>>>    [junit4]   2> 1120331 INFO
>>> (zkCallback-796-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi    ] o.a.s.c.c.ZkStateReader A cluster state
>>> change: WatchedEvent state:SyncConnected type:NodeDataChanged
>>> path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
>>>    [junit4]   2> 1120331 INFO
>>> (zkCallback-791-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi    ] o.a.s.c.c.ZkStateReader A cluster state
>>> change: WatchedEvent state:SyncConnected type:NodeDataChanged
>>> path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
>>>    [junit4]   2> 1120335 INFO  (zkCallback-793-thread-1) [    ]
>>> o.a.s.c.c.ZkStateReader Updated cluster state version to 4
>>>    [junit4]   2> 1120335 INFO
>>> (zkCallback-796-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi    ] o.a.s.c.c.ZkStateReader Updated cluster
>>> state version to 4
>>>    [junit4]   2> 1120336 INFO
>>> (zkCallback-791-thread-1-processing-n:127.0.0.1:49573_rd%2Fi)
>>> [n:127.0.0.1:49573_rd%2Fi    ] o.a.s.c.c.ZkStateReader Updated cluster
>>> state version to 4
>>>    [junit4]   2> 1121221 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1   x:collection1]
>>> o.a.s.c.ZkController waiting to find shard id in clusterstate for
>>> collection1
>>>    [junit4]   2> 1121222 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1   x:collection1]
>>> o.a.s.c.ZkController Check for collection zkNode:collection1
>>>    [junit4]   2> 1121222 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1   x:collection1]
>>> o.a.s.c.ZkController Collection zkNode exists
>>>    [junit4]   2> 1121223 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1   x:collection1]
>>> o.a.s.c.c.ZkStateReader Load collection config from:/collections/collection1
>>>    [junit4]   2> 1121224 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1   x:collection1]
>>> o.a.s.c.c.ZkStateReader path=/collections/collection1 configName=conf1
>>> specified config exists in ZooKeeper
>>>    [junit4]   2> 1121224 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1   x:collection1]
>>> o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
>>> '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/shard-1-001/cores/collection1/'
>>>    [junit4]   2> 1121243 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1   x:collection1] o.a.s.c.Config
>>> loaded config solrconfig.xml with version 0
>>>    [junit4]   2> 1121248 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1   x:collection1]
>>> o.a.s.c.SolrConfig current version of requestparams : -1
>>>    [junit4]   2> 1121250 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1   x:collection1]
>>> o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
>>>    [junit4]   2> 1121255 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1   x:collection1] o.a.s.c.Config
>>> Loaded SolrConfig: solrconfig.xml
>>>    [junit4]   2> 1121257 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1   x:collection1]
>>> o.a.s.s.IndexSchema Reading Solr Schema from /configs/conf1/schema.xml
>>>    [junit4]   2> 1121261 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1   x:collection1]
>>> o.a.s.s.IndexSchema [collection1] Schema name=test
>>>    [junit4]   2> 1121323 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1   x:collection1]
>>> o.a.s.s.IndexSchema default search field in schema is text
>>>    [junit4]   2> 1121324 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1   x:collection1]
>>> o.a.s.s.IndexSchema unique key field: id
>>>    [junit4]   2> 1121324 WARN
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1   x:collection1]
>>> o.a.s.s.IndexSchema Field lowerfilt1and2 is not multivalued and destination
>>> for multiple copyFields (2)
>>>    [junit4]   2> 1121325 WARN
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1   x:collection1]
>>> o.a.s.s.IndexSchema Field text is not multivalued and destination for
>>> multiple copyFields (3)
>>>    [junit4]   2> 1121325 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1   x:collection1]
>>> o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration
>>> from collection collection1
>>>    [junit4]   2> 1121325 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
>>>    [junit4]   2> 1121326 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
>>> [/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/shard-1-001/cores/collection1/],
>>> dataDir=[null]
>>>    [junit4]   2> 1121326 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core:
>>> collection1
>>>    [junit4]   2> 1121326 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/shard-1-001/cores/collection1/data
>>>    [junit4]   2> 1121326 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.c.SolrCore New index directory detected: old=null
>>> new=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/shard-1-001/cores/collection1/data/index/
>>>    [junit4]   2> 1121326 WARN
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory
>>> '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/shard-1-001/cores/collection1/data/index'
>>> doesn't exist. Creating new index...
>>>    [junit4]   2> 1121326 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/shard-1-001/cores/collection1/data/index
>>>    [junit4]   2> 1121327 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
>>>    [junit4]   2>
>>> commit{dir=MockDirectoryWrapper(RAMDirectory@4f382ff3
>>> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7f89fe7f
>>> ),segFN=segments_1,generation=1}
>>>    [junit4]   2> 1121327 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.c.SolrCore newest commit generation = 1
>>>    [junit4]   2> 1121328 INFO
>>> (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:49579_rd%2Fi
>>> c:collection1 s:shard2 r:core_node1 x:collection1] o.a.s.c.SolrCore Looking
>>> for old index directories to cleanup for core collection1 in
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/shard-1-001/cores/collection1/data/
>>>    [junit4]   2> 1121329 WARN
>>> (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:49579_rd%2Fi
>>> c:collection1 s:shard2 r:core_node1 x:collection1] o.a.s.c.DirectoryFactory
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/shard-1-001/cores/collection1/data/
>>> does not point to a valid data directory; skipping clean-up of old index
>>> directories.
>>>    [junit4]   2> 1121331 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as
>>> default, creating implicit default
>>>    [junit4]   2> 1121344 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
>>>    [junit4]   2> 1121345 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
>>>    [junit4]   2> 1121348 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
>>>    [junit4]   2> 1121349 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
>>>    [junit4]   2> 1121349 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.c.PluginBag requestHandler : '/replication' created
>>> with startup=lazy
>>>    [junit4]   2> 1121352 WARN
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.c.SolrResourceLoader Solr loaded a deprecated
>>> plugin/analysis class [org.apache.solr.handler.admin.AdminHandlers]. Please
>>> consult documentation how to replace it accordingly.
>>>    [junit4]   2> 1121352 WARN
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.c.SolrResourceLoader Solr loaded a deprecated
>>> plugin/analysis class [org.apache.solr.handler.admin.AdminHandlers]. Please
>>> consult documentation how to replace it accordingly.
>>>    [junit4]   2> 1121352 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.c.RequestHandlers Registered paths:
>>> /admin/mbeans,standard,,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/update/csv,/sql,/admin/segments,/admin/system,/replication,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin,/admin/ping,/update,/admin/file
>>>    [junit4]   2> 1121352 WARN
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.c.RequestHandlers no default request handler is
>>> registered (either '/select' or 'standard')
>>>    [junit4]   2> 1121353 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.c.SolrCore Using default statsCache cache:
>>> org.apache.solr.search.stats.LocalStatsCache
>>>    [junit4]   2> 1121354 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
>>> org.apache.solr.update.UpdateLog
>>>    [junit4]   2> 1121354 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
>>> defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
>>> numVersionBuckets=65536
>>>    [junit4]   2> 1121355 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
>>>    [junit4]   2> 1121355 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
>>>    [junit4]   2> 1121356 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
>>>    [junit4]   2>
>>> commit{dir=MockDirectoryWrapper(RAMDirectory@4f382ff3
>>> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7f89fe7f
>>> ),segFN=segments_1,generation=1}
>>>    [junit4]   2> 1121356 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.c.SolrCore newest commit generation = 1
>>>    [junit4]   2> 1121356 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@4f994aaf[collection1]
>>> main
>>>    [junit4]   2> 1121356 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.c.c.ZkStateReader Load collection config
>>> from:/collections/collection1
>>>    [junit4]   2> 1121358 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.c.c.ZkStateReader path=/collections/collection1
>>> configName=conf1 specified config exists in ZooKeeper
>>>    [junit4]   2> 1121358 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.r.ManagedResourceStorage Setting up ZooKeeper-based
>>> storage for the RestManager with znodeBase: /configs/conf1
>>>    [junit4]   2> 1121359 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO
>>> with znodeBase: /configs/conf1
>>>    [junit4]   2> 1121359 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs:
>>> {}
>>>    [junit4]   2> 1121359 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json
>>> using ZooKeeperStorageIO:path=/configs/conf1
>>>    [junit4]   2> 1121360 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.r.ManagedResourceStorage No data found for znode
>>> /configs/conf1/_rest_managed.json
>>>    [junit4]   2> 1121360 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.r.ManagedResourceStorage Loaded null at path
>>> _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
>>>    [junit4]   2> 1121360 INFO
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.r.RestManager Initializing 0 registered
>>> ManagedResources
>>>    [junit4]   2> 1121361 WARN
>>> (coreLoadExecutor-2750-thread-1-processing-n:127.0.0.1:49579_rd%2Fi)
>>> [n:127.0.0.1:49579_rd%2Fi c:collection1 s:shard2 r:core_node1
>>> x:collection1] o.a.s.h.a.AdminHandlers <
>>>
>>> [...truncated too long message...]
>>>
>>> ndler.TestSQLHandler_C5ED92674EE29591-001/shard-4-001/cores/collection1/data
>>> [CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/shard-4-001/cores/collection1/data;done=false>>]
>>>    [junit4]   2> 1141546 INFO
>>> (zkCallback-806-thread-2-processing-n:127.0.0.1:49619_rd%2Fi)
>>> [n:127.0.0.1:49619_rd%2Fi c:collection1 s:shard1 r:core_node4
>>> x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory:
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/shard-4-001/cores/collection1/data
>>>    [junit4]   2> 1141546 INFO
>>> (zkCallback-806-thread-2-processing-n:127.0.0.1:49619_rd%2Fi)
>>> [n:127.0.0.1:49619_rd%2Fi c:collection1 s:shard1 r:core_node4
>>> x:collection1] o.a.s.c.CachingDirectoryFactory looking to close
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/shard-4-001/cores/collection1/data/index.20150701222013213
>>> [CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/shard-4-001/cores/collection1/data/index.20150701222013213;done=false>>]
>>>    [junit4]   2> 1141546 INFO
>>> (zkCallback-806-thread-2-processing-n:127.0.0.1:49619_rd%2Fi)
>>> [n:127.0.0.1:49619_rd%2Fi c:collection1 s:shard1 r:core_node4
>>> x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory:
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001/shard-4-001/cores/collection1/data/index.20150701222013213
>>>    [junit4]   2> 1142086 WARN
>>> (zkCallback-806-thread-3-processing-n:127.0.0.1:49619_rd%2Fi)
>>> [n:127.0.0.1:49619_rd%2Fi    ] o.a.s.c.c.ZkStateReader ZooKeeper watch
>>> triggered, but Solr cannot talk to ZK
>>>    [junit4]   2> 1142098 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.e.j.s.ServerConnector Stopped ServerConnector@51cb0eeb{HTTP/1.1}{
>>> 127.0.0.1:0}
>>>    [junit4]   2> 1142098 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [    ]
>>> o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@5db9c22c
>>> {/rd/i,null,UNAVAILABLE}
>>>    [junit4]   2> 1142101 INFO
>>> (TEST-TestSQLHandler.doTest-seed#[C5ED92674EE29591]) [n:127.0.0.1:49619_rd%2Fi
>>> c:collection1 s:shard1 r:core_node4 x:collection1] o.a.s.c.ZkTestServer
>>> connecting to 127.0.0.1:49569 49569
>>>    [junit4]   2> 1142112 INFO  (Thread-2366) [    ] o.a.s.c.ZkTestServer
>>> connecting to 127.0.0.1:49569 49569
>>>    [junit4]   2> 1142981 WARN  (Thread-2366) [    ] o.a.s.c.ZkTestServer
>>> Watch limit violations:
>>>    [junit4]   2> Maximum concurrent create/delete watches above limit:
>>>    [junit4]   2>
>>>    [junit4]   2>        7       /solr/aliases.json
>>>    [junit4]   2>        7       /solr/clusterstate.json
>>>    [junit4]   2>        5       /solr/configs/conf1
>>>    [junit4]   2>
>>>    [junit4]   2> Maximum concurrent children watches above limit:
>>>    [junit4]   2>
>>>    [junit4]   2>        7       /solr/live_nodes
>>>    [junit4]   2>        3       /solr/overseer/queue
>>>    [junit4]   2>        3       /solr/overseer/collection-queue-work
>>>    [junit4]   2>
>>>    [junit4]   2> NOTE: reproduce with: ant test
>>> -Dtestcase=TestSQLHandler -Dtests.method=doTest
>>> -Dtests.seed=C5ED92674EE29591 -Dtests.slow=true -Dtests.locale=zh_TW
>>> -Dtests.timezone=Asia/Chongqing -Dtests.asserts=true
>>> -Dtests.file.encoding=ISO-8859-1
>>>    [junit4] ERROR   26.6s J1 | TestSQLHandler.doTest <<<
>>>    [junit4]    > Throwable #1: java.io.IOException: JSONTupleStream:
>>> expected ARRAY_START but got EOF
>>>    [junit4]    >        at
>>> __randomizedtesting.SeedInfo.seed([C5ED92674EE29591:62A92AC323598628]:0)
>>>    [junit4]    >        at
>>> org.apache.solr.client.solrj.io.stream.JSONTupleStream.expect(JSONTupleStream.java:99)
>>>    [junit4]    >        at
>>> org.apache.solr.client.solrj.io.stream.JSONTupleStream.advanceToDocs(JSONTupleStream.java:159)
>>>    [junit4]    >        at
>>> org.apache.solr.client.solrj.io.stream.JSONTupleStream.next(JSONTupleStream.java:77)
>>>    [junit4]    >        at
>>> org.apache.solr.client.solrj.io.stream.SolrStream.read(SolrStream.java:149)
>>>    [junit4]    >        at
>>> org.apache.solr.handler.TestSQLHandler.getTuples(TestSQLHandler.java:833)
>>>    [junit4]    >        at
>>> org.apache.solr.handler.TestSQLHandler.testTimeSeriesGrouping(TestSQLHandler.java:613)
>>>    [junit4]    >        at
>>> org.apache.solr.handler.TestSQLHandler.doTest(TestSQLHandler.java:92)
>>>    [junit4]    >        at
>>> org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:960)
>>>    [junit4]    >        at
>>> org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:935)
>>>    [junit4]    >        at java.lang.Thread.run(Thread.java:745)
>>>    [junit4]   2> 1143063 INFO
>>> (SUITE-TestSQLHandler-seed#[C5ED92674EE29591]-worker) [n:127.0.0.1:49619_rd%2Fi
>>> c:collection1 s:shard1 r:core_node4 x:collection1] o.a.s.SolrTestCaseJ4
>>> ###deleteCore
>>>    [junit4]   2> NOTE: leaving temporary files on disk at:
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestSQLHandler_C5ED92674EE29591-001
>>>    [junit4]   2> NOTE: test params are: codec=Asserting(Lucene53):
>>> {item_i=PostingsFormat(name=Memory doPackFST= true), n_l1=FST50,
>>> multiDefault=FST50, intDefault=PostingsFormat(name=Asserting), day_i=FST50,
>>> n_dt1=PostingsFormat(name=Asserting), n_td1=PostingsFormat(name=Asserting),
>>> n_d1=FST50, field_i=FST50, str_s=PostingsFormat(name=Memory doPackFST=
>>> true), n_f1=PostingsFormat(name=Asserting),
>>> n_ti1=PostingsFormat(name=MockRandom),
>>> year_i=PostingsFormat(name=MockRandom),
>>> rnd_b=PostingsFormat(name=MockRandom),
>>> n_tl1=PostingsFormat(name=Asserting),
>>> _version_=PostingsFormat(name=Asserting), n_tf1=FST50,
>>> n_tdt1=PostingsFormat(name=Asserting), id=PostingsFormat(name=MockRandom),
>>> text=PostingsFormat(name=Memory doPackFST= true), timestamp=FST50,
>>> month_i=FST50}, docValues:{year_i=DocValuesFormat(name=Asserting),
>>> item_i=DocValuesFormat(name=Memory),
>>> multiDefault=DocValuesFormat(name=Direct),
>>> intDefault=DocValuesFormat(name=Lucene50),
>>> day_i=DocValuesFormat(name=Direct), id=DocValuesFormat(name=Asserting),
>>> field_i=DocValuesFormat(name=Direct), str_s=DocValuesFormat(name=Memory),
>>> n_f1=DocValuesFormat(name=Lucene50), month_i=DocValuesFormat(name=Direct)},
>>> sim=RandomSimilarityProvider(queryNorm=false,coord=yes): {}, locale=zh_TW,
>>> timezone=Asia/Chongqing
>>>    [junit4]   2> NOTE: Mac OS X 10.8.5 x86_64/Oracle Corporation
>>> 1.8.0_45 (64-bit)/cpus=3,threads=1,free=73195064,total=396361728
>>>    [junit4]   2> NOTE: All tests run in this JVM: [TestRTGBase,
>>> TestHashQParserPlugin, TestDistributedGrouping, JavabinLoaderTest,
>>> DebugComponentTest, BaseCdcrDistributedZkTest, CdcrVersionReplicationTest,
>>> ShardRoutingCustomTest, FileBasedSpellCheckerTest, TestReload,
>>> OverseerStatusTest, TestTrie, BasicFunctionalityTest, DateMathParserTest,
>>> TestManagedSynonymFilterFactory, DistributedDebugComponentTest,
>>> TestPseudoReturnFields, BadCopyFieldTest, TestFileDictionaryLookup,
>>> CollectionsAPIDistributedZkTest, ResourceLoaderTest, CleanupOldIndexTest,
>>> PolyFieldTest, FileUtilsTest, LeaderElectionIntegrationTest,
>>> TestSolrCoreProperties, TestFuzzyAnalyzedSuggestions,
>>> SaslZkACLProviderTest, TestQuerySenderNoQuery,
>>> DistributedFacetPivotWhiteBoxTest, TestValueSourceCache,
>>> HdfsRecoverLeaseTest, RecoveryAfterSoftCommitTest, SolrIndexConfigTest,
>>> SmileWriterTest, SuggesterTSTTest, TestDefaultSimilarityFactory,
>>> TestOrdValues, SharedFSAutoReplicaFailoverUtilsTest, EchoParamsTest,
>>> TestCloudManagedSchema, TestStandardQParsers,
>>> TestReversedWildcardFilterFactory, QueryResultKeyTest, SpatialFilterTest,
>>> ChangedSchemaMergeTest, TestAuthenticationFramework,
>>> TestBlendedInfixSuggestions, EnumFieldTest, TestSolrXml,
>>> TestExactStatsCache, MoreLikeThisHandlerTest, TestRangeQuery,
>>> TestRandomFaceting, TestSolrDynamicMBean, TestSolrCloudWithKerberosAlt,
>>> IndexSchemaTest, TestSolrQueryParserDefaultOperatorResource,
>>> TestRecoveryHdfs, DistributedQueryComponentOptimizationTest, DateFieldTest,
>>> MBeansHandlerTest, ConvertedLegacyTest, DistributedMLTComponentTest,
>>> TestSolrConfigHandlerConcurrent, TestDefaultStatsCache,
>>> WordBreakSolrSpellCheckerTest, TestPHPSerializedResponseWriter,
>>> TestReplicaProperties, InfoHandlerTest, TestTrieFacet,
>>> BasicDistributedZk2Test, PluginInfoTest, CSVRequestHandlerTest,
>>> ChaosMonkeySafeLeaderTest, TestSchemaManager,
>>> TestSimpleTrackingShardHandler, ZkNodePropsTest, TestRebalanceLeaders,
>>> BinaryUpdateRequestHandlerTest, CoreAdminCreateDiscoverTest,
>>> AliasIntegrationTest, DisMaxRequestHandlerTest, SimplePostToolTest,
>>> TestZkChroot, TestSQLHandler]
>>>    [junit4] Completed [156/514] on J1 in 26.60s, 1 test, 1 error <<<
>>> FAILURES!
>>>
>>> [...truncated 1131 lines...]
>>> BUILD FAILED
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:526: The
>>> following error occurred while executing this line:
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:474: The
>>> following error occurred while executing this line:
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:61: The
>>> following error occurred while executing this line:
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/extra-targets.xml:39:
>>> The following error occurred while executing this line:
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build.xml:230:
>>> The following error occurred while executing this line:
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/common-build.xml:513:
>>> The following error occurred while executing this line:
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:1426:
>>> The following error occurred while executing this line:
>>> /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:981:
>>> There were test failures: 514 suites, 2021 tests, 1 error, 64 ignored (24
>>> assumptions)
>>>
>>> Total time: 73 minutes 28 seconds
>>> Build step 'Invoke Ant' marked build as failure
>>> Archiving artifacts
>>> Recording test results
>>> Email was triggered for: Failure - Any
>>> Sending email for trigger: Failure - Any
>>>
>>>
>>>
>>>
>>> ---------------------------------------------------------------------
>>> To unsubscribe, e-mail: dev-unsubscribe@lucene.apache.org
>>> For additional commands, e-mail: dev-help@lucene.apache.org
>>>
>>
>>
>

Mime
View raw message