Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/6400/
Java: 64bit/jdk1.8.0_121 -XX:+UseCompressedOops -XX:+UseParallelGC
1 tests failed.
FAILED: org.apache.solr.handler.TestReqParamsAPI.test
Error Message:
Could not get expected value 'A val' for path 'params/a' full output: {
"responseHeader":{ "status":0, "QTime":0}, "params":{
"wt":"json", "useParams":""}, "context":{ "webapp":"/solr",
"path":"/dump0", "httpMethod":"GET"}}, from server:
http://127.0.0.1:59233/solr/collection1_shard1_replica2
Stack Trace:
java.lang.AssertionError: Could not get expected value 'A val' for path
'params/a' full output: {
"responseHeader":{
"status":0,
"QTime":0},
"params":{
"wt":"json",
"useParams":""},
"context":{
"webapp":"/solr",
"path":"/dump0",
"httpMethod":"GET"}}, from server:
http://127.0.0.1:59233/solr/collection1_shard1_replica2
at
__randomizedtesting.SeedInfo.seed([229553DB7D7CD29F:AAC16C01D380BF67]: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:556)
at
org.apache.solr.handler.TestReqParamsAPI.testReqParams(TestReqParamsAPI.java:127)
at
org.apache.solr.handler.TestReqParamsAPI.test(TestReqParamsAPI.java:69)
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:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
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:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
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:368)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 10869 lines...]
[junit4] Suite: org.apache.solr.handler.TestReqParamsAPI
[junit4] 2> Creating dataDir:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReqParamsAPI_229553DB7D7CD29F-001\init-core-data-001
[junit4] 2> 38644 INFO
(SUITE-TestReqParamsAPI-seed#[229553DB7D7CD29F]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using TrieFields
[junit4] 2> 38650 INFO
(SUITE-TestReqParamsAPI-seed#[229553DB7D7CD29F]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 38652 INFO
(SUITE-TestReqParamsAPI-seed#[229553DB7D7CD29F]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReqParamsAPI_229553DB7D7CD29F-001\tempDir-001
[junit4] 2> 38652 INFO
(SUITE-TestReqParamsAPI-seed#[229553DB7D7CD29F]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 38652 INFO (Thread-38) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 38652 INFO (Thread-38) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 38753 INFO
(SUITE-TestReqParamsAPI-seed#[229553DB7D7CD29F]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:59229
[junit4] 2> 38763 INFO (jetty-launcher-62-thread-2) [ ] o.e.j.s.Server
jetty-9.3.14.v20161028
[junit4] 2> 38764 INFO (jetty-launcher-62-thread-1) [ ] o.e.j.s.Server
jetty-9.3.14.v20161028
[junit4] 2> 38764 INFO (jetty-launcher-62-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@14c8f161{/solr,null,AVAILABLE}
[junit4] 2> 38766 INFO (jetty-launcher-62-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@e101987{/solr,null,AVAILABLE}
[junit4] 2> 38788 INFO (jetty-launcher-62-thread-1) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@1da0fbdb{HTTP/1.1,[http/1.1]}{127.0.0.1:?????}
[junit4] 2> 38788 INFO (jetty-launcher-62-thread-2) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@42c48418{HTTP/1.1,[http/1.1]}{127.0.0.1:?????}
[junit4] 2> 38788 INFO (jetty-launcher-62-thread-1) [ ] o.e.j.s.Server
Started @?????ms
[junit4] 2> 38788 INFO (jetty-launcher-62-thread-2) [ ] o.e.j.s.Server
Started @?????ms
[junit4] 2> 38788 INFO (jetty-launcher-62-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=59236}
[junit4] 2> 38788 INFO (jetty-launcher-62-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=59233}
[junit4] 2> 38788 ERROR (jetty-launcher-62-thread-1) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 38788 INFO (jetty-launcher-62-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.0.0
[junit4] 2> 38788 INFO (jetty-launcher-62-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 38788 INFO (jetty-launcher-62-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 38788 ERROR (jetty-launcher-62-thread-2) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 38788 INFO (jetty-launcher-62-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-02-16T22:29:30.278Z
[junit4] 2> 38788 INFO (jetty-launcher-62-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.0.0
[junit4] 2> 38788 INFO (jetty-launcher-62-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 38788 INFO (jetty-launcher-62-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 38788 INFO (jetty-launcher-62-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-02-16T22:29:30.278Z
[junit4] 2> 38796 INFO (jetty-launcher-62-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 38802 INFO (jetty-launcher-62-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 38810 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15a490b6da20001, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 38817 INFO (jetty-launcher-62-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:59229/solr
[junit4] 2> 38819 INFO (jetty-launcher-62-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:59229/solr
[junit4] 2> 38834 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15a490b6da20003, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 38842 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15a490b6da20004, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 38875 INFO (jetty-launcher-62-thread-1)
[n:127.0.0.1:59236_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 38875 INFO (jetty-launcher-62-thread-2)
[n:127.0.0.1:59233_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 38877 INFO (jetty-launcher-62-thread-1)
[n:127.0.0.1:59236_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:59236_solr
[junit4] 2> 38879 INFO (jetty-launcher-62-thread-2)
[n:127.0.0.1:59233_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:59233_solr
[junit4] 2> 38879 INFO (jetty-launcher-62-thread-1)
[n:127.0.0.1:59236_solr ] o.a.s.c.Overseer Overseer
(id=97470655374688261-127.0.0.1:59236_solr-n_0000000000) starting
[junit4] 2> 38883 INFO
(zkCallback-72-thread-1-processing-n:127.0.0.1:59236_solr)
[n:127.0.0.1:59236_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 38884 INFO
(zkCallback-73-thread-1-processing-n:127.0.0.1:59233_solr)
[n:127.0.0.1:59233_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 38892 INFO (jetty-launcher-62-thread-1)
[n:127.0.0.1:59236_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:59236_solr
[junit4] 2> 38974 INFO
(zkCallback-72-thread-1-processing-n:127.0.0.1:59236_solr)
[n:127.0.0.1:59236_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 38975 INFO
(zkCallback-73-thread-1-processing-n:127.0.0.1:59233_solr)
[n:127.0.0.1:59233_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 39037 INFO (jetty-launcher-62-thread-1)
[n:127.0.0.1:59236_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReqParamsAPI_229553DB7D7CD29F-001\tempDir-001\node1\.
[junit4] 2> 39037 INFO (jetty-launcher-62-thread-2)
[n:127.0.0.1:59233_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReqParamsAPI_229553DB7D7CD29F-001\tempDir-001\node2\.
[junit4] 2> 39066 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15a490b6da20007, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 39075 INFO
(SUITE-TestReqParamsAPI-seed#[229553DB7D7CD29F]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 39076 INFO
(SUITE-TestReqParamsAPI-seed#[229553DB7D7CD29F]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:59229/solr ready
[junit4] 2> 39837 INFO (qtp1731964853-311) [n:127.0.0.1:59233_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=2&collection.configName=conf1&name=collection1&action=CREATE&numShards=1&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 39882 INFO
(OverseerThreadFactory-63-thread-1-processing-n:127.0.0.1:59236_solr)
[n:127.0.0.1:59236_solr ] o.a.s.c.CreateCollectionCmd Create collection
collection1
[junit4] 2> 40068 INFO (qtp1731964853-310) [n:127.0.0.1:59233_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf1&newCollection=true&name=collection1_shard1_replica2&action=CREATE&numShards=1&collection=collection1&shard=shard1&wt=javabin&version=2
[junit4] 2> 40070 INFO (qtp1546178959-320) [n:127.0.0.1:59236_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf1&newCollection=true&name=collection1_shard1_replica1&action=CREATE&numShards=1&collection=collection1&shard=shard1&wt=javabin&version=2
[junit4] 2> 40201 INFO
(zkCallback-73-thread-1-processing-n:127.0.0.1:59233_solr)
[n:127.0.0.1:59233_solr ] 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> 40201 INFO
(zkCallback-72-thread-2-processing-n:127.0.0.1:59236_solr)
[n:127.0.0.1:59236_solr ] 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> 41117 INFO (qtp1546178959-320) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 7.0.0
[junit4] 2> 41126 INFO (qtp1731964853-310) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 x:collection1_shard1_replica2] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 7.0.0
[junit4] 2> 41162 INFO (qtp1546178959-320) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.s.IndexSchema
[collection1_shard1_replica1] Schema name=minimal
[junit4] 2> 41165 INFO (qtp1731964853-310) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 x:collection1_shard1_replica2] o.a.s.s.IndexSchema
[collection1_shard1_replica2] Schema name=minimal
[junit4] 2> 41170 INFO (qtp1546178959-320) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.s.IndexSchema
Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 41171 INFO (qtp1731964853-310) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 x:collection1_shard1_replica2] o.a.s.s.IndexSchema
Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 41175 INFO (qtp1546178959-320) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1_shard1_replica1' using configuration from
collection collection1
[junit4] 2> 41175 INFO (qtp1731964853-310) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 x:collection1_shard1_replica2] o.a.s.c.CoreContainer
Creating SolrCore 'collection1_shard1_replica2' using configuration from
collection collection1
[junit4] 2> 41176 INFO (qtp1546178959-320) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.SolrCore
[[collection1_shard1_replica1] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReqParamsAPI_229553DB7D7CD29F-001\tempDir-001\node1\collection1_shard1_replica1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReqParamsAPI_229553DB7D7CD29F-001\tempDir-001\node1\.\collection1_shard1_replica1\data\]
[junit4] 2> 41176 INFO (qtp1731964853-310) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 x:collection1_shard1_replica2] o.a.s.c.SolrCore
[[collection1_shard1_replica2] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReqParamsAPI_229553DB7D7CD29F-001\tempDir-001\node2\collection1_shard1_replica2],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReqParamsAPI_229553DB7D7CD29F-001\tempDir-001\node2\.\collection1_shard1_replica2\data\]
[junit4] 2> 41316 INFO (qtp1731964853-310) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 x:collection1_shard1_replica2] o.a.s.u.UpdateHandler
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 41317 INFO (qtp1731964853-310) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 x:collection1_shard1_replica2] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 41317 INFO (qtp1546178959-320) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.u.UpdateHandler
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 41318 INFO (qtp1546178959-320) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 41323 INFO (qtp1546178959-320) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.u.CommitTracker
Hard AutoCommit: disabled
[junit4] 2> 41324 INFO (qtp1546178959-320) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.u.CommitTracker
Soft AutoCommit: disabled
[junit4] 2> 41324 INFO (qtp1731964853-310) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 x:collection1_shard1_replica2] o.a.s.u.CommitTracker
Hard AutoCommit: disabled
[junit4] 2> 41324 INFO (qtp1731964853-310) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 x:collection1_shard1_replica2] o.a.s.u.CommitTracker
Soft AutoCommit: disabled
[junit4] 2> 41324 INFO (qtp1546178959-320) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@6799da6[collection1_shard1_replica1] main]
[junit4] 2> 41326 INFO (qtp1731964853-310) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 x:collection1_shard1_replica2]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@776851ff[collection1_shard1_replica2] main]
[junit4] 2> 41334 INFO (qtp1546178959-320) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 41335 INFO (qtp1731964853-310) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 x:collection1_shard1_replica2]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 41335 INFO (qtp1546178959-320) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 41335 INFO (qtp1731964853-310) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 x:collection1_shard1_replica2]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 41341 INFO (qtp1546178959-320) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at
/configs/conf1/managed-schema
[junit4] 2> 41341 INFO (qtp1731964853-310) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 x:collection1_shard1_replica2]
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at
/configs/conf1/managed-schema
[junit4] 2> 41345 INFO (qtp1731964853-310) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 x:collection1_shard1_replica2]
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 41345 INFO (qtp1731964853-310) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 x:collection1_shard1_replica2]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 41345 INFO (qtp1546178959-320) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 41346 INFO (qtp1546178959-320) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 41351 INFO (qtp1731964853-310) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 x:collection1_shard1_replica2] o.a.s.u.UpdateLog Could
not find max version in index or recent updates, using new clock
1559530488820924416
[junit4] 2> 41351 INFO (qtp1546178959-320) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.u.UpdateLog Could
not find max version in index or recent updates, using new clock
1559530488820924416
[junit4] 2> 41361 INFO
(searcherExecutor-66-thread-1-processing-n:127.0.0.1:59236_solr
x:collection1_shard1_replica1 s:shard1 c:collection1) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.SolrCore
[collection1_shard1_replica1] Registered new searcher
Searcher@6799da6[collection1_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 41361 INFO
(searcherExecutor-67-thread-1-processing-n:127.0.0.1:59233_solr
x:collection1_shard1_replica2 s:shard1 c:collection1) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 x:collection1_shard1_replica2] o.a.s.c.SolrCore
[collection1_shard1_replica2] Registered new searcher
Searcher@776851ff[collection1_shard1_replica2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 41379 INFO (qtp1546178959-320) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 41380 INFO (qtp1546178959-320) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 41383 INFO (qtp1546178959-320) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.SyncStrategy
Sync replicas to http://127.0.0.1:59236/solr/collection1_shard1_replica1/
[junit4] 2> 41392 INFO (qtp1546178959-320) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.u.PeerSync
PeerSync: core=collection1_shard1_replica1 url=http://127.0.0.1:59236/solr
START replicas=[http://127.0.0.1:59233/solr/collection1_shard1_replica2/]
nUpdates=100
[junit4] 2> 41393 INFO (qtp1546178959-320) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.u.PeerSync
PeerSync: core=collection1_shard1_replica1 url=http://127.0.0.1:59236/solr
DONE. We have no versions. sync failed.
[junit4] 2> 41406 INFO (qtp1731964853-308) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.c.S.Request [collection1_shard1_replica2] webapp=/solr path=/get
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
status=0 QTime=10
[junit4] 2> 41502 INFO
(zkCallback-73-thread-1-processing-n:127.0.0.1:59233_solr)
[n:127.0.0.1:59233_solr ] 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> 41502 INFO
(zkCallback-72-thread-4-processing-n:127.0.0.1:59236_solr)
[n:127.0.0.1:59236_solr ] 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> 41507 INFO (qtp1546178959-320) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.SyncStrategy
Leader's attempt to sync with shard failed, moving to the next candidate
[junit4] 2> 41507 INFO (qtp1546178959-320) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we
can't sync in that case - we were active before, so become leader anyway
[junit4] 2> 41555 INFO (qtp1546178959-320) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 x:collection1_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:59236/solr/collection1_shard1_replica1/ shard1
[junit4] 2> 41660 INFO
(zkCallback-73-thread-1-processing-n:127.0.0.1:59233_solr)
[n:127.0.0.1:59233_solr ] 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> 41660 INFO
(zkCallback-72-thread-3-processing-n:127.0.0.1:59236_solr)
[n:127.0.0.1:59236_solr ] 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> 41708 INFO (qtp1546178959-320) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.ZkController I
am the leader, no recovery necessary
[junit4] 2> 41716 INFO (qtp1546178959-320) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf1&newCollection=true&name=collection1_shard1_replica1&action=CREATE&numShards=1&collection=collection1&shard=shard1&wt=javabin&version=2}
status=0 QTime=1654
[junit4] 2> 41815 INFO
(zkCallback-73-thread-1-processing-n:127.0.0.1:59233_solr)
[n:127.0.0.1:59233_solr ] 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> 41815 INFO
(zkCallback-72-thread-3-processing-n:127.0.0.1:59236_solr)
[n:127.0.0.1:59236_solr ] 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> 42386 INFO (qtp1731964853-310) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 x:collection1_shard1_replica2] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf1&newCollection=true&name=collection1_shard1_replica2&action=CREATE&numShards=1&collection=collection1&shard=shard1&wt=javabin&version=2}
status=0 QTime=2326
[junit4] 2> 42404 INFO (qtp1731964853-311) [n:127.0.0.1:59233_solr ]
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most
30 seconds. Check all shard replicas
[junit4] 2> 42488 INFO
(zkCallback-73-thread-1-processing-n:127.0.0.1:59233_solr)
[n:127.0.0.1:59233_solr ] 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> 42488 INFO
(zkCallback-72-thread-4-processing-n:127.0.0.1:59236_solr)
[n:127.0.0.1:59236_solr ] 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> 43405 INFO (qtp1731964853-311) [n:127.0.0.1:59233_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={replicationFactor=2&collection.configName=conf1&name=collection1&action=CREATE&numShards=1&wt=javabin&version=2}
status=0 QTime=3573
[junit4] 2> 43425 INFO
(TEST-TestReqParamsAPI.test-seed#[229553DB7D7CD29F]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 43437 INFO
(TEST-TestReqParamsAPI.test-seed#[229553DB7D7CD29F]) [ ]
o.a.s.c.TestSolrConfigHandler going to send config command. path
/config?wt=json , payload: {
[junit4] 2> 'create-requesthandler' : { 'name' : '/dump0', 'class':
'org.apache.solr.handler.DumpRequestHandler' }
[junit4] 2> }
[junit4] 2> 43486 INFO (qtp1731964853-306) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.h.SolrConfigHandler Executed config commands successfully and persisted
to ZK [{"create-requesthandler":{
[junit4] 2> "name":"/dump0",
[junit4] 2> "class":"org.apache.solr.handler.DumpRequestHandler"}}]
[junit4] 2> 43488 INFO (Thread-58) [n:127.0.0.1:59233_solr ]
o.a.s.c.SolrCore config update listener called for core
collection1_shard1_replica2
[junit4] 2> 43488 INFO (Thread-57) [n:127.0.0.1:59236_solr ]
o.a.s.c.SolrCore config update listener called for core
collection1_shard1_replica1
[junit4] 2> 43488 INFO (qtp1731964853-306) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.h.SolrConfigHandler Waiting up to 30 secs for 2 replicas to set the
property overlay to be of version 0 for collection collection1
[junit4] 2> 43489 INFO (Thread-58) [n:127.0.0.1:59233_solr ]
o.a.s.c.SolrCore core reload collection1_shard1_replica2
[junit4] 2> 43489 INFO (Thread-57) [n:127.0.0.1:59236_solr ]
o.a.s.c.SolrCore core reload collection1_shard1_replica1
[junit4] 2> 43491 INFO
(solrHandlerExecutor-76-thread-2-processing-n:127.0.0.1:59233_solr
x:collection1_shard1_replica2 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.h.SolrConfigHandler Time elapsed : 0 secs,
maxWait 30
[junit4] 2> 43493 INFO
(solrHandlerExecutor-76-thread-1-processing-n:127.0.0.1:59233_solr
x:collection1_shard1_replica2 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.h.SolrConfigHandler Time elapsed : 0 secs,
maxWait 30
[junit4] 2> 43513 INFO (Thread-58) [n:127.0.0.1:59233_solr ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 43521 INFO (Thread-57) [n:127.0.0.1:59236_solr ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 43540 INFO (Thread-58) [n:127.0.0.1:59233_solr ]
o.a.s.s.IndexSchema [collection1_shard1_replica2] Schema name=minimal
[junit4] 2> 43544 INFO (Thread-57) [n:127.0.0.1:59236_solr ]
o.a.s.s.IndexSchema [collection1_shard1_replica1] Schema name=minimal
[junit4] 2> 43547 INFO (Thread-57) [n:127.0.0.1:59236_solr ]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 43550 INFO (Thread-58) [n:127.0.0.1:59233_solr ]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 43553 INFO (Thread-57) [n:127.0.0.1:59236_solr ]
o.a.s.c.CoreContainer Reloading SolrCore 'collection1_shard1_replica1' using
configuration from collection collection1
[junit4] 2> 43553 INFO (Thread-58) [n:127.0.0.1:59233_solr ]
o.a.s.c.CoreContainer Reloading SolrCore 'collection1_shard1_replica2' using
configuration from collection collection1
[junit4] 2> 43555 INFO (Thread-58) [n:127.0.0.1:59233_solr c:collection1
s:shard1 r:core_node1 x:collection1_shard1_replica2] o.a.s.c.SolrCore
[[collection1_shard1_replica2] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReqParamsAPI_229553DB7D7CD29F-001\tempDir-001\node2\collection1_shard1_replica2],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReqParamsAPI_229553DB7D7CD29F-001\tempDir-001\node2\.\collection1_shard1_replica2\data\]
[junit4] 2> 43555 INFO (Thread-57) [n:127.0.0.1:59236_solr c:collection1
s:shard1 r:core_node2 x:collection1_shard1_replica1] o.a.s.c.SolrCore
[[collection1_shard1_replica1] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReqParamsAPI_229553DB7D7CD29F-001\tempDir-001\node1\collection1_shard1_replica1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReqParamsAPI_229553DB7D7CD29F-001\tempDir-001\node1\.\collection1_shard1_replica1\data\]
[junit4] 2> 43653 INFO (qtp1546178959-318) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.h.SolrConfigHandler expecting overlay version 0 but my version is -1
[junit4] 2> 43653 INFO (qtp1731964853-313) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.h.SolrConfigHandler expecting overlay version 0 but my version is -1
[junit4] 2> 43653 INFO (qtp1546178959-318) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.c.S.Request [collection1_shard1_replica1] webapp=/solr
path=/config/znodeVersion params={overlay=0&wt=javabin&version=2} status=0
QTime=37
[junit4] 2> 43653 INFO (qtp1731964853-313) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.c.S.Request [collection1_shard1_replica2] webapp=/solr
path=/config/znodeVersion params={overlay=0&wt=javabin&version=2} status=0
QTime=48
[junit4] 2> 43655 INFO
(solrHandlerExecutor-76-thread-1-processing-n:127.0.0.1:59233_solr
x:collection1_shard1_replica2 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.h.SolrConfigHandler Could not get
expectedVersion 0 from http://127.0.0.1:59233/solr/collection1_shard1_replica2/
for prop overlay after 1 attempts
[junit4] 2> 43655 INFO
(solrHandlerExecutor-76-thread-1-processing-n:127.0.0.1:59233_solr
x:collection1_shard1_replica2 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.h.SolrConfigHandler Time elapsed : 0 secs,
maxWait 30
[junit4] 2> 43655 INFO
(solrHandlerExecutor-76-thread-2-processing-n:127.0.0.1:59233_solr
x:collection1_shard1_replica2 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.h.SolrConfigHandler Could not get
expectedVersion 0 from http://127.0.0.1:59236/solr/collection1_shard1_replica1/
for prop overlay after 1 attempts
[junit4] 2> 43655 INFO
(solrHandlerExecutor-76-thread-2-processing-n:127.0.0.1:59233_solr
x:collection1_shard1_replica2 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.h.SolrConfigHandler Time elapsed : 0 secs,
maxWait 30
[junit4] 2> 43656 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.h.SolrConfigHandler Trying to update my
configs
[junit4] 2> 43656 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.c.SolrCore config update listener called
for core collection1_shard1_replica1
[junit4] 2> 43658 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.c.SolrCore core reload
collection1_shard1_replica1
[junit4] 2> 43658 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.h.SolrConfigHandler Trying to update my
configs
[junit4] 2> 43658 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.c.SolrCore config update listener called
for core collection1_shard1_replica2
[junit4] 2> 43659 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.c.SolrCore core reload
collection1_shard1_replica2
[junit4] 2> 43689 INFO (Thread-57) [n:127.0.0.1:59236_solr c:collection1
s:shard1 r:core_node2 x:collection1_shard1_replica1] o.a.s.u.CommitTracker Hard
AutoCommit: disabled
[junit4] 2> 43689 INFO (Thread-57) [n:127.0.0.1:59236_solr c:collection1
s:shard1 r:core_node2 x:collection1_shard1_replica1] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 43691 INFO (Thread-57) [n:127.0.0.1:59236_solr c:collection1
s:shard1 r:core_node2 x:collection1_shard1_replica1] o.a.s.s.SolrIndexSearcher
Opening [Searcher@5c536c8a[collection1_shard1_replica1] main]
[junit4] 2> 43692 INFO (Thread-58) [n:127.0.0.1:59233_solr c:collection1
s:shard1 r:core_node1 x:collection1_shard1_replica2] o.a.s.u.CommitTracker Hard
AutoCommit: disabled
[junit4] 2> 43692 INFO (Thread-58) [n:127.0.0.1:59233_solr c:collection1
s:shard1 r:core_node1 x:collection1_shard1_replica2] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 43693 INFO (Thread-57) [n:127.0.0.1:59236_solr c:collection1
s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 43695 INFO (Thread-58) [n:127.0.0.1:59233_solr c:collection1
s:shard1 r:core_node1 x:collection1_shard1_replica2] o.a.s.s.SolrIndexSearcher
Opening [Searcher@36f1236d[collection1_shard1_replica2] main]
[junit4] 2> 43695 INFO (Thread-57) [n:127.0.0.1:59236_solr c:collection1
s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 43695 INFO (Thread-57) [n:127.0.0.1:59236_solr c:collection1
s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at
/configs/conf1/managed-schema
[junit4] 2> 43696 INFO (Thread-57) [n:127.0.0.1:59236_solr c:collection1
s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 43697 INFO (Thread-57) [n:127.0.0.1:59236_solr c:collection1
s:shard1 r:core_node2 x:collection1_shard1_replica1] o.a.s.h.ReplicationHandler
Commits will be reserved for 10000
[junit4] 2> 43697 INFO (Thread-58) [n:127.0.0.1:59233_solr c:collection1
s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 43697 INFO (Thread-57) [n:127.0.0.1:59236_solr c:collection1
s:shard1 r:core_node2 x:collection1_shard1_replica1] o.a.s.u.UpdateLog Could
not find max version in index or recent updates, using new clock
1559530491280883712
[junit4] 2> 43698 INFO
(searcherExecutor-78-thread-1-processing-n:127.0.0.1:59236_solr
x:collection1_shard1_replica1 s:shard1 c:collection1 r:core_node2)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.c.SolrCore [collection1_shard1_replica1]
Registered new searcher Searcher@5c536c8a[collection1_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 43701 INFO (Thread-58) [n:127.0.0.1:59233_solr c:collection1
s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 43702 INFO (Thread-58) [n:127.0.0.1:59233_solr c:collection1
s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at
/configs/conf1/managed-schema
[junit4] 2> 43705 INFO (Thread-58) [n:127.0.0.1:59233_solr c:collection1
s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 43705 INFO (Thread-58) [n:127.0.0.1:59233_solr c:collection1
s:shard1 r:core_node1 x:collection1_shard1_replica2] o.a.s.h.ReplicationHandler
Commits will be reserved for 10000
[junit4] 2> 43705 INFO (Thread-58) [n:127.0.0.1:59233_solr c:collection1
s:shard1 r:core_node1 x:collection1_shard1_replica2] o.a.s.u.UpdateLog Could
not find max version in index or recent updates, using new clock
1559530491289272320
[junit4] 2> 43707 INFO
(searcherExecutor-77-thread-1-processing-n:127.0.0.1:59233_solr
x:collection1_shard1_replica2 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.c.SolrCore [collection1_shard1_replica2]
Registered new searcher Searcher@36f1236d[collection1_shard1_replica2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 43708 INFO (Thread-57) [n:127.0.0.1:59236_solr c:collection1
s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 43708 INFO (Thread-58) [n:127.0.0.1:59233_solr c:collection1
s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 43708 INFO (Thread-58) [n:127.0.0.1:59233_solr c:collection1
s:shard1 r:core_node1 x:collection1_shard1_replica2] o.a.s.s.SolrIndexSearcher
Opening [Searcher@2e74581a[collection1_shard1_replica2] main]
[junit4] 2> 43709 INFO (Thread-57) [n:127.0.0.1:59236_solr c:collection1
s:shard1 r:core_node2 x:collection1_shard1_replica1] o.a.s.s.SolrIndexSearcher
Opening [Searcher@59dcc891[collection1_shard1_replica1] main]
[junit4] 2> 43709 INFO (Thread-57) [n:127.0.0.1:59236_solr c:collection1
s:shard1 r:core_node2 x:collection1_shard1_replica1] o.a.s.c.SolrCore
[collection1_shard1_replica1] CLOSING SolrCore
org.apache.solr.core.SolrCore@7063ebba
[junit4] 2> 43709 INFO
(searcherExecutor-77-thread-1-processing-n:127.0.0.1:59233_solr
x:collection1_shard1_replica2 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.c.SolrCore [collection1_shard1_replica2]
Registered new searcher Searcher@2e74581a[collection1_shard1_replica2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 43709 INFO
(searcherExecutor-78-thread-1-processing-n:127.0.0.1:59236_solr
x:collection1_shard1_replica1 s:shard1 c:collection1 r:core_node2)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.c.SolrCore [collection1_shard1_replica1]
Registered new searcher Searcher@59dcc891[collection1_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 43710 INFO (Thread-57) [n:127.0.0.1:59236_solr c:collection1
s:shard1 r:core_node2 x:collection1_shard1_replica1] o.a.s.m.SolrMetricManager
Closing metric reporters for: solr.core.collection1.shard1.replica1
[junit4] 2> 43726 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.c.SolrConfig Using Lucene MatchVersion:
7.0.0
[junit4] 2> 43731 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.c.SolrConfig Using Lucene MatchVersion:
7.0.0
[junit4] 2> 43742 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.s.IndexSchema
[collection1_shard1_replica1] Schema name=minimal
[junit4] 2> 43743 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.s.IndexSchema
[collection1_shard1_replica2] Schema name=minimal
[junit4] 2> 43751 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.s.IndexSchema Loaded schema minimal/1.1
with uniqueid field id
[junit4] 2> 43751 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.s.IndexSchema Loaded schema minimal/1.1
with uniqueid field id
[junit4] 2> 43756 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.c.CoreContainer Reloading SolrCore
'collection1_shard1_replica2' using configuration from collection collection1
[junit4] 2> 43756 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.c.CoreContainer Reloading SolrCore
'collection1_shard1_replica1' using configuration from collection collection1
[junit4] 2> 43758 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.c.SolrCore [[collection1_shard1_replica2]
] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReqParamsAPI_229553DB7D7CD29F-001\tempDir-001\node2\collection1_shard1_replica2],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReqParamsAPI_229553DB7D7CD29F-001\tempDir-001\node2\.\collection1_shard1_replica2\data\]
[junit4] 2> 43758 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.c.SolrCore [[collection1_shard1_replica1]
] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReqParamsAPI_229553DB7D7CD29F-001\tempDir-001\node1\collection1_shard1_replica1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReqParamsAPI_229553DB7D7CD29F-001\tempDir-001\node1\.\collection1_shard1_replica1\data\]
[junit4] 2> 43766 INFO (qtp1731964853-309) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.h.SolrConfigHandler I already have the expected version 0 of config
[junit4] 2> 43766 INFO (qtp1731964853-309) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.h.SolrConfigHandler isStale false , resourceloader
org.apache.solr.cloud.ZkSolrResourceLoader
[junit4] 2> 43766 INFO (qtp1731964853-309) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.c.S.Request [collection1_shard1_replica2] webapp=/solr
path=/config/znodeVersion params={overlay=0&wt=javabin&version=2} status=0
QTime=0
[junit4] 2> 43777 INFO (qtp1546178959-316) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.h.SolrConfigHandler I already have the expected version 0 of config
[junit4] 2> 43777 INFO (qtp1546178959-316) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.h.SolrConfigHandler isStale false , resourceloader
org.apache.solr.cloud.ZkSolrResourceLoader
[junit4] 2> 43777 INFO (qtp1546178959-316) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.c.S.Request [collection1_shard1_replica1] webapp=/solr
path=/config/znodeVersion params={overlay=0&wt=javabin&version=2} status=0
QTime=1
[junit4] 2> 43787 INFO (qtp1731964853-306) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.h.SolrConfigHandler Took 301.0ms to set the property overlay to be of
version 0 for collection collection1
[junit4] 2> 43787 INFO (qtp1731964853-306) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.c.S.Request [collection1_shard1_replica2] webapp=/solr path=/config
params={wt=json} status=0 QTime=347
[junit4] 2> 43787 INFO (qtp1731964853-306) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.c.SolrCore [collection1_shard1_replica2] CLOSING SolrCore
org.apache.solr.core.SolrCore@425c2f71
[junit4] 2> 43788 INFO (qtp1731964853-306) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.m.SolrMetricManager Closing metric reporters for:
solr.core.collection1.shard1.replica2
[junit4] 2> 43789 INFO
(TEST-TestReqParamsAPI.test-seed#[229553DB7D7CD29F]) [ ]
o.a.s.c.TestSolrConfigHandler going to send config command. path
/config?wt=json , payload: {
[junit4] 2> 'create-requesthandler' : { 'name' : '/dump1', 'class':
'org.apache.solr.handler.DumpRequestHandler', 'useParams':'x' }
[junit4] 2> }
[junit4] 2> 43793 INFO (qtp1731964853-308) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.c.ZkController Persisted config data to node
/configs/conf1/configoverlay.json
[junit4] 2> 43794 INFO (qtp1731964853-308) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.h.SolrConfigHandler Executed config commands successfully and persisted
to ZK [{"create-requesthandler":{
[junit4] 2> "name":"/dump1",
[junit4] 2> "class":"org.apache.solr.handler.DumpRequestHandler",
[junit4] 2> "useParams":"x"}}]
[junit4] 2> 43794 INFO (qtp1731964853-308) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.h.SolrConfigHandler Waiting up to 30 secs for 2 replicas to set the
property overlay to be of version 1 for collection collection1
[junit4] 2> 43805 INFO (Thread-59) [n:127.0.0.1:59233_solr ]
o.a.s.c.SolrCore config update listener called for core
collection1_shard1_replica2
[junit4] 2> 43807 INFO
(solrHandlerExecutor-87-thread-2-processing-n:127.0.0.1:59233_solr
x:collection1_shard1_replica2 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.h.SolrConfigHandler Time elapsed : 0 secs,
maxWait 30
[junit4] 2> 43809 INFO (Thread-59) [n:127.0.0.1:59233_solr ]
o.a.s.c.SolrCore core reload collection1_shard1_replica2
[junit4] 2> 43809 INFO (Thread-60) [n:127.0.0.1:59236_solr ]
o.a.s.c.SolrCore config update listener called for core
collection1_shard1_replica1
[junit4] 2> 43810 INFO (Thread-60) [n:127.0.0.1:59236_solr ]
o.a.s.c.SolrCore core reload collection1_shard1_replica1
[junit4] 2> 43811 INFO
(solrHandlerExecutor-87-thread-1-processing-n:127.0.0.1:59233_solr
x:collection1_shard1_replica2 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.h.SolrConfigHandler Time elapsed : 0 secs,
maxWait 30
[junit4] 2> 43876 INFO
(OverseerCollectionConfigSetProcessor-97470655374688261-127.0.0.1:59236_solr-n_0000000000)
[n:127.0.0.1:59236_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 43891 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 43891 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 43894 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@1c73bce6[collection1_shard1_replica1] main]
[junit4] 2> 43895 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.r.ManagedResourceStorage Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 43895 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 43895 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.r.ManagedResourceStorage Loaded null at
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 43895 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 43895 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper
watch for the managed schema at /configs/conf1/managed-schema
[junit4] 2> 43897 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.s.SolrIndexSearcher Opening
[Searcher@5173ce0e[collection1_shard1_replica2] main]
[junit4] 2> 43897 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.s.ZkIndexSchemaReader Current schema
version 0 is already the latest
[junit4] 2> 43897 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.h.ReplicationHandler Commits will be
reserved for 10000
[junit4] 2> 43897 INFO
(searcherExecutor-86-thread-1-processing-n:127.0.0.1:59236_solr
x:collection1_shard1_replica1 s:shard1 c:collection1 r:core_node2)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.c.SolrCore [collection1_shard1_replica1]
Registered new searcher Searcher@1c73bce6[collection1_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 43898 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.u.UpdateLog Could not find max version in
index or recent updates, using new clock 1559530491491647488
[junit4] 2> 43902 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.r.ManagedResourceStorage Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 43906 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.r.ManagedResourceStorage Loaded null at
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 43906 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper
watch for the managed schema at /configs/conf1/managed-schema
[junit4] 2> 43908 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.s.ZkIndexSchemaReader Current schema
version 0 is already the latest
[junit4] 2> 43908 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.h.ReplicationHandler Commits will be
reserved for 10000
[junit4] 2> 43908 INFO
(searcherExecutor-85-thread-1-processing-n:127.0.0.1:59233_solr
x:collection1_shard1_replica2 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.c.SolrCore [collection1_shard1_replica2]
Registered new searcher Searcher@5173ce0e[collection1_shard1_replica2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 43908 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.u.UpdateLog Could not find max version in
index or recent updates, using new clock 1559530491502133248
[junit4] 2> 43911 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.u.DefaultSolrCoreState New IndexWriter is
ready to be used.
[junit4] 2> 43911 INFO (qtp1546178959-315) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.h.SolrConfigHandler expecting overlay version 1 but my version is 0
[junit4] 2> 43911 INFO (qtp1546178959-315) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.c.S.Request [collection1_shard1_replica1] webapp=/solr
path=/config/znodeVersion params={overlay=1&wt=javabin&version=2} status=0
QTime=0
[junit4] 2> 43913 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.u.DefaultSolrCoreState New IndexWriter is
ready to be used.
[junit4] 2> 43913 INFO
(solrHandlerExecutor-87-thread-2-processing-n:127.0.0.1:59233_solr
x:collection1_shard1_replica2 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.h.SolrConfigHandler Could not get
expectedVersion 1 from http://127.0.0.1:59236/solr/collection1_shard1_replica1/
for prop overlay after 1 attempts
[junit4] 2> 43913 INFO
(solrHandlerExecutor-87-thread-2-processing-n:127.0.0.1:59233_solr
x:collection1_shard1_replica2 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.h.SolrConfigHandler Time elapsed : 0 secs,
maxWait 30
[junit4] 2> 43913 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@1749007[collection1_shard1_replica1] main]
[junit4] 2> 43913 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.s.SolrIndexSearcher Opening
[Searcher@8b8c5c3[collection1_shard1_replica2] main]
[junit4] 2> 43913 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.c.SolrCore [collection1_shard1_replica1]
CLOSING SolrCore org.apache.solr.core.SolrCore@432bad54
[junit4] 2> 43913 INFO
(searcherExecutor-86-thread-1-processing-n:127.0.0.1:59236_solr
x:collection1_shard1_replica1 s:shard1 c:collection1 r:core_node2)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.c.SolrCore [collection1_shard1_replica1]
Registered new searcher Searcher@1749007[collection1_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 43913 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.m.SolrMetricManager Closing metric
reporters for: solr.core.collection1.shard1.replica1
[junit4] 2> 43913 INFO
(searcherExecutor-85-thread-1-processing-n:127.0.0.1:59233_solr
x:collection1_shard1_replica2 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.c.SolrCore [collection1_shard1_replica2]
Registered new searcher Searcher@8b8c5c3[collection1_shard1_replica2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 43920 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.h.SolrConfigHandler Trying to update my
configs
[junit4] 2> 43920 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.c.SolrCore config update listener called
for core collection1_shard1_replica1
[junit4] 2> 43920 INFO (qtp1731964853-311) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.h.SolrConfigHandler expecting overlay version 1 but my version is 0
[junit4] 2> 43920 INFO (qtp1731964853-311) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.c.S.Request [collection1_shard1_replica2] webapp=/solr
path=/config/znodeVersion params={overlay=1&wt=javabin&version=2} status=0
QTime=0
[junit4] 2> 43921 INFO
(solrHandlerExecutor-87-thread-1-processing-n:127.0.0.1:59233_solr
x:collection1_shard1_replica2 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.h.SolrConfigHandler Could not get
expectedVersion 1 from http://127.0.0.1:59233/solr/collection1_shard1_replica2/
for prop overlay after 1 attempts
[junit4] 2> 43921 INFO
(solrHandlerExecutor-87-thread-1-processing-n:127.0.0.1:59233_solr
x:collection1_shard1_replica2 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.h.SolrConfigHandler Time elapsed : 0 secs,
maxWait 30
[junit4] 2> 43921 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.c.SolrCore core reload
collection1_shard1_replica1
[junit4] 2> 43922 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.h.SolrConfigHandler Trying to update my
configs
[junit4] 2> 43922 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.c.SolrCore config update listener called
for core collection1_shard1_replica2
[junit4] 2> 43922 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.c.SolrCore core reload
collection1_shard1_replica2
[junit4] 2> 43941 INFO (Thread-60) [n:127.0.0.1:59236_solr ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 43944 INFO (Thread-59) [n:127.0.0.1:59233_solr ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 43954 INFO (Thread-59) [n:127.0.0.1:59233_solr ]
o.a.s.s.IndexSchema [collection1_shard1_replica2] Schema name=minimal
[junit4] 2> 43955 INFO (Thread-60) [n:127.0.0.1:59236_solr ]
o.a.s.s.IndexSchema [collection1_shard1_replica1] Schema name=minimal
[junit4] 2> 43960 INFO (Thread-60) [n:127.0.0.1:59236_solr ]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 43960 INFO (Thread-59) [n:127.0.0.1:59233_solr ]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 43964 INFO (Thread-59) [n:127.0.0.1:59233_solr ]
o.a.s.c.CoreContainer Reloading SolrCore 'collection1_shard1_replica2' using
configuration from collection collection1
[junit4] 2> 43965 INFO (Thread-60) [n:127.0.0.1:59236_solr ]
o.a.s.c.CoreContainer Reloading SolrCore 'collection1_shard1_replica1' using
configuration from collection collection1
[junit4] 2> 43967 INFO (Thread-59) [n:127.0.0.1:59233_solr c:collection1
s:shard1 r:core_node1 x:collection1_shard1_replica2] o.a.s.c.SolrCore
[[collection1_shard1_replica2] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReqParamsAPI_229553DB7D7CD29F-001\tempDir-001\node2\collection1_shard1_replica2],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReqParamsAPI_229553DB7D7CD29F-001\tempDir-001\node2\.\collection1_shard1_replica2\data\]
[junit4] 2> 43967 INFO (Thread-60) [n:127.0.0.1:59236_solr c:collection1
s:shard1 r:core_node2 x:collection1_shard1_replica1] o.a.s.c.SolrCore
[[collection1_shard1_replica1] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReqParamsAPI_229553DB7D7CD29F-001\tempDir-001\node1\collection1_shard1_replica1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReqParamsAPI_229553DB7D7CD29F-001\tempDir-001\node1\.\collection1_shard1_replica1\data\]
[junit4] 2> 44016 INFO (qtp1546178959-320) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.h.SolrConfigHandler expecting overlay version 1 but my version is 0
[junit4] 2> 44016 INFO (qtp1546178959-320) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.c.S.Request [collection1_shard1_replica1] webapp=/solr
path=/config/znodeVersion params={overlay=1&wt=javabin&version=2} status=0
QTime=0
[junit4] 2> 44020 INFO
(solrHandlerExecutor-87-thread-2-processing-n:127.0.0.1:59233_solr
x:collection1_shard1_replica2 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.h.SolrConfigHandler Could not get
expectedVersion 1 from http://127.0.0.1:59236/solr/collection1_shard1_replica1/
for prop overlay after 2 attempts
[junit4] 2> 44020 INFO
(solrHandlerExecutor-87-thread-2-processing-n:127.0.0.1:59233_solr
x:collection1_shard1_replica2 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.h.SolrConfigHandler Time elapsed : 0 secs,
maxWait 30
[junit4] 2> 44022 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.h.SolrConfigHandler Trying to update my
configs
[junit4] 2> 44022 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.c.SolrCore config update listener called
for core collection1_shard1_replica1
[junit4] 2> 44023 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.c.SolrCore core reload
collection1_shard1_replica1
[junit4] 2> 44025 INFO (qtp1731964853-307) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.h.SolrConfigHandler expecting overlay version 1 but my version is 0
[junit4] 2> 44025 INFO (qtp1731964853-307) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.c.S.Request [collection1_shard1_replica2] webapp=/solr
path=/config/znodeVersion params={overlay=1&wt=javabin&version=2} status=0
QTime=0
[junit4] 2> 44027 INFO
(solrHandlerExecutor-87-thread-1-processing-n:127.0.0.1:59233_solr
x:collection1_shard1_replica2 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.h.SolrConfigHandler Could not get
expectedVersion 1 from http://127.0.0.1:59233/solr/collection1_shard1_replica2/
for prop overlay after 2 attempts
[junit4] 2> 44027 INFO
(solrHandlerExecutor-87-thread-1-processing-n:127.0.0.1:59233_solr
x:collection1_shard1_replica2 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.h.SolrConfigHandler Time elapsed : 0 secs,
maxWait 30
[junit4] 2> 44027 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.h.SolrConfigHandler Another reload is in
progress . Not doing anything
[junit4] 2> 44083 INFO (Thread-59) [n:127.0.0.1:59233_solr c:collection1
s:shard1 r:core_node1 x:collection1_shard1_replica2] o.a.s.u.CommitTracker Hard
AutoCommit: disabled
[junit4] 2> 44083 INFO (Thread-59) [n:127.0.0.1:59233_solr c:collection1
s:shard1 r:core_node1 x:collection1_shard1_replica2] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 44085 INFO (Thread-60) [n:127.0.0.1:59236_solr c:collection1
s:shard1 r:core_node2 x:collection1_shard1_replica1] o.a.s.u.CommitTracker Hard
AutoCommit: disabled
[junit4] 2> 44085 INFO (Thread-60) [n:127.0.0.1:59236_solr c:collection1
s:shard1 r:core_node2 x:collection1_shard1_replica1] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 44085 INFO (Thread-59) [n:127.0.0.1:59233_solr c:collection1
s:shard1 r:core_node1 x:collection1_shard1_replica2] o.a.s.s.SolrIndexSearcher
Opening [Searcher@1d89620c[collection1_shard1_replica2] main]
[junit4] 2> 44086 INFO (Thread-60) [n:127.0.0.1:59236_solr c:collection1
s:shard1 r:core_node2 x:collection1_shard1_replica1] o.a.s.s.SolrIndexSearcher
Opening [Searcher@33935ff5[collection1_shard1_replica1] main]
[junit4] 2> 44088 INFO (Thread-59) [n:127.0.0.1:59233_solr c:collection1
s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 44088 INFO (Thread-60) [n:127.0.0.1:59236_solr c:collection1
s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 44089 INFO (Thread-59) [n:127.0.0.1:59233_solr c:collection1
s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 44089 INFO (Thread-59) [n:127.0.0.1:59233_solr c:collection1
s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at
/configs/conf1/managed-schema
[junit4] 2> 44089 INFO (Thread-60) [n:127.0.0.1:59236_solr c:collection1
s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 44089 INFO (Thread-60) [n:127.0.0.1:59236_solr c:collection1
s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at
/configs/conf1/managed-schema
[junit4] 2> 44090 INFO (Thread-59) [n:127.0.0.1:59233_solr c:collection1
s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 44090 INFO (Thread-59) [n:127.0.0.1:59233_solr c:collection1
s:shard1 r:core_node1 x:collection1_shard1_replica2] o.a.s.h.ReplicationHandler
Commits will be reserved for 10000
[junit4] 2> 44090 INFO (Thread-60) [n:127.0.0.1:59236_solr c:collection1
s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 44091 INFO (Thread-60) [n:127.0.0.1:59236_solr c:collection1
s:shard1 r:core_node2 x:collection1_shard1_replica1] o.a.s.h.ReplicationHandler
Commits will be reserved for 10000
[junit4] 2> 44091 INFO (Thread-59) [n:127.0.0.1:59233_solr c:collection1
s:shard1 r:core_node1 x:collection1_shard1_replica2] o.a.s.u.UpdateLog Could
not find max version in index or recent updates, using new clock
1559530491694022656
[junit4] 2> 44091 INFO (Thread-60) [n:127.0.0.1:59236_solr c:collection1
s:shard1 r:core_node2 x:collection1_shard1_replica1] o.a.s.u.UpdateLog Could
not find max version in index or recent updates, using new clock
1559530491694022656
[junit4] 2> 44092 INFO
(searcherExecutor-94-thread-1-processing-n:127.0.0.1:59233_solr
x:collection1_shard1_replica2 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.c.SolrCore [collection1_shard1_replica2]
Registered new searcher Searcher@1d89620c[collection1_shard1_replica2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 44092 INFO
(searcherExecutor-95-thread-1-processing-n:127.0.0.1:59236_solr
x:collection1_shard1_replica1 s:shard1 c:collection1 r:core_node2)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.c.SolrCore [collection1_shard1_replica1]
Registered new searcher Searcher@33935ff5[collection1_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 44093 INFO (Thread-59) [n:127.0.0.1:59233_solr c:collection1
s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 44099 INFO (Thread-60) [n:127.0.0.1:59236_solr c:collection1
s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 44099 INFO (Thread-59) [n:127.0.0.1:59233_solr c:collection1
s:shard1 r:core_node1 x:collection1_shard1_replica2] o.a.s.s.SolrIndexSearcher
Opening [Searcher@48ad39d3[collection1_shard1_replica2] main]
[junit4] 2> 44099 INFO
(searcherExecutor-94-thread-1-processing-n:127.0.0.1:59233_solr
x:collection1_shard1_replica2 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.c.SolrCore [collection1_shard1_replica2]
Registered new searcher Searcher@48ad39d3[collection1_shard1_replica2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 44100 INFO (Thread-59) [n:127.0.0.1:59233_solr c:collection1
s:shard1 r:core_node1 x:collection1_shard1_replica2] o.a.s.c.SolrCore
[collection1_shard1_replica2] CLOSING SolrCore
org.apache.solr.core.SolrCore@28299373
[junit4] 2> 44100 INFO (Thread-59) [n:127.0.0.1:59233_solr c:collection1
s:shard1 r:core_node1 x:collection1_shard1_replica2] o.a.s.m.SolrMetricManager
Closing metric reporters for: solr.core.collection1.shard1.replica2
[junit4] 2> 44110 INFO (Thread-60) [n:127.0.0.1:59236_solr c:collection1
s:shard1 r:core_node2 x:collection1_shard1_replica1] o.a.s.s.SolrIndexSearcher
Opening [Searcher@5a311792[collection1_shard1_replica1] main]
[junit4] 2> 44112 INFO
(searcherExecutor-95-thread-1-processing-n:127.0.0.1:59236_solr
x:collection1_shard1_replica1 s:shard1 c:collection1 r:core_node2)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.c.SolrCore [collection1_shard1_replica1]
Registered new searcher Searcher@5a311792[collection1_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 44112 INFO (Thread-60) [n:127.0.0.1:59236_solr c:collection1
s:shard1 r:core_node2 x:collection1_shard1_replica1] o.a.s.c.SolrCore
[collection1_shard1_replica1] CLOSING SolrCore
org.apache.solr.core.SolrCore@458de0b9
[junit4] 2> 44114 INFO (Thread-60) [n:127.0.0.1:59236_solr c:collection1
s:shard1 r:core_node2 x:collection1_shard1_replica1] o.a.s.m.SolrMetricManager
Closing metric reporters for: solr.core.collection1.shard1.replica1
[junit4] 2> 44117 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.c.SolrConfig Using Lucene MatchVersion:
7.0.0
[junit4] 2> 44130 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.s.IndexSchema
[collection1_shard1_replica2] Schema name=minimal
[junit4] 2> 44132 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.c.SolrConfig Using Lucene MatchVersion:
7.0.0
[junit4] 2> 44136 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.s.IndexSchema Loaded schema minimal/1.1
with uniqueid field id
[junit4] 2> 44141 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.c.CoreContainer Reloading SolrCore
'collection1_shard1_replica2' using configuration from collection collection1
[junit4] 2> 44142 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.s.IndexSchema
[collection1_shard1_replica1] Schema name=minimal
[junit4] 2> 44145 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.s.IndexSchema Loaded schema minimal/1.1
with uniqueid field id
[junit4] 2> 44147 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.c.CoreContainer Reloading SolrCore
'collection1_shard1_replica1' using configuration from collection collection1
[junit4] 2> 44147 INFO (qtp1731964853-307) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.h.SolrConfigHandler I already have the expected version 1 of config
[junit4] 2> 44147 INFO (qtp1731964853-307) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.h.SolrConfigHandler isStale false , resourceloader
org.apache.solr.cloud.ZkSolrResourceLoader
[junit4] 2> 44147 INFO (qtp1731964853-307) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.c.S.Request [collection1_shard1_replica2] webapp=/solr
path=/config/znodeVersion params={overlay=1&wt=javabin&version=2} status=0
QTime=0
[junit4] 2> 44150 INFO (qtp1546178959-317) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.h.SolrConfigHandler I already have the expected version 1 of config
[junit4] 2> 44150 INFO (qtp1546178959-317) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.h.SolrConfigHandler isStale false , resourceloader
org.apache.solr.cloud.ZkSolrResourceLoader
[junit4] 2> 44150 INFO (qtp1546178959-317) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.c.S.Request [collection1_shard1_replica1] webapp=/solr
path=/config/znodeVersion params={overlay=1&wt=javabin&version=2} status=0
QTime=0
[junit4] 2> 44152 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.c.SolrCore [[collection1_shard1_replica2]
] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReqParamsAPI_229553DB7D7CD29F-001\tempDir-001\node2\collection1_shard1_replica2],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReqParamsAPI_229553DB7D7CD29F-001\tempDir-001\node2\.\collection1_shard1_replica2\data\]
[junit4] 2> 44153 INFO (qtp1731964853-308) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.h.SolrConfigHandler Took 358.0ms to set the property overlay to be of
version 1 for collection collection1
[junit4] 2> 44153 INFO (qtp1731964853-308) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.c.S.Request [collection1_shard1_replica2] webapp=/solr path=/config
params={wt=json} status=0 QTime=363
[junit4] 2> 44154 INFO (qtp1731964853-308) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.c.SolrCore [collection1_shard1_replica2] CLOSING SolrCore
org.apache.solr.core.SolrCore@5c8ff337
[junit4] 2> 44154 INFO (qtp1731964853-308) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.m.SolrMetricManager Closing metric reporters for:
solr.core.collection1.shard1.replica2
[junit4] 2> 44155 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.c.SolrCore [[collection1_shard1_replica1]
] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReqParamsAPI_229553DB7D7CD29F-001\tempDir-001\node1\collection1_shard1_replica1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReqParamsAPI_229553DB7D7CD29F-001\tempDir-001\node1\.\collection1_shard1_replica1\data\]
[junit4] 2> 44162 INFO
(TEST-TestReqParamsAPI.test-seed#[229553DB7D7CD29F]) [ ]
o.a.s.c.AbstractDistribZkTestBase Wait for recoveries to finish - collection:
collection1 failOnTimeout:true timeout (sec):90
[junit4] 2> 44163 INFO
(TEST-TestReqParamsAPI.test-seed#[229553DB7D7CD29F]) [ ]
o.a.s.c.AbstractDistribZkTestBase Recoveries finished - collection: collection1
[junit4] 2> 44163 INFO
(TEST-TestReqParamsAPI.test-seed#[229553DB7D7CD29F]) [ ]
o.a.s.c.TestSolrConfigHandler going to send config command. path
/config/params?wt=json , payload: {
[junit4] 2> 'set' : {'x': { 'a':'A val',
[junit4] 2> 'b': 'B val'}
[junit4] 2> }
[junit4] 2> }
[junit4] 2> 44169 INFO (qtp1731964853-309) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.h.SolrConfigHandler Waiting up to 30 secs for 2 replicas to set the
property params to be of version 0 for collection collection1
[junit4] 2> 44177 INFO (Thread-61) [n:127.0.0.1:59233_solr ]
o.a.s.c.SolrCore config update listener called for core
collection1_shard1_replica2
[junit4] 2> 44179 INFO (Thread-61) [n:127.0.0.1:59233_solr ]
o.a.s.c.RequestParams conf resource params.json loaded . version : 0
[junit4] 2> 44180 INFO (Thread-61) [n:127.0.0.1:59233_solr ]
o.a.s.c.RequestParams request params refreshed to version 0
[junit4] 2> 44183 INFO
(solrHandlerExecutor-104-thread-1-processing-n:127.0.0.1:59233_solr
x:collection1_shard1_replica2 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.h.SolrConfigHandler Time elapsed : 0 secs,
maxWait 30
[junit4] 2> 44183 INFO
(solrHandlerExecutor-104-thread-2-processing-n:127.0.0.1:59233_solr
x:collection1_shard1_replica2 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.h.SolrConfigHandler Time elapsed : 0 secs,
maxWait 30
[junit4] 2> 44183 INFO (Thread-62) [n:127.0.0.1:59236_solr ]
o.a.s.c.SolrCore config update listener called for core
collection1_shard1_replica1
[junit4] 2> 44185 INFO (Thread-62) [n:127.0.0.1:59236_solr ]
o.a.s.c.RequestParams conf resource params.json loaded . version : 0
[junit4] 2> 44185 INFO (Thread-62) [n:127.0.0.1:59236_solr ]
o.a.s.c.RequestParams request params refreshed to version 0
[junit4] 2> 44288 INFO (qtp1731964853-311) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.h.SolrConfigHandler I already have the expected version 0 of params
[junit4] 2> 44289 INFO (qtp1731964853-311) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.h.SolrConfigHandler isStale false , resourceloader
org.apache.solr.cloud.ZkSolrResourceLoader
[junit4] 2> 44289 INFO (qtp1731964853-311) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.c.S.Request [collection1_shard1_replica2] webapp=/solr
path=/config/znodeVersion params={params=0&wt=javabin&version=2} status=0
QTime=0
[junit4] 2> 44290 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 44291 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 44291 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 44291 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 44293 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@5c11aa10[collection1_shard1_replica1] main]
[junit4] 2> 44293 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.s.SolrIndexSearcher Opening
[Searcher@6596061a[collection1_shard1_replica2] main]
[junit4] 2> 44294 INFO (qtp1546178959-318) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.h.SolrConfigHandler I already have the expected version 0 of params
[junit4] 2> 44294 INFO (qtp1546178959-318) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1]
o.a.s.h.SolrConfigHandler isStale false , resourceloader
org.apache.solr.cloud.ZkSolrResourceLoader
[junit4] 2> 44294 INFO (qtp1546178959-318) [n:127.0.0.1:59236_solr
c:collection1 s:shard1 r:core_node2 x:colle
[...truncated too long message...]
p=/solr path=/dump0 params={wt=json&useParams=x} status=0 QTime=0
[junit4] 2> 48750 INFO (qtp1731964853-308) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.c.S.Request [collection1_shard1_replica2] webapp=/solr path=/dump0
params={wt=json&useParams=x} status=0 QTime=0
[junit4] 2> 48851 INFO (qtp1731964853-306) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.c.S.Request [collection1_shard1_replica2] webapp=/solr path=/dump0
params={wt=json&useParams=x} status=0 QTime=0
[junit4] 2> 48953 INFO (qtp1731964853-307) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.c.S.Request [collection1_shard1_replica2] webapp=/solr path=/dump0
params={wt=json&useParams=x} status=0 QTime=0
[junit4] 2> 49060 INFO (qtp1731964853-311) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.c.S.Request [collection1_shard1_replica2] webapp=/solr path=/dump0
params={wt=json&useParams=x} status=0 QTime=0
[junit4] 2> 49161 INFO (qtp1731964853-309) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.c.S.Request [collection1_shard1_replica2] webapp=/solr path=/dump0
params={wt=json&useParams=x} status=0 QTime=0
[junit4] 2> 49262 INFO (qtp1731964853-313) [n:127.0.0.1:59233_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica2]
o.a.s.c.S.Request [collection1_shard1_replica2] webapp=/solr path=/dump0
params={wt=json&useParams=x} status=0 QTime=0
[junit4] 2> 49363 INFO
(TEST-TestReqParamsAPI.test-seed#[229553DB7D7CD29F]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending test
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestReqParamsAPI
-Dtests.method=test -Dtests.seed=229553DB7D7CD29F -Dtests.slow=true
-Dtests.locale=th-TH-u-nu-thai-x-lvariant-TH
-Dtests.timezone=Atlantic/South_Georgia -Dtests.asserts=true
-Dtests.file.encoding=UTF-8
[junit4] FAILURE 5.96s J1 | TestReqParamsAPI.test <<<
[junit4] > Throwable #1: java.lang.AssertionError: Could not get expected
value 'A val' for path 'params/a' full output: {
[junit4] > "responseHeader":{
[junit4] > "status":0,
[junit4] > "QTime":0},
[junit4] > "params":{
[junit4] > "wt":"json",
[junit4] > "useParams":""},
[junit4] > "context":{
[junit4] > "webapp":"/solr",
[junit4] > "path":"/dump0",
[junit4] > "httpMethod":"GET"}}, from server:
http://127.0.0.1:59233/solr/collection1_shard1_replica2
[junit4] > at
__randomizedtesting.SeedInfo.seed([229553DB7D7CD29F:AAC16C01D380BF67]:0)
[junit4] > at
org.apache.solr.core.TestSolrConfigHandler.testForResponseElement(TestSolrConfigHandler.java:556)
[junit4] > at
org.apache.solr.handler.TestReqParamsAPI.testReqParams(TestReqParamsAPI.java:127)
[junit4] > at
org.apache.solr.handler.TestReqParamsAPI.test(TestReqParamsAPI.java:69)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 49372 INFO (jetty-launcher-62-thread-1) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@42c48418{HTTP/1.1,[http/1.1]}{127.0.0.1:?}
[junit4] 2> 49372 INFO (jetty-launcher-62-thread-2) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@1da0fbdb{HTTP/1.1,[http/1.1]}{127.0.0.1:?}
[junit4] 2> 49372 INFO (jetty-launcher-62-thread-1) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1612457185
[junit4] 2> 49373 INFO (jetty-launcher-62-thread-2) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=208091933
[junit4] 2> 49377 INFO (coreCloseExecutor-115-thread-1)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.c.SolrCore [collection1_shard1_replica2]
CLOSING SolrCore org.apache.solr.core.SolrCore@6ec13d37
[junit4] 2> 49377 INFO (coreCloseExecutor-116-thread-1)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.c.SolrCore [collection1_shard1_replica1]
CLOSING SolrCore org.apache.solr.core.SolrCore@b0d0242
[junit4] 2> 49381 INFO (coreCloseExecutor-115-thread-1)
[n:127.0.0.1:59233_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica2] o.a.s.m.SolrMetricManager Closing metric
reporters for: solr.core.collection1.shard1.replica2
[junit4] 2> 49383 INFO
(zkCallback-73-thread-1-processing-n:127.0.0.1:59233_solr)
[n:127.0.0.1:59233_solr ] 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> 49383 INFO
(zkCallback-72-thread-3-processing-n:127.0.0.1:59236_solr)
[n:127.0.0.1:59236_solr ] 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> 49384 INFO (coreCloseExecutor-116-thread-1)
[n:127.0.0.1:59236_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica1] o.a.s.m.SolrMetricManager Closing metric
reporters for: solr.core.collection1.shard1.replica1
[junit4] 2> 49387 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15a490b6da20006, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 49387 WARN
(zkCallback-73-thread-1-processing-n:127.0.0.1:59233_solr)
[n:127.0.0.1:59233_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 49389 INFO
(zkCallback-72-thread-2-processing-n:127.0.0.1:59236_solr)
[n:127.0.0.1:59236_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (1)
[junit4] 2> 49390 INFO (jetty-launcher-62-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 49390 INFO (jetty-launcher-62-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@14c8f161{/solr,null,UNAVAILABLE}
[junit4] 2> 49391 INFO (jetty-launcher-62-thread-2) [ ]
o.a.s.c.Overseer Overseer
(id=97470655374688261-127.0.0.1:59236_solr-n_0000000000) closing
[junit4] 2> 49391 INFO
(OverseerStateUpdate-97470655374688261-127.0.0.1:59236_solr-n_0000000000)
[n:127.0.0.1:59236_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:59236_solr
[junit4] 2> 49394 WARN
(zkCallback-72-thread-2-processing-n:127.0.0.1:59236_solr)
[n:127.0.0.1:59236_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 49395 INFO (jetty-launcher-62-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 49395 INFO (jetty-launcher-62-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@e101987{/solr,null,UNAVAILABLE}
[junit4] 2> 49396 INFO
(SUITE-TestReqParamsAPI-seed#[229553DB7D7CD29F]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:59229 59229
[junit4] 2> 49398 INFO (Thread-38) [ ] o.a.s.c.ZkTestServer connecting
to 127.0.0.1:59229 59229
[junit4] 2> 49400 WARN (Thread-38) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 11 /solr/configs/conf1/managed-schema
[junit4] 2> 8 /solr/configs/conf1
[junit4] 2> 3 /solr/aliases.json
[junit4] 2> 3 /solr/clusterprops.json
[junit4] 2> 2 /solr/security.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 3 /solr/clusterstate.json
[junit4] 2> 2 /solr/collections/collection1/state.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 13 /solr/overseer/queue
[junit4] 2> 7 /solr/overseer/collection-queue-work
[junit4] 2> 3 /solr/live_nodes
[junit4] 2> 3 /solr/collections
[junit4] 2> 3 /solr/overseer/queue-work
[junit4] 2>
[junit4] 2> 49400 INFO
(SUITE-TestReqParamsAPI-seed#[229553DB7D7CD29F]-worker) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReqParamsAPI_229553DB7D7CD29F-001
[junit4] 2> Feb 16, 2017 10:29:40 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 4 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=CheapBastard,
sim=RandomSimilarity(queryNorm=true): {}, locale=th-TH-u-nu-thai-x-lvariant-TH,
timezone=Atlantic/South_Georgia
[junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 1.8.0_121
(64-bit)/cpus=3,threads=1,free=123907968,total=227016704
[junit4] 2> NOTE: All tests run in this JVM: [TestLeaderElectionZkExpiry,
RuleEngineTest, TestReversedWildcardFilterFactory, HdfsDirectoryFactoryTest,
OverriddenZkACLAndCredentialsProvidersTest, TestJoin, HdfsRecoveryZkTest,
TestReqParamsAPI]
[junit4] Completed [8/694 (1!)] on J1 in 11.02s, 1 test, 1 failure <<<
FAILURES!
[...truncated 64838 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
