Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-master/952/
2 tests failed.
FAILED: org.apache.solr.handler.TestReqParamsAPI.test
Error Message:
Could not get expected value 'CY val' for path 'response/params/y/c' full
output: { "responseHeader":{ "status":0, "QTime":0}, "response":{
"znodeVersion":0, "params":{"x":{ "a":"A val", "b":"B
val", "":{"v":0}}}}}
Stack Trace:
java.lang.AssertionError: Could not get expected value 'CY val' for path
'response/params/y/c' full output: {
"responseHeader":{
"status":0,
"QTime":0},
"response":{
"znodeVersion":0,
"params":{"x":{
"a":"A val",
"b":"B val",
"":{"v":0}}}}}
at
__randomizedtesting.SeedInfo.seed([9E761808F3733B3B:162227D25D8F56C3]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at
org.apache.solr.core.TestSolrConfigHandler.testForResponseElement(TestSolrConfigHandler.java:458)
at
org.apache.solr.handler.TestReqParamsAPI.testReqParams(TestReqParamsAPI.java:165)
at
org.apache.solr.handler.TestReqParamsAPI.test(TestReqParamsAPI.java:67)
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:1764)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:996)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:971)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at java.lang.Thread.run(Thread.java:745)
FAILED: org.apache.solr.cloud.UnloadDistributedZkTest.test
Error Message:
Captured an uncaught exception in thread: Thread[id=2614,
name=testExecutor-1092-thread-14, state=RUNNABLE,
group=TGRP-UnloadDistributedZkTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught
exception in thread: Thread[id=2614, name=testExecutor-1092-thread-14,
state=RUNNABLE, group=TGRP-UnloadDistributedZkTest]
Caused by: java.lang.RuntimeException:
org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting
response from server at: http://127.0.0.1:34282
at __randomizedtesting.SeedInfo.seed([9E761808F3733B3B]:0)
at
org.apache.solr.cloud.BasicDistributedZkTest.lambda$createCores$3(BasicDistributedZkTest.java:583)
at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$6(ExecutorUtil.java:229)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occured
while waiting response from server at: http://127.0.0.1:34282
at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:588)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230)
at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
at
org.apache.solr.cloud.BasicDistributedZkTest.lambda$createCores$3(BasicDistributedZkTest.java:581)
... 4 more
Caused by: java.net.SocketTimeoutException: Read timed out
at java.net.SocketInputStream.socketRead0(Native Method)
at java.net.SocketInputStream.socketRead(SocketInputStream.java:116)
at java.net.SocketInputStream.read(SocketInputStream.java:170)
at java.net.SocketInputStream.read(SocketInputStream.java:141)
at
org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160)
at
org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84)
at
org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273)
at
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140)
at
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
at
org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261)
at
org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283)
at
org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251)
at
org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197)
at
org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272)
at
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124)
at
org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685)
at
org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487)
at
org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882)
at
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
at
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107)
at
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:482)
... 8 more
Build Log:
[...truncated 11125 lines...]
[junit4] Suite: org.apache.solr.handler.TestReqParamsAPI
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/init-core-data-001
[junit4] 2> 246940 INFO
(SUITE-TestReqParamsAPI-seed#[9E761808F3733B3B]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true)
[junit4] 2> 246940 INFO
(SUITE-TestReqParamsAPI-seed#[9E761808F3733B3B]-worker) [ ]
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
[junit4] 2> 246950 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 246951 INFO (Thread-690) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 246951 INFO (Thread-690) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 247051 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.ZkTestServer start zk server on port:40331
[junit4] 2> 247051 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 247052 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 247067 INFO (zkCallback-93-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@7f027f6d
name:ZooKeeperConnection Watcher:127.0.0.1:40331 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 247067 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 247067 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 247067 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 247078 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 247079 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 247082 INFO (zkCallback-94-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@3cb9014 name:ZooKeeperConnection
Watcher:127.0.0.1:40331/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 247082 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 247082 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 247082 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/collection1
[junit4] 2> 247084 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
[junit4] 2> 247086 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
[junit4] 2> 247087 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
[junit4] 2> 247091 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 247091 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
[junit4] 2> 247093 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 247093 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
[junit4] 2> 247095 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 247095 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 247096 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 247097 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
[junit4] 2> 247098 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 247098 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
[junit4] 2> 247099 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 247099 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
[junit4] 2> 247101 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 247101 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
[junit4] 2> 247102 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 247102 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
[junit4] 2> 247104 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 247104 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 247105 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 247106 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
[junit4] 2> 247107 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 247107 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
[junit4] 2> 247209 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/control-001/cores/collection1
[junit4] 2> 247212 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ] o.e.j.s.Server
jetty-9.3.6.v20151106
[junit4] 2> 247222 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@e24da53{/,null,AVAILABLE}
[junit4] 2> 247227 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@43ea2172{HTTP/1.1,[http/1.1]}{127.0.0.1:42178}
[junit4] 2> 247227 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ] o.e.j.s.Server
Started @250259ms
[junit4] 2> 247227 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/tempDir-001/control/data,
hostContext=/, hostPort=42178,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/control-001/cores}
[junit4] 2> 247227 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@4e0e2f2a
[junit4] 2> 247228 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/control-001'
[junit4] 2> 247228 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 247228 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 247228 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 247230 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 247233 INFO (zkCallback-95-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@132bb0f8
name:ZooKeeperConnection Watcher:127.0.0.1:40331/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 247234 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 247234 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 247235 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 247235 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/control-001/solr.xml
[junit4] 2> 247241 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.CorePropertiesLocator Config-defined core root directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/control-001/cores
[junit4] 2> 247242 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.CoreContainer New CoreContainer 623980069
[junit4] 2> 247242 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/control-001]
[junit4] 2> 247242 WARN
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.CoreContainer Couldn't add files from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/control-001/lib
to classpath:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/control-001/lib
[junit4] 2> 247245 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
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> 247246 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 247247 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ] o.a.s.l.LogWatcher
SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 247247 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ] o.a.s.l.LogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 247247 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ] o.a.s.c.ZkContainer
Zookeeper client=127.0.0.1:40331/solr
[junit4] 2> 247247 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 247247 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 247250 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 247253 INFO (zkCallback-98-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@6917bbb9
name:ZooKeeperConnection Watcher:127.0.0.1:40331 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 247254 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 247254 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 247262 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 247268 INFO
(zkCallback-99-thread-1-processing-n:127.0.0.1:42178_) [n:127.0.0.1:42178_ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@5904eb32
name:ZooKeeperConnection Watcher:127.0.0.1:40331/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 247268 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 247269 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.c.c.SolrZkClient makePath: /overseer/queue
[junit4] 2> 247271 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
[junit4] 2> 247274 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
[junit4] 2> 247275 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
[junit4] 2> 247277 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
[junit4] 2> 247279 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 247280 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 247281 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 247282 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 247283 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 247284 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 247285 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 247286 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
[junit4] 2> 247287 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 247288 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.c.LeaderElector Joined leadership election with path:
/overseer_elect/election/95504548726833156-127.0.0.1:42178_-n_0000000000
[junit4] 2> 247288 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:42178_
[junit4] 2> 247288 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
[junit4] 2> 247289 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.c.Overseer Overseer (id=95504548726833156-127.0.0.1:42178_-n_0000000000)
starting
[junit4] 2> 247291 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
[junit4] 2> 247296 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.c.OverseerAutoReplicaFailoverThread Starting
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=30000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 247297 INFO
(OverseerStateUpdate-95504548726833156-127.0.0.1:42178_-n_0000000000)
[n:127.0.0.1:42178_ ] o.a.s.c.Overseer Starting to work on the main queue
[junit4] 2> 247297 INFO
(OverseerCollectionConfigSetProcessor-95504548726833156-127.0.0.1:42178_-n_0000000000)
[n:127.0.0.1:42178_ ] o.a.s.c.OverseerTaskProcessor Process current queue
of overseer operations
[junit4] 2> 247307 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:42178_
[junit4] 2> 247307 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:42178_
[junit4] 2> 247308 INFO
(OverseerStateUpdate-95504548726833156-127.0.0.1:42178_-n_0000000000)
[n:127.0.0.1:42178_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (0)
[junit4] 2> 247309 INFO
(zkCallback-99-thread-1-processing-n:127.0.0.1:42178_) [n:127.0.0.1:42178_ ]
o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live
nodes size: [0])
[junit4] 2> 247310 INFO
(zkCallback-99-thread-1-processing-n:127.0.0.1:42178_) [n:127.0.0.1:42178_ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 247326 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for
authorization module.
[junit4] 2> 247326 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 247328 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.c.CorePropertiesLocator Looking for core definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/control-001/cores
[junit4] 2> 247329 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1,
config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true,
configSetProperties=configsetprops.json, collection=control_collection,
coreNodeName=, dataDir=data/, shard=}
[junit4] 2> 247329 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.c.CorePropertiesLocator Found core collection1 in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/control-001/cores/collection1
[junit4] 2> 247329 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.c.CorePropertiesLocator Found 1 core definitions
[junit4] 2> 247330 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.s.SolrDispatchFilter
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2
[junit4] 2> 247330 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:42178_ ]
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 247331 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection x:collection1] o.a.s.c.ZkController
publishing state=down
[junit4] 2> 247331 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection x:collection1] o.a.s.c.ZkController
numShards not found on descriptor - reading it from system property
[junit4] 2> 247333 INFO
(OverseerStateUpdate-95504548726833156-127.0.0.1:42178_-n_0000000000)
[n:127.0.0.1:42178_ ] 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:42178";,
[junit4] 2> "node_name":"127.0.0.1:42178_",
[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> 247333 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection x:collection1] o.a.s.c.ZkController
look for our core node name
[junit4] 2> 247333 INFO
(OverseerStateUpdate-95504548726833156-127.0.0.1:42178_-n_0000000000)
[n:127.0.0.1:42178_ ] 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:42178";,
[junit4] 2> "node_name":"127.0.0.1:42178_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 247334 INFO
(OverseerStateUpdate-95504548726833156-127.0.0.1:42178_-n_0000000000)
[n:127.0.0.1:42178_ ] o.a.s.c.o.ClusterStateMutator building a new cName:
control_collection
[junit4] 2> 247334 INFO
(OverseerStateUpdate-95504548726833156-127.0.0.1:42178_-n_0000000000)
[n:127.0.0.1:42178_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard1
[junit4] 2> 247336 INFO
(zkCallback-99-thread-1-processing-n:127.0.0.1:42178_) [n:127.0.0.1:42178_ ]
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> 248334 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection x:collection1] o.a.s.c.ZkController
waiting to find shard id in clusterstate for collection1
[junit4] 2> 248334 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection x:collection1] o.a.s.c.ZkController
Check for collection zkNode:control_collection
[junit4] 2> 248334 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection x:collection1] o.a.s.c.ZkController
Collection zkNode exists
[junit4] 2> 248334 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection x:collection1]
o.a.s.c.c.ZkStateReader Load collection config from:
[/collections/control_collection]
[junit4] 2> 248335 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection x:collection1]
o.a.s.c.c.ZkStateReader path=[/collections/control_collection]
[configName]=[conf1] specified config exists in ZooKeeper
[junit4] 2> 248335 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection x:collection1]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/control-001/cores/collection1'
[junit4] 2> 248335 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection x:collection1]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 248335 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection x:collection1]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 248337 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection x:collection1] o.a.s.c.Config loaded
config solrconfig.xml with version 0
[junit4] 2> 248342 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection x:collection1] o.a.s.c.SolrConfig
current version of requestparams : -1
[junit4] 2> 248346 WARN
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection x:collection1] o.a.s.c.Config
Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory>
instead.
[junit4] 2> 248347 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection x:collection1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 7.0.0
[junit4] 2> 248357 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection x:collection1] o.a.s.c.SolrConfig
Loaded SolrConfig: solrconfig.xml
[junit4] 2> 248364 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 248484 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Initialized with
rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 248495 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection x:collection1] o.a.s.s.IndexSchema
default search field in schema is text
[junit4] 2> 248496 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection x:collection1] o.a.s.s.IndexSchema
unique key field: id
[junit4] 2> 248513 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 248515 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 248517 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 248518 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 248519 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection x:collection1]
o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default
properties: Can't find resource 'configsetprops.json' in classpath or
'/configs/conf1',
cwd=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2
[junit4] 2> 248519 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection
control_collection
[junit4] 2> 248520 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 248520 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/control-001/cores/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/control-001/cores/collection1/data/]
[junit4] 2> 248520 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@6f4265b7
[junit4] 2> 248521 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.CachingDirectoryFactory return new directory for
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/control-001/cores/collection1/data
[junit4] 2> 248521 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore New index directory detected: old=null
new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/control-001/cores/collection1/data/index/
[junit4] 2> 248521 WARN
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore [collection1] Solr index directory
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/control-001/cores/collection1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 248521 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.CachingDirectoryFactory return new directory for
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/control-001/cores/collection1/data/index
[junit4] 2> 248523 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.MockRandomMergePolicy:
org.apache.lucene.index.MockRandomMergePolicy@6aaeff37
[junit4] 2> 248523 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=RawDirectoryWrapper(RAMDirectory@1d170814
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6db07169),segFN=segments_1,generation=1}
[junit4] 2> 248523 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 248526 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"nodistrib"
[junit4] 2> 248527 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"dedupe"
[junit4] 2> 248527 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 248527 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"stored_sig"
[junit4] 2> 248527 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 248527 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"distrib-dup-test-chain-explicit"
[junit4] 2> 248527 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 248527 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 248527 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ 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> 248528 WARN
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type =
requestHandler,name = /dump,class = DumpRequestHandler,args =
{defaults={a=A,b=B}}}
[junit4] 2> 248530 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 248531 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 248531 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 248532 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 248534 INFO
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:42178_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore
Looking for old index directories to cleanup for core collection1 in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/control-001/cores/collection1/data/
[junit4] 2> 248534 WARN
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:42178_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.DirectoryFactory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/control-001/cores/collection1/data/
does not point to a valid data directory; skipping clean-up of old index
directories.
[junit4] 2> 248540 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.RequestHandlers Registered paths:
/admin/mbeans,standard,/dump,/update/csv,/sql,/update/json/docs,/admin/luke,/export,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/stream,/schema,/admin/plugins,/admin/logging,/update/json,/admin/ping,/admin/threads,/update,/admin/file
[junit4] 2> 248541 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ 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> 248542 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ 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> 248542 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ 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> 248543 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 248544 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 248545 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=13, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=86.947265625,
floorSegmentMB=2.0830078125, forceMergeDeletesPctAllowed=11.699214573258402,
segmentsPerTier=19.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.6541508730968006
[junit4] 2> 248545 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=RawDirectoryWrapper(RAMDirectory@1d170814
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6db07169),segFN=segments_1,generation=1}
[junit4] 2> 248546 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 248546 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@2cd12f3d[collection1] main]
[junit4] 2> 248546 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ 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> 248548 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ 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> 248548 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ 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> 248548 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 248548 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.RestManager Initializing RestManager with initArgs: {}
[junit4] 2> 248549 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ 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> 248550 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ 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> 248550 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ 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> 248550 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 248550 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 248551 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ 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> 248551 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ 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> 248551 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ 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> 248551 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ 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 1528072781304954880
[junit4] 2> 248553 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.UpdateLog Took 2.0ms to seed version buckets with highest version
1528072781304954880
[junit4] 2> 248553 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ZkController watch zkdir /configs/conf1
[junit4] 2> 248554 INFO
(coreLoadExecutor-611-thread-1-processing-n:127.0.0.1:42178_)
[n:127.0.0.1:42178_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 248554 INFO
(searcherExecutor-612-thread-1-processing-n:127.0.0.1:42178_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:42178_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore
[collection1] Registered new searcher Searcher@2cd12f3d[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 248558 INFO
(coreZkRegister-605-thread-1-processing-n:127.0.0.1:42178_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:42178_
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:42178
collection:control_collection shard:shard1
[junit4] 2> 248560 INFO
(coreZkRegister-605-thread-1-processing-n:127.0.0.1:42178_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:42178_
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> 248564 INFO
(coreZkRegister-605-thread-1-processing-n:127.0.0.1:42178_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:42178_
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/95504548726833156-core_node1-n_0000000000
[junit4] 2> 248564 INFO
(coreZkRegister-605-thread-1-processing-n:127.0.0.1:42178_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:42178_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext Running the leader process for shard=shard1
and weAreReplacement=false and leaderVoteWait=10000
[junit4] 2> 248566 INFO
(coreZkRegister-605-thread-1-processing-n:127.0.0.1:42178_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:42178_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 248566 INFO
(coreZkRegister-605-thread-1-processing-n:127.0.0.1:42178_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:42178_
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> 248566 INFO
(coreZkRegister-605-thread-1-processing-n:127.0.0.1:42178_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:42178_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
Sync replicas to http://127.0.0.1:42178/collection1/
[junit4] 2> 248566 INFO
(coreZkRegister-605-thread-1-processing-n:127.0.0.1:42178_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:42178_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
Sync Success - now sync replicas to me
[junit4] 2> 248566 INFO
(coreZkRegister-605-thread-1-processing-n:127.0.0.1:42178_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:42178_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
http://127.0.0.1:42178/collection1/ has no replicas
[junit4] 2> 248566 INFO
(OverseerStateUpdate-95504548726833156-127.0.0.1:42178_-n_0000000000)
[n:127.0.0.1:42178_ ] 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> 248567 INFO
(coreZkRegister-605-thread-1-processing-n:127.0.0.1:42178_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:42178_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1
[junit4] 2> 248570 INFO
(coreZkRegister-605-thread-1-processing-n:127.0.0.1:42178_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:42178_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
/collections/control_collection/leaders/shard1/leader after winning as
/collections/control_collection/leader_elect/shard1/election/95504548726833156-core_node1-n_0000000000
[junit4] 2> 248571 INFO
(coreZkRegister-605-thread-1-processing-n:127.0.0.1:42178_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:42178_
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:42178/collection1/ shard1
[junit4] 2> 248572 INFO
(OverseerStateUpdate-95504548726833156-127.0.0.1:42178_-n_0000000000)
[n:127.0.0.1:42178_ ] 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:42178";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 1
[junit4] 2> 248675 INFO
(zkCallback-99-thread-1-processing-n:127.0.0.1:42178_) [n:127.0.0.1:42178_ ]
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> 248723 INFO
(coreZkRegister-605-thread-1-processing-n:127.0.0.1:42178_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:42178_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
We are http://127.0.0.1:42178/collection1/ and leader is
http://127.0.0.1:42178/collection1/
[junit4] 2> 248723 INFO
(coreZkRegister-605-thread-1-processing-n:127.0.0.1:42178_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:42178_
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:42178
[junit4] 2> 248723 INFO
(coreZkRegister-605-thread-1-processing-n:127.0.0.1:42178_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:42178_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
I am the leader, no recovery necessary
[junit4] 2> 248723 INFO
(coreZkRegister-605-thread-1-processing-n:127.0.0.1:42178_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:42178_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
publishing state=active
[junit4] 2> 248723 INFO
(coreZkRegister-605-thread-1-processing-n:127.0.0.1:42178_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:42178_
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> 248726 INFO
(OverseerStateUpdate-95504548726833156-127.0.0.1:42178_-n_0000000000)
[n:127.0.0.1:42178_ ] 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:42178";,
[junit4] 2> "node_name":"127.0.0.1:42178_",
[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> 248726 INFO
(coreZkRegister-605-thread-1-processing-n:127.0.0.1:42178_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:42178_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (1)
[junit4] 2> 248727 INFO
(OverseerStateUpdate-95504548726833156-127.0.0.1:42178_-n_0000000000)
[n:127.0.0.1:42178_ ] 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:42178";,
[junit4] 2> "node_name":"127.0.0.1:42178_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 248830 INFO
(zkCallback-99-thread-1-processing-n:127.0.0.1:42178_) [n:127.0.0.1:42178_ ]
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> 248832 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 248833 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 248835 INFO (zkCallback-101-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@4a53496 name:ZooKeeperConnection
Watcher:127.0.0.1:40331/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 248835 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 248836 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 248836 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 248839 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 248839 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ] o.a.s.c.ChaosMonkey
monkey: init - expire sessions:false cause connection loss:false
[junit4] 2> 248839 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase Creating collection1 with stateFormat=2
[junit4] 2> 248839 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 248842 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 248846 INFO (zkCallback-102-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@3684fecf
name:ZooKeeperConnection Watcher:127.0.0.1:40331/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 248846 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 248846 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 248849 INFO
(OverseerStateUpdate-95504548726833156-127.0.0.1:42178_-n_0000000000)
[n:127.0.0.1:42178_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message
= {
[junit4] 2> "operation":"create",
[junit4] 2> "name":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "stateFormat":"2"} current state version: 3
[junit4] 2> 248849 INFO
(OverseerStateUpdate-95504548726833156-127.0.0.1:42178_-n_0000000000)
[n:127.0.0.1:42178_ ] o.a.s.c.o.ClusterStateMutator building a new cName:
collection1
[junit4] 2> 248949 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/shard-1-001/cores/collection1
[junit4] 2> 248950 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/shard-1-001
[junit4] 2> 248951 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ] o.e.j.s.Server
jetty-9.3.6.v20151106
[junit4] 2> 248952 INFO
(OverseerStateUpdate-95504548726833156-127.0.0.1:42178_-n_0000000000)
[n:127.0.0.1:42178_ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/collection1/state.json
[junit4] 2> 248953 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@2f5e0d0d{/,null,AVAILABLE}
[junit4] 2> 248954 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@4c10de96{HTTP/1.1,[http/1.1]}{127.0.0.1:41788}
[junit4] 2> 248954 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ] o.e.j.s.Server
Started @251986ms
[junit4] 2> 248954 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/tempDir-001/jetty1,
solrconfig=solrconfig.xml, hostContext=/, hostPort=41788,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/shard-1-001/cores}
[junit4] 2> 248955 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@4e0e2f2a
[junit4] 2> 248955 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/shard-1-001'
[junit4] 2> 248955 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 248955 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 248956 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 248962 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 248964 INFO (zkCallback-103-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@18ae2a6d
name:ZooKeeperConnection Watcher:127.0.0.1:40331/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 248964 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 248964 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 248966 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 248966 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/shard-1-001/solr.xml
[junit4] 2> 248972 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.CorePropertiesLocator Config-defined core root directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/shard-1-001/cores
[junit4] 2> 248972 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.CoreContainer New CoreContainer 468060006
[junit4] 2> 248972 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/shard-1-001]
[junit4] 2> 248972 WARN
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.CoreContainer Couldn't add files from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/shard-1-001/lib
to classpath:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/shard-1-001/lib
[junit4] 2> 248972 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
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> 248973 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 248974 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ] o.a.s.l.LogWatcher
SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 248974 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ] o.a.s.l.LogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 248974 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ] o.a.s.c.ZkContainer
Zookeeper client=127.0.0.1:40331/solr
[junit4] 2> 248974 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 248974 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 248975 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 248977 INFO (zkCallback-106-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@b22a784 name:ZooKeeperConnection
Watcher:127.0.0.1:40331 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 248978 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 248978 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 248981 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:41788_ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 248983 INFO
(zkCallback-107-thread-1-processing-n:127.0.0.1:41788_) [n:127.0.0.1:41788_
] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1a1bd411
name:ZooKeeperConnection Watcher:127.0.0.1:40331/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 248983 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:41788_ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 249001 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:41788_ ]
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 249003 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:41788_ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 249005 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:41788_ ]
o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 249005 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:41788_ ]
o.a.s.c.LeaderElector Joined leadership election with path:
/overseer_elect/election/95504548726833161-127.0.0.1:41788_-n_0000000001
[junit4] 2> 249006 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:41788_ ]
o.a.s.c.LeaderElector Watching path
/overseer_elect/election/95504548726833156-127.0.0.1:42178_-n_0000000000 to
know if I could be the leader
[junit4] 2> 249006 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:41788_ ]
o.a.s.c.ZkController Publish node=127.0.0.1:41788_ as DOWN
[junit4] 2> 249008 INFO
(OverseerStateUpdate-95504548726833156-127.0.0.1:42178_-n_0000000000)
[n:127.0.0.1:42178_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message
= {
[junit4] 2> "operation":"downnode",
[junit4] 2> "node_name":"127.0.0.1:41788_"} current state version: 3
[junit4] 2> 249008 INFO
(OverseerStateUpdate-95504548726833156-127.0.0.1:42178_-n_0000000000)
[n:127.0.0.1:42178_ ] o.a.s.c.o.NodeMutator DownNode state invoked for node:
127.0.0.1:41788_
[junit4] 2> 249014 INFO
(OverseerStateUpdate-95504548726833156-127.0.0.1:42178_-n_0000000000)
[n:127.0.0.1:42178_ ] o.a.s.c.o.ZkStateWriter going to update_collection
/collections/collection1/state.json version: 0
[junit4] 2> 249120 INFO (zkCallback-101-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred
- updating... (live nodes size: [1])
[junit4] 2> 249120 INFO
(zkCallback-99-thread-1-processing-n:127.0.0.1:42178_) [n:127.0.0.1:42178_ ]
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> 249120 INFO
(zkCallback-107-thread-1-processing-n:127.0.0.1:41788_) [n:127.0.0.1:41788_
] 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> 250015 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:41788_ ]
o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:41788_
[junit4] 2> 250016 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:41788_ ]
o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:41788_
[junit4] 2> 250018 INFO
(zkCallback-99-thread-1-processing-n:127.0.0.1:42178_) [n:127.0.0.1:42178_ ]
o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live
nodes size: [1])
[junit4] 2> 250018 INFO
(zkCallback-107-thread-1-processing-n:127.0.0.1:41788_) [n:127.0.0.1:41788_
] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live
nodes size: [1])
[junit4] 2> 250018 INFO (zkCallback-101-thread-1) [ ]
o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live
nodes size: [1])
[junit4] 2> 250018 INFO
(zkCallback-107-thread-1-processing-n:127.0.0.1:41788_) [n:127.0.0.1:41788_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 250018 INFO (zkCallback-101-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 250019 INFO
(zkCallback-99-thread-1-processing-n:127.0.0.1:42178_) [n:127.0.0.1:42178_ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 250053 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:41788_ ]
o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for
authorization module.
[junit4] 2> 250053 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:41788_ ]
o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 250054 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:41788_ ]
o.a.s.c.CorePropertiesLocator Looking for core definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/shard-1-001/cores
[junit4] 2> 250055 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:41788_ ]
o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1,
config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true,
configSetProperties=configsetprops.json, collection=collection1, coreNodeName=,
dataDir=data/, shard=}
[junit4] 2> 250055 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:41788_ ]
o.a.s.c.CorePropertiesLocator Found core collection1 in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/shard-1-001/cores/collection1
[junit4] 2> 250055 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:41788_ ]
o.a.s.c.CorePropertiesLocator Found 1 core definitions
[junit4] 2> 250058 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:41788_ ]
o.a.s.s.SolrDispatchFilter
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2
[junit4] 2> 250058 INFO
(TEST-TestReqParamsAPI.test-seed#[9E761808F3733B3B]) [n:127.0.0.1:41788_ ]
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 250059 INFO
(coreLoadExecutor-622-thread-1-processing-n:127.0.0.1:41788_)
[n:127.0.0.1:41788_ c:collection1 x:collection1] o.a.s.c.ZkController
publishing state=down
[junit4] 2> 250059 INFO
(coreLoadExecutor-622-thread-1-processing-n:127.0.0.1:41788_)
[n:127.0.0.1:41788_ c:collection1 x:collection1] o.a.s.c.ZkController
numShards not found on descriptor - reading it from system property
[junit4] 2> 250061 INFO
(OverseerStateUpdate-95504548726833156-127.0.0.1:42178_-n_0000000000)
[n:127.0.0.1:42178_ ] 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:41788";,
[junit4] 2> "node_name":"127.0.0.1:41788_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"} current state version: 4
[junit4] 2> 250062 INFO
(coreLoadExecutor-622-thread-1-processing-n:127.0.0.1:41788_)
[n:127.0.0.1:41788_ c:collection1 x:collection1] o.a.s.c.ZkController
Registering watch for collection collection1
[junit4] 2> 250062 INFO
(OverseerStateUpdate-95504548726833156-127.0.0.1:42178_-n_0000000000)
[n:127.0.0.1:42178_ ] 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:41788";,
[junit4] 2> "node_name":"127.0.0.1:41788_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"}
[junit4] 2> 250062 INFO
(coreLoadExecutor-622-thread-1-processing-n:127.0.0.1:41788_)
[n:127.0.0.1:41788_ c:collection1 x:collection1] o.a.s.c.c.ZkStateReader
addZkWatch [collection1]
[junit4] 2> 250062 INFO
(OverseerStateUpdate-95504548726833156-127.0.0.1:42178_-n_0000000000)
[n:127.0.0.1:42178_ ] o.a.s.c.o.ReplicaMutator Collection already exists
with numShards=2
[junit4] 2> 250062 INFO
(OverseerStateUpdate-95504548726833156-127.0.0.1:42178_-n_0000000000)
[n:127.0.0.1:42178_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard2
[junit4] 2> 250062 INFO
(coreLoadExecutor-622-thread-1-processing-n:127.0.0.1:41788_)
[n:127.0.0.1:41788_ c:collection1 x:collection1] o.a.s.c.c.ZkStateReader Add
data for [collection1] ver [1]
[junit4] 2> 250063 INFO
(coreLoadExecutor-622-thread-1-processing-n:127.0.0.1:41788_)
[n:127.0.0.1:41788_ c:collection1 x:collection1] o.a.s.c.ZkController look
for our core node name
[junit4] 2> 250165 INFO
(OverseerStateUpdate-95504548726833156-127.0.0.1:42178_-n_0000000000)
[n:127.0.0.1:42178_ ] o.a.s.c.o.ZkStateWriter going to update_collection
/collections/collection1/state.json version: 1
[junit4] 2> 250166 INFO
(zkCallback-107-thread-1-processing-n:127.0.0.1:41788_) [n:127.0.0.1:41788_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 250167 INFO
(zkCallback-107-thread-1-processing-n:127.0.0.1:41788_) [n:127.0.0.1:41788_
] o.a.s.c.c.ZkStateReader Updating data for [collection1] from [1] to [2]
[junit4] 2> 251063 INFO
(coreLoadExecutor-622-thread-1-processing-n:127.0.0.1:41788_)
[n:127.0.0.1:41788_ c:collection1 x:collection1] o.a.s.c.ZkController waiting
to find shard id in clusterstate for collection1
[junit4] 2> 251063 INFO
(coreLoadExecutor-622-thread-1-processing-n:127.0.0.1:41788_)
[n:127.0.0.1:41788_ c:collection1 x:collection1] o.a.s.c.ZkController Check
for collection zkNode:collection1
[junit4] 2> 251063 INFO
(coreLoadExecutor-622-thread-1-processing-n:127.0.0.1:41788_)
[n:127.0.0.1:41788_ c:collection1 x:collection1] o.a.s.c.ZkController
Collection zkNode exists
[junit4] 2> 251063 INFO
(coreLoadExecutor-622-thread-1-processing-n:127.0.0.1:41788_)
[n:127.0.0.1:41788_ c:collection1 x:collection1] o.a.s.c.c.ZkStateReader Load
collection config from: [/collections/collection1]
[junit4] 2> 251064 INFO
(coreLoadExecutor-622-thread-1-processing-n:127.0.0.1:41788_)
[n:127.0.0.1:41788_ c:collection1 x:collection1] o.a.s.c.c.ZkStateReader
path=[/collections/collection1] [configName]=[conf1] specified config exists in
ZooKeeper
[junit4] 2> 251064 INFO
(coreLoadExecutor-622-thread-1-processing-n:127.0.0.1:41788_)
[n:127.0.0.1:41788_ c:collection1 x:collection1] o.a.s.c.SolrResourceLoader
new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J2/temp/solr.handler.TestReqParamsAPI_9E761808F3733B3B-001/shard-1-001/cores/collection1'
[junit4] 2> 251065 INFO
(coreLoadExecutor-622-thread-1-processing-n:127.0.0.1:41788_)
[n:127.0.0.1:41788_ c:collection1 x:collection1] o.a.s.c.SolrResourceLoader
JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 251065 INFO (
[...truncated too long message...]
0.0.1:34282
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:588)
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241)
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230)
[junit4] > at
org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
[junit4] > at
org.apache.solr.cloud.BasicDistributedZkTest.lambda$createCores$3(BasicDistributedZkTest.java:581)
[junit4] > ... 4 more
[junit4] > Caused by: java.net.SocketTimeoutException: Read timed out
[junit4] > at java.net.SocketInputStream.socketRead0(Native Method)
[junit4] > at
java.net.SocketInputStream.socketRead(SocketInputStream.java:116)
[junit4] > at
java.net.SocketInputStream.read(SocketInputStream.java:170)
[junit4] > at
java.net.SocketInputStream.read(SocketInputStream.java:141)
[junit4] > at
org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160)
[junit4] > at
org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84)
[junit4] > at
org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273)
[junit4] > at
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140)
[junit4] > at
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
[junit4] > at
org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261)
[junit4] > at
org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283)
[junit4] > at
org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251)
[junit4] > at
org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197)
[junit4] > at
org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272)
[junit4] > at
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124)
[junit4] > at
org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685)
[junit4] > at
org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487)
[junit4] > at
org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882)
[junit4] > at
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
[junit4] > at
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107)
[junit4] > at
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:482)
[junit4] > ... 8 moreThrowable #9:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught
exception in thread: Thread[id=2609, name=testExecutor-1092-thread-9,
state=RUNNABLE, group=TGRP-UnloadDistributedZkTest]
[junit4] > Caused by: java.lang.RuntimeException:
org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting
response from server at: http://127.0.0.1:34282
[junit4] > at
__randomizedtesting.SeedInfo.seed([9E761808F3733B3B]:0)
[junit4] > at
org.apache.solr.cloud.BasicDistributedZkTest.lambda$createCores$3(BasicDistributedZkTest.java:583)
[junit4] > at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$6(ExecutorUtil.java:229)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > Caused by: org.apache.solr.client.solrj.SolrServerException:
Timeout occured while waiting response from server at: http://127.0.0.1:34282
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:588)
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241)
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230)
[junit4] > at
org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
[junit4] > at
org.apache.solr.cloud.BasicDistributedZkTest.lambda$createCores$3(BasicDistributedZkTest.java:581)
[junit4] > ... 4 more
[junit4] > Caused by: java.net.SocketTimeoutException: Read timed out
[junit4] > at java.net.SocketInputStream.socketRead0(Native Method)
[junit4] > at
java.net.SocketInputStream.socketRead(SocketInputStream.java:116)
[junit4] > at
java.net.SocketInputStream.read(SocketInputStream.java:170)
[junit4] > at
java.net.SocketInputStream.read(SocketInputStream.java:141)
[junit4] > at
org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160)
[junit4] > at
org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84)
[junit4] > at
org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273)
[junit4] > at
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140)
[junit4] > at
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
[junit4] > at
org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261)
[junit4] > at
org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283)
[junit4] > at
org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251)
[junit4] > at
org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197)
[junit4] > at
org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272)
[junit4] > at
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124)
[junit4] > at
org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685)
[junit4] > at
org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487)
[junit4] > at
org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882)
[junit4] > at
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
[junit4] > at
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107)
[junit4] > at
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:482)
[junit4] > ... 8 more
[junit4] 2> 508050 INFO
(SUITE-UnloadDistributedZkTest-seed#[9E761808F3733B3B]-worker) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> Mar 06, 2016 5:07:04 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> NOTE: test params are:
codec=DummyCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=DUMMY,
chunkSize=22460, maxDocsPerChunk=2, blockSize=1006),
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=DUMMY,
chunkSize=22460, blockSize=1006)),
sim=RandomSimilarity(queryNorm=false,coord=crazy): {}, locale=sr-Latn-RS,
timezone=America/Rankin_Inlet
[junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation
1.8.0_66 (64-bit)/cpus=4,threads=1,free=194796752,total=429391872
[junit4] 2> NOTE: All tests run in this JVM: [BlockDirectoryTest,
SharedFSAutoReplicaFailoverTest, HdfsLockFactoryTest, SuggesterWFSTTest,
TestReload, UpdateParamsTest, TestSort, TestReqParamsAPI, HdfsNNFailoverTest,
TestIndexingPerformance, TestCollapseQParserPlugin, RegexBoostProcessorTest,
TestSolrDeletionPolicy1, TestRequestStatusCollectionAPI,
UnloadDistributedZkTest]
[junit4] Completed [68/582 (2!)] on J2 in 139.78s, 1 test, 1 error <<<
FAILURES!
[...truncated 1683 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/build.xml:747:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/build.xml:684:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/build.xml:59:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build.xml:233:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/common-build.xml:524:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/lucene/common-build.xml:1457:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/lucene/common-build.xml:1014:
There were test failures: 582 suites (8 ignored), 2344 tests, 1 error, 1
failure, 34 ignored (17 assumptions) [seed: 9E761808F3733B3B]
Total time: 244 minutes 59 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
No prior successful build to compare, so performing full copy of artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
