Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Solaris/982/
Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseSerialGC
1 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.search.stats.TestDistribIDF
Error Message:
1 thread leaked from SUITE scope at
org.apache.solr.search.stats.TestDistribIDF: 1) Thread[id=54257,
name=OverseerHdfsCoreFailoverThread-97029437477158917-127.0.0.1:44203_solr-n_0000000002,
state=TIMED_WAITING, group=Overseer Hdfs SolrCore Failover Thread.] at
java.lang.Thread.sleep(Native Method) at
org.apache.solr.cloud.OverseerAutoReplicaFailoverThread.run(OverseerAutoReplicaFailoverThread.java:137)
at java.lang.Thread.run(Thread.java:745)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE
scope at org.apache.solr.search.stats.TestDistribIDF:
1) Thread[id=54257,
name=OverseerHdfsCoreFailoverThread-97029437477158917-127.0.0.1:44203_solr-n_0000000002,
state=TIMED_WAITING, group=Overseer Hdfs SolrCore Failover Thread.]
at java.lang.Thread.sleep(Native Method)
at
org.apache.solr.cloud.OverseerAutoReplicaFailoverThread.run(OverseerAutoReplicaFailoverThread.java:137)
at java.lang.Thread.run(Thread.java:745)
at __randomizedtesting.SeedInfo.seed([D55A06E42A659E6F]:0)
Build Log:
[...truncated 12557 lines...]
[junit4] Suite: org.apache.solr.search.stats.TestDistribIDF
[junit4] 2> Creating dataDir:
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.search.stats.TestDistribIDF_D55A06E42A659E6F-001/init-core-data-001
[junit4] 2> 2468325 INFO
(SUITE-TestDistribIDF-seed#[D55A06E42A659E6F]-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> 2468329 INFO
(TEST-TestDistribIDF.testMultiCollectionQuery-seed#[D55A06E42A659E6F]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testMultiCollectionQuery
[junit4] 2> 2468329 INFO
(TEST-TestDistribIDF.testMultiCollectionQuery-seed#[D55A06E42A659E6F]) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 3 servers in
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.search.stats.TestDistribIDF_D55A06E42A659E6F-001/tempDir-001
[junit4] 2> 2468329 INFO
(TEST-TestDistribIDF.testMultiCollectionQuery-seed#[D55A06E42A659E6F]) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2468329 INFO (Thread-12347) [ ] o.a.s.c.ZkTestServer
client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2468329 INFO (Thread-12347) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 2468429 INFO
(TEST-TestDistribIDF.testMultiCollectionQuery-seed#[D55A06E42A659E6F]) [ ]
o.a.s.c.ZkTestServer start zk server on port:62536
[junit4] 2> 2468449 INFO (jetty-launcher-10582-thread-1) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 2468449 INFO (jetty-launcher-10582-thread-2) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 2468449 INFO (jetty-launcher-10582-thread-3) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 2468451 INFO (jetty-launcher-10582-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@c276d45{/solr,null,AVAILABLE}
[junit4] 2> 2468452 INFO (jetty-launcher-10582-thread-3) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@4885c814{/solr,null,AVAILABLE}
[junit4] 2> 2468452 INFO (jetty-launcher-10582-thread-2) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@673ad272{HTTP/1.1,[http/1.1]}{127.0.0.1:60562}
[junit4] 2> 2468452 INFO (jetty-launcher-10582-thread-2) [ ]
o.e.j.s.Server Started @2471965ms
[junit4] 2> 2468452 INFO (jetty-launcher-10582-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=60562}
[junit4] 2> 2468453 ERROR (jetty-launcher-10582-thread-2) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2468453 INFO (jetty-launcher-10582-thread-3) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@4d384cd6{HTTP/1.1,[http/1.1]}{127.0.0.1:60141}
[junit4] 2> 2468453 INFO (jetty-launcher-10582-thread-3) [ ]
o.e.j.s.Server Started @2471965ms
[junit4] 2> 2468453 INFO (jetty-launcher-10582-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.0.0
[junit4] 2> 2468453 INFO (jetty-launcher-10582-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=60141}
[junit4] 2> 2468453 INFO (jetty-launcher-10582-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2468453 ERROR (jetty-launcher-10582-thread-3) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2468453 INFO (jetty-launcher-10582-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@65070b98{/solr,null,AVAILABLE}
[junit4] 2> 2468453 INFO (jetty-launcher-10582-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2468453 INFO (jetty-launcher-10582-thread-3) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.0.0
[junit4] 2> 2468453 INFO (jetty-launcher-10582-thread-3) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2468453 INFO (jetty-launcher-10582-thread-1) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@3052cf4b{HTTP/1.1,[http/1.1]}{127.0.0.1:44203}
[junit4] 2> 2468454 INFO (jetty-launcher-10582-thread-1) [ ]
o.e.j.s.Server Started @2471966ms
[junit4] 2> 2468454 INFO (jetty-launcher-10582-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=44203}
[junit4] 2> 2468453 INFO (jetty-launcher-10582-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2016-12-01T00:21:59.439Z
[junit4] 2> 2468454 ERROR (jetty-launcher-10582-thread-1) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2468454 INFO (jetty-launcher-10582-thread-3) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2468454 INFO (jetty-launcher-10582-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.0.0
[junit4] 2> 2468454 INFO (jetty-launcher-10582-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2468454 INFO (jetty-launcher-10582-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2468454 INFO (jetty-launcher-10582-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2016-12-01T00:21:59.440Z
[junit4] 2> 2468454 INFO (jetty-launcher-10582-thread-3) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2016-12-01T00:21:59.440Z
[junit4] 2> 2468457 INFO (jetty-launcher-10582-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2468457 INFO (jetty-launcher-10582-thread-3) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2468457 INFO (jetty-launcher-10582-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2468463 INFO (jetty-launcher-10582-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:62536/solr
[junit4] 2> 2468464 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 0x158b7c261950002, 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> 2468466 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 0x158b7c261950003, 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> 2468466 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 0x158b7c261950001, 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> 2468467 INFO (jetty-launcher-10582-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:62536/solr
[junit4] 2> 2468469 INFO (jetty-launcher-10582-thread-3) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:62536/solr
[junit4] 2> 2468500 INFO (jetty-launcher-10582-thread-2)
[n:127.0.0.1:60562_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:60562_solr
[junit4] 2> 2468501 INFO (jetty-launcher-10582-thread-3)
[n:127.0.0.1:60141_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:60141_solr
[junit4] 2> 2468501 INFO (jetty-launcher-10582-thread-2)
[n:127.0.0.1:60562_solr ] o.a.s.c.Overseer Overseer
(id=97029437477158920-127.0.0.1:60562_solr-n_0000000000) starting
[junit4] 2> 2468513 INFO (jetty-launcher-10582-thread-2)
[n:127.0.0.1:60562_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:60562_solr
[junit4] 2> 2468524 INFO
(zkCallback-10598-thread-1-processing-n:127.0.0.1:60141_solr)
[n:127.0.0.1:60141_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 2468531 INFO (jetty-launcher-10582-thread-3)
[n:127.0.0.1:60141_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.search.stats.TestDistribIDF_D55A06E42A659E6F-001/tempDir-001/node3/.
[junit4] 2> 2468533 INFO
(OverseerStateUpdate-97029437477158920-127.0.0.1:60562_solr-n_0000000000)
[n:127.0.0.1:60562_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 2468537 INFO
(zkCallback-10593-thread-2-processing-n:127.0.0.1:44203_solr)
[n:127.0.0.1:44203_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 2468539 INFO (jetty-launcher-10582-thread-1)
[n:127.0.0.1:44203_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:44203_solr
[junit4] 2> 2468541 INFO
(zkCallback-10593-thread-1-processing-n:127.0.0.1:44203_solr)
[n:127.0.0.1:44203_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 2468558 INFO
(zkCallback-10598-thread-1-processing-n:127.0.0.1:60141_solr)
[n:127.0.0.1:60141_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 2468559 INFO
(zkCallback-10597-thread-2-processing-n:127.0.0.1:60562_solr)
[n:127.0.0.1:60562_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 2468585 INFO (jetty-launcher-10582-thread-2)
[n:127.0.0.1:60562_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.search.stats.TestDistribIDF_D55A06E42A659E6F-001/tempDir-001/node2/.
[junit4] 2> 2468637 INFO (jetty-launcher-10582-thread-1)
[n:127.0.0.1:44203_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.search.stats.TestDistribIDF_D55A06E42A659E6F-001/tempDir-001/node1/.
[junit4] 2> 2469226 INFO
(TEST-TestDistribIDF.testMultiCollectionQuery-seed#[D55A06E42A659E6F]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 2469228 INFO
(TEST-TestDistribIDF.testMultiCollectionQuery-seed#[D55A06E42A659E6F]) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:62536/solr ready
[junit4] 2> 2469230 INFO (qtp549509694-54113) [n:127.0.0.1:60562_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=1&collection.configName=conf1&maxShardsPerNode=1&name=collection1&action=CREATE&numShards=2&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2469233 INFO
(OverseerThreadFactory-12451-thread-1-processing-n:127.0.0.1:60562_solr)
[n:127.0.0.1:60562_solr ] o.a.s.c.CreateCollectionCmd Create collection
collection1
[junit4] 2> 2469340 INFO (qtp549509694-54115) [n:127.0.0.1:60562_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=2&collection=collection1&shard=shard1&wt=javabin&version=2
[junit4] 2> 2469340 INFO (qtp495418013-54121) [n:127.0.0.1:60141_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf1&newCollection=true&name=collection1_shard2_replica1&action=CREATE&numShards=2&collection=collection1&shard=shard2&wt=javabin&version=2
[junit4] 2> 2469450 INFO
(zkCallback-10598-thread-1-processing-n:127.0.0.1:60141_solr)
[n:127.0.0.1:60141_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: [3])
[junit4] 2> 2469451 INFO
(zkCallback-10597-thread-3-processing-n:127.0.0.1:60562_solr)
[n:127.0.0.1:60562_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: [3])
[junit4] 2> 2470375 WARN (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.Config Beginning
with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 2470377 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 7.0.0
[junit4] 2> 2470399 WARN (qtp495418013-54121) [n:127.0.0.1:60141_solr
c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.c.Config Beginning
with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 2470401 INFO (qtp495418013-54121) [n:127.0.0.1:60141_solr
c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 7.0.0
[junit4] 2> 2470407 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.s.IndexSchema
[collection1_shard1_replica1] Schema name=test
[junit4] 2> 2470450 INFO (qtp495418013-54121) [n:127.0.0.1:60141_solr
c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.s.IndexSchema
[collection1_shard2_replica1] Schema name=test
[junit4] 2> 2470520 WARN (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.s.IndexSchema
[collection1_shard1_replica1] default search field in schema is text. WARNING:
Deprecated, please use 'df' on request instead.
[junit4] 2> 2470522 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.s.IndexSchema
Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 2470536 INFO (qtp549509694-54115) [n:127.0.0.1:60562_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> 2470537 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica1]
o.a.s.c.SolrCore [[collection1_shard1_replica1] ] Opening new SolrCore at
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.search.stats.TestDistribIDF_D55A06E42A659E6F-001/tempDir-001/node2/collection1_shard1_replica1],
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.search.stats.TestDistribIDF_D55A06E42A659E6F-001/tempDir-001/node2/./collection1_shard1_replica1/data/]
[junit4] 2> 2470537 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica1]
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@3750ef26
[junit4] 2> 2470538 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=31, maxMergeAtOnceExplicit=14, maxMergedSegmentMB=36.88671875,
floorSegmentMB=2.17578125, forceMergeDeletesPctAllowed=13.566005280621589,
segmentsPerTier=19.0, maxCFSSegmentSizeMB=1.078125,
noCFSRatio=0.7488659343794114
[junit4] 2> 2470565 WARN (qtp495418013-54121) [n:127.0.0.1:60141_solr
c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.s.IndexSchema
[collection1_shard2_replica1] default search field in schema is text. WARNING:
Deprecated, please use 'df' on request instead.
[junit4] 2> 2470567 INFO (qtp495418013-54121) [n:127.0.0.1:60141_solr
c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.s.IndexSchema
Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 2470573 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 2470573 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2470579 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2470582 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2470583 INFO (qtp495418013-54121) [n:127.0.0.1:60141_solr
c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1_shard2_replica1' using configuration from
collection collection1
[junit4] 2> 2470584 INFO (qtp495418013-54121) [n:127.0.0.1:60141_solr
c:collection1 s:shard2 r:core_node2 x:collection1_shard2_replica1]
o.a.s.c.SolrCore [[collection1_shard2_replica1] ] Opening new SolrCore at
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.search.stats.TestDistribIDF_D55A06E42A659E6F-001/tempDir-001/node3/collection1_shard2_replica1],
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.search.stats.TestDistribIDF_D55A06E42A659E6F-001/tempDir-001/node3/./collection1_shard2_replica1/data/]
[junit4] 2> 2470584 INFO (qtp495418013-54121) [n:127.0.0.1:60141_solr
c:collection1 s:shard2 r:core_node2 x:collection1_shard2_replica1]
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@3750ef26
[junit4] 2> 2470585 INFO (qtp495418013-54121) [n:127.0.0.1:60141_solr
c:collection1 s:shard2 r:core_node2 x:collection1_shard2_replica1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=31, maxMergeAtOnceExplicit=14, maxMergedSegmentMB=36.88671875,
floorSegmentMB=2.17578125, forceMergeDeletesPctAllowed=13.566005280621589,
segmentsPerTier=19.0, maxCFSSegmentSizeMB=1.078125,
noCFSRatio=0.7488659343794114
[junit4] 2> 2470588 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=26, maxMergeAtOnceExplicit=45, maxMergedSegmentMB=85.197265625,
floorSegmentMB=0.6767578125, forceMergeDeletesPctAllowed=21.366476022658585,
segmentsPerTier=40.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 2470588 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@4d7f0200[collection1_shard1_replica1] main]
[junit4] 2> 2470594 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica1]
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 2470598 INFO (qtp495418013-54121) [n:127.0.0.1:60141_solr
c:collection1 s:shard2 r:core_node2 x:collection1_shard2_replica1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 2470598 INFO (qtp495418013-54121) [n:127.0.0.1:60141_solr
c:collection1 s:shard2 r:core_node2 x:collection1_shard2_replica1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2470599 INFO (qtp495418013-54121) [n:127.0.0.1:60141_solr
c:collection1 s:shard2 r:core_node2 x:collection1_shard2_replica1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2470599 INFO (qtp495418013-54121) [n:127.0.0.1:60141_solr
c:collection1 s:shard2 r:core_node2 x:collection1_shard2_replica1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2470599 INFO (qtp495418013-54121) [n:127.0.0.1:60141_solr
c:collection1 s:shard2 r:core_node2 x:collection1_shard2_replica1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=26, maxMergeAtOnceExplicit=45, maxMergedSegmentMB=85.197265625,
floorSegmentMB=0.6767578125, forceMergeDeletesPctAllowed=21.366476022658585,
segmentsPerTier=40.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 2470599 INFO (qtp495418013-54121) [n:127.0.0.1:60141_solr
c:collection1 s:shard2 r:core_node2 x:collection1_shard2_replica1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@756ab89b[collection1_shard2_replica1] main]
[junit4] 2> 2470601 INFO (qtp495418013-54121) [n:127.0.0.1:60141_solr
c:collection1 s:shard2 r:core_node2 x:collection1_shard2_replica1]
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 2470604 INFO (qtp495418013-54121) [n:127.0.0.1:60141_solr
c:collection1 s:shard2 r:core_node2 x:collection1_shard2_replica1]
o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 2470605 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica1]
o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 2470623 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 2470623 INFO (qtp495418013-54121) [n:127.0.0.1:60141_solr
c:collection1 s:shard2 r:core_node2 x:collection1_shard2_replica1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 2470624 INFO
(searcherExecutor-12463-thread-1-processing-n:127.0.0.1:60141_solr
x:collection1_shard2_replica1 s:shard2 c:collection1 r:core_node2)
[n:127.0.0.1:60141_solr c:collection1 s:shard2 r:core_node2
x:collection1_shard2_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: default
[junit4] 2> 2470624 INFO (qtp495418013-54121) [n:127.0.0.1:60141_solr
c:collection1 s:shard2 r:core_node2 x:collection1_shard2_replica1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1552471002038927360
[junit4] 2> 2470624 INFO
(searcherExecutor-12463-thread-1-processing-n:127.0.0.1:60141_solr
x:collection1_shard2_replica1 s:shard2 c:collection1 r:core_node2)
[n:127.0.0.1:60141_solr c:collection1 s:shard2 r:core_node2
x:collection1_shard2_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: direct
[junit4] 2> 2470624 INFO
(searcherExecutor-12463-thread-1-processing-n:127.0.0.1:60141_solr
x:collection1_shard2_replica1 s:shard2 c:collection1 r:core_node2)
[n:127.0.0.1:60141_solr c:collection1 s:shard2 r:core_node2
x:collection1_shard2_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: wordbreak
[junit4] 2> 2470625 INFO
(searcherExecutor-12463-thread-1-processing-n:127.0.0.1:60141_solr
x:collection1_shard2_replica1 s:shard2 c:collection1 r:core_node2)
[n:127.0.0.1:60141_solr c:collection1 s:shard2 r:core_node2
x:collection1_shard2_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: multipleFields
[junit4] 2> 2470625 INFO
(searcherExecutor-12463-thread-1-processing-n:127.0.0.1:60141_solr
x:collection1_shard2_replica1 s:shard2 c:collection1 r:core_node2)
[n:127.0.0.1:60141_solr c:collection1 s:shard2 r:core_node2
x:collection1_shard2_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: jarowinkler
[junit4] 2> 2470625 INFO
(searcherExecutor-12463-thread-1-processing-n:127.0.0.1:60141_solr
x:collection1_shard2_replica1 s:shard2 c:collection1 r:core_node2)
[n:127.0.0.1:60141_solr c:collection1 s:shard2 r:core_node2
x:collection1_shard2_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: external
[junit4] 2> 2470626 INFO
(searcherExecutor-12463-thread-1-processing-n:127.0.0.1:60141_solr
x:collection1_shard2_replica1 s:shard2 c:collection1 r:core_node2)
[n:127.0.0.1:60141_solr c:collection1 s:shard2 r:core_node2
x:collection1_shard2_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: freq
[junit4] 2> 2470626 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1552471002041024512
[junit4] 2> 2470626 INFO
(searcherExecutor-12463-thread-1-processing-n:127.0.0.1:60141_solr
x:collection1_shard2_replica1 s:shard2 c:collection1 r:core_node2)
[n:127.0.0.1:60141_solr c:collection1 s:shard2 r:core_node2
x:collection1_shard2_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: fqcn
[junit4] 2> 2470627 INFO
(searcherExecutor-12463-thread-1-processing-n:127.0.0.1:60141_solr
x:collection1_shard2_replica1 s:shard2 c:collection1 r:core_node2)
[n:127.0.0.1:60141_solr c:collection1 s:shard2 r:core_node2
x:collection1_shard2_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: perDict
[junit4] 2> 2470627 INFO
(searcherExecutor-12463-thread-1-processing-n:127.0.0.1:60141_solr
x:collection1_shard2_replica1 s:shard2 c:collection1 r:core_node2)
[n:127.0.0.1:60141_solr c:collection1 s:shard2 r:core_node2
x:collection1_shard2_replica1] o.a.s.c.SolrCore [collection1_shard2_replica1]
Registered new searcher Searcher@756ab89b[collection1_shard2_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2470628 INFO
(searcherExecutor-12458-thread-1-processing-n:127.0.0.1:60562_solr
x:collection1_shard1_replica1 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:60562_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: default
[junit4] 2> 2470629 INFO
(searcherExecutor-12458-thread-1-processing-n:127.0.0.1:60562_solr
x:collection1_shard1_replica1 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:60562_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: direct
[junit4] 2> 2470629 INFO
(searcherExecutor-12458-thread-1-processing-n:127.0.0.1:60562_solr
x:collection1_shard1_replica1 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:60562_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: wordbreak
[junit4] 2> 2470630 INFO
(searcherExecutor-12458-thread-1-processing-n:127.0.0.1:60562_solr
x:collection1_shard1_replica1 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:60562_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: multipleFields
[junit4] 2> 2470631 INFO
(searcherExecutor-12458-thread-1-processing-n:127.0.0.1:60562_solr
x:collection1_shard1_replica1 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:60562_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: jarowinkler
[junit4] 2> 2470633 INFO
(searcherExecutor-12458-thread-1-processing-n:127.0.0.1:60562_solr
x:collection1_shard1_replica1 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:60562_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: external
[junit4] 2> 2470633 INFO
(searcherExecutor-12458-thread-1-processing-n:127.0.0.1:60562_solr
x:collection1_shard1_replica1 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:60562_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: freq
[junit4] 2> 2470633 INFO
(searcherExecutor-12458-thread-1-processing-n:127.0.0.1:60562_solr
x:collection1_shard1_replica1 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:60562_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: fqcn
[junit4] 2> 2470634 INFO
(searcherExecutor-12458-thread-1-processing-n:127.0.0.1:60562_solr
x:collection1_shard1_replica1 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:60562_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: perDict
[junit4] 2> 2470634 INFO
(searcherExecutor-12458-thread-1-processing-n:127.0.0.1:60562_solr
x:collection1_shard1_replica1 s:shard1 c:collection1 r:core_node1)
[n:127.0.0.1:60562_solr c:collection1 s:shard1 r:core_node1
x:collection1_shard1_replica1] o.a.s.c.SolrCore [collection1_shard1_replica1]
Registered new searcher Searcher@4d7f0200[collection1_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2470636 INFO (qtp495418013-54121) [n:127.0.0.1:60141_solr
c:collection1 s:shard2 r:core_node2 x:collection1_shard2_replica1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 2470637 INFO (qtp495418013-54121) [n:127.0.0.1:60141_solr
c:collection1 s:shard2 r:core_node2 x:collection1_shard2_replica1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 2470637 INFO (qtp495418013-54121) [n:127.0.0.1:60141_solr
c:collection1 s:shard2 r:core_node2 x:collection1_shard2_replica1]
o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:60141/solr/collection1_shard2_replica1/
[junit4] 2> 2470637 INFO (qtp495418013-54121) [n:127.0.0.1:60141_solr
c:collection1 s:shard2 r:core_node2 x:collection1_shard2_replica1]
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 2470637 INFO (qtp495418013-54121) [n:127.0.0.1:60141_solr
c:collection1 s:shard2 r:core_node2 x:collection1_shard2_replica1]
o.a.s.c.SyncStrategy http://127.0.0.1:60141/solr/collection1_shard2_replica1/
has no replicas
[junit4] 2> 2470644 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 2470644 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 2470644 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica1]
o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:60562/solr/collection1_shard1_replica1/
[junit4] 2> 2470644 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica1]
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 2470644 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica1]
o.a.s.c.SyncStrategy http://127.0.0.1:60562/solr/collection1_shard1_replica1/
has no replicas
[junit4] 2> 2470649 INFO (qtp495418013-54121) [n:127.0.0.1:60141_solr
c:collection1 s:shard2 r:core_node2 x:collection1_shard2_replica1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:60141/solr/collection1_shard2_replica1/ shard2
[junit4] 2> 2470654 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:60562/solr/collection1_shard1_replica1/ shard1
[junit4] 2> 2470758 INFO
(zkCallback-10598-thread-1-processing-n:127.0.0.1:60141_solr)
[n:127.0.0.1:60141_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: [3])
[junit4] 2> 2470758 INFO
(zkCallback-10597-thread-2-processing-n:127.0.0.1:60562_solr)
[n:127.0.0.1:60562_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: [3])
[junit4] 2> 2470802 INFO (qtp495418013-54121) [n:127.0.0.1:60141_solr
c:collection1 s:shard2 r:core_node2 x:collection1_shard2_replica1]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 2470805 INFO (qtp495418013-54121) [n:127.0.0.1:60141_solr
c:collection1 s:shard2 r:core_node2 x:collection1_shard2_replica1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf1&newCollection=true&name=collection1_shard2_replica1&action=CREATE&numShards=2&collection=collection1&shard=shard2&wt=javabin&version=2}
status=0 QTime=1464
[junit4] 2> 2470806 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection1 s:shard1 r:core_node1 x:collection1_shard1_replica1]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 2470810 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection1 s:shard1 r:core_node1 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=2&collection=collection1&shard=shard1&wt=javabin&version=2}
status=0 QTime=1471
[junit4] 2> 2470815 INFO (qtp549509694-54113) [n:127.0.0.1:60562_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> 2470917 INFO
(zkCallback-10598-thread-1-processing-n:127.0.0.1:60141_solr)
[n:127.0.0.1:60141_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: [3])
[junit4] 2> 2470919 INFO
(zkCallback-10597-thread-1-processing-n:127.0.0.1:60562_solr)
[n:127.0.0.1:60562_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: [3])
[junit4] 2> 2471237 INFO
(OverseerCollectionConfigSetProcessor-97029437477158920-127.0.0.1:60562_solr-n_0000000000)
[n:127.0.0.1:60562_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> 2471816 INFO (qtp549509694-54113) [n:127.0.0.1:60562_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={replicationFactor=1&collection.configName=conf1&maxShardsPerNode=1&name=collection1&action=CREATE&numShards=2&wt=javabin&version=2}
status=0 QTime=2586
[junit4] 2> 2471816 INFO
(TEST-TestDistribIDF.testMultiCollectionQuery-seed#[D55A06E42A659E6F]) [ ]
o.a.s.c.AbstractDistribZkTestBase Wait for recoveries to finish - collection:
collection1 failOnTimeout:true timeout (sec):100
[junit4] 2> 2471817 INFO
(TEST-TestDistribIDF.testMultiCollectionQuery-seed#[D55A06E42A659E6F]) [ ]
o.a.s.c.AbstractDistribZkTestBase Recoveries finished - collection: collection1
[junit4] 2> 2471818 INFO (qtp549509694-54116) [n:127.0.0.1:60562_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=1&collection.configName=conf2&maxShardsPerNode=1&name=collection1_local&action=CREATE&numShards=2&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2471821 INFO
(OverseerThreadFactory-12451-thread-2-processing-n:127.0.0.1:60562_solr)
[n:127.0.0.1:60562_solr ] o.a.s.c.CreateCollectionCmd Create collection
collection1_local
[junit4] 2> 2472032 INFO (qtp549509694-54117) [n:127.0.0.1:60562_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf2&newCollection=true&name=collection1_local_shard2_replica1&action=CREATE&numShards=2&collection=collection1_local&shard=shard2&wt=javabin&version=2
[junit4] 2> 2472034 INFO (qtp1736882781-54129) [n:127.0.0.1:44203_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf2&newCollection=true&name=collection1_local_shard1_replica1&action=CREATE&numShards=2&collection=collection1_local&shard=shard1&wt=javabin&version=2
[junit4] 2> 2472144 INFO
(zkCallback-10597-thread-3-processing-n:127.0.0.1:60562_solr)
[n:127.0.0.1:60562_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1_local/state.json] for collection
[collection1_local] has occurred - updating... (live nodes size: [3])
[junit4] 2> 2472144 INFO
(zkCallback-10593-thread-1-processing-n:127.0.0.1:44203_solr)
[n:127.0.0.1:44203_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1_local/state.json] for collection
[collection1_local] has occurred - updating... (live nodes size: [3])
[junit4] 2> 2473044 INFO (qtp549509694-54117) [n:127.0.0.1:60562_solr
c:collection1_local s:shard2 x:collection1_local_shard2_replica1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 2473046 INFO (qtp1736882781-54129) [n:127.0.0.1:44203_solr
c:collection1_local s:shard1 x:collection1_local_shard1_replica1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 2473052 INFO (qtp549509694-54117) [n:127.0.0.1:60562_solr
c:collection1_local s:shard2 x:collection1_local_shard2_replica1]
o.a.s.s.IndexSchema [collection1_local_shard2_replica1] Schema name=minimal
[junit4] 2> 2473053 INFO (qtp549509694-54117) [n:127.0.0.1:60562_solr
c:collection1_local s:shard2 x:collection1_local_shard2_replica1]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 2473054 INFO (qtp549509694-54117) [n:127.0.0.1:60562_solr
c:collection1_local s:shard2 x:collection1_local_shard2_replica1]
o.a.s.c.CoreContainer Creating SolrCore 'collection1_local_shard2_replica1'
using configuration from collection collection1_local
[junit4] 2> 2473055 INFO (qtp549509694-54117) [n:127.0.0.1:60562_solr
c:collection1_local s:shard2 r:core_node1 x:collection1_local_shard2_replica1]
o.a.s.c.SolrCore [[collection1_local_shard2_replica1] ] Opening new SolrCore at
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.search.stats.TestDistribIDF_D55A06E42A659E6F-001/tempDir-001/node2/collection1_local_shard2_replica1],
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.search.stats.TestDistribIDF_D55A06E42A659E6F-001/tempDir-001/node2/./collection1_local_shard2_replica1/data/]
[junit4] 2> 2473059 INFO (qtp1736882781-54129) [n:127.0.0.1:44203_solr
c:collection1_local s:shard1 x:collection1_local_shard1_replica1]
o.a.s.s.IndexSchema [collection1_local_shard1_replica1] Schema name=minimal
[junit4] 2> 2473061 INFO (qtp1736882781-54129) [n:127.0.0.1:44203_solr
c:collection1_local s:shard1 x:collection1_local_shard1_replica1]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 2473062 INFO (qtp1736882781-54129) [n:127.0.0.1:44203_solr
c:collection1_local s:shard1 x:collection1_local_shard1_replica1]
o.a.s.c.CoreContainer Creating SolrCore 'collection1_local_shard1_replica1'
using configuration from collection collection1_local
[junit4] 2> 2473062 INFO (qtp1736882781-54129) [n:127.0.0.1:44203_solr
c:collection1_local s:shard1 r:core_node2 x:collection1_local_shard1_replica1]
o.a.s.c.SolrCore [[collection1_local_shard1_replica1] ] Opening new SolrCore at
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.search.stats.TestDistribIDF_D55A06E42A659E6F-001/tempDir-001/node1/collection1_local_shard1_replica1],
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.search.stats.TestDistribIDF_D55A06E42A659E6F-001/tempDir-001/node1/./collection1_local_shard1_replica1/data/]
[junit4] 2> 2473063 INFO (qtp549509694-54117) [n:127.0.0.1:60562_solr
c:collection1_local s:shard2 r:core_node1 x:collection1_local_shard2_replica1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2473063 INFO (qtp549509694-54117) [n:127.0.0.1:60562_solr
c:collection1_local s:shard2 r:core_node1 x:collection1_local_shard2_replica1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2473064 INFO (qtp549509694-54117) [n:127.0.0.1:60562_solr
c:collection1_local s:shard2 r:core_node1 x:collection1_local_shard2_replica1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@61c67fe7[collection1_local_shard2_replica1] main]
[junit4] 2> 2473066 INFO (qtp549509694-54117) [n:127.0.0.1:60562_solr
c:collection1_local s:shard2 r:core_node1 x:collection1_local_shard2_replica1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf2
[junit4] 2> 2473067 INFO (qtp549509694-54117) [n:127.0.0.1:60562_solr
c:collection1_local s:shard2 r:core_node1 x:collection1_local_shard2_replica1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf2
[junit4] 2> 2473067 INFO (qtp549509694-54117) [n:127.0.0.1:60562_solr
c:collection1_local s:shard2 r:core_node1 x:collection1_local_shard2_replica1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 2473071 INFO (qtp1736882781-54129) [n:127.0.0.1:44203_solr
c:collection1_local s:shard1 r:core_node2 x:collection1_local_shard1_replica1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2473071 INFO (qtp1736882781-54129) [n:127.0.0.1:44203_solr
c:collection1_local s:shard1 r:core_node2 x:collection1_local_shard1_replica1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2473071 INFO (qtp1736882781-54129) [n:127.0.0.1:44203_solr
c:collection1_local s:shard1 r:core_node2 x:collection1_local_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@259ceba0[collection1_local_shard1_replica1] main]
[junit4] 2> 2473073 INFO (qtp549509694-54117) [n:127.0.0.1:60562_solr
c:collection1_local s:shard2 r:core_node1 x:collection1_local_shard2_replica1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 2473073 INFO (qtp549509694-54117) [n:127.0.0.1:60562_solr
c:collection1_local s:shard2 r:core_node1 x:collection1_local_shard2_replica1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 2473073 INFO (qtp549509694-54117) [n:127.0.0.1:60562_solr
c:collection1_local s:shard2 r:core_node1 x:collection1_local_shard2_replica1]
o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:60562/solr/collection1_local_shard2_replica1/
[junit4] 2> 2473073 ERROR (qtp549509694-54117) [n:127.0.0.1:60562_solr
c:collection1_local s:shard2 r:core_node1 x:collection1_local_shard2_replica1]
o.a.s.c.SyncStrategy No UpdateLog found - cannot sync
[junit4] 2> 2473073 INFO (qtp549509694-54117) [n:127.0.0.1:60562_solr
c:collection1_local s:shard2 r:core_node1 x:collection1_local_shard2_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> 2473075 INFO (qtp1736882781-54129) [n:127.0.0.1:44203_solr
c:collection1_local s:shard1 r:core_node2 x:collection1_local_shard1_replica1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf2
[junit4] 2> 2473076 INFO (qtp1736882781-54129) [n:127.0.0.1:44203_solr
c:collection1_local s:shard1 r:core_node2 x:collection1_local_shard1_replica1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf2
[junit4] 2> 2473076 INFO (qtp1736882781-54129) [n:127.0.0.1:44203_solr
c:collection1_local s:shard1 r:core_node2 x:collection1_local_shard1_replica1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 2473076 INFO
(searcherExecutor-12470-thread-1-processing-n:127.0.0.1:44203_solr
x:collection1_local_shard1_replica1 s:shard1 c:collection1_local r:core_node2)
[n:127.0.0.1:44203_solr c:collection1_local s:shard1 r:core_node2
x:collection1_local_shard1_replica1] o.a.s.c.SolrCore
[collection1_local_shard1_replica1] Registered new searcher
Searcher@259ceba0[collection1_local_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2473077 INFO
(searcherExecutor-12468-thread-1-processing-n:127.0.0.1:60562_solr
x:collection1_local_shard2_replica1 s:shard2 c:collection1_local r:core_node1)
[n:127.0.0.1:60562_solr c:collection1_local s:shard2 r:core_node1
x:collection1_local_shard2_replica1] o.a.s.c.SolrCore
[collection1_local_shard2_replica1] Registered new searcher
Searcher@61c67fe7[collection1_local_shard2_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2473078 INFO (qtp549509694-54117) [n:127.0.0.1:60562_solr
c:collection1_local s:shard2 r:core_node1 x:collection1_local_shard2_replica1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:60562/solr/collection1_local_shard2_replica1/ shard2
[junit4] 2> 2473085 INFO (qtp1736882781-54129) [n:127.0.0.1:44203_solr
c:collection1_local s:shard1 r:core_node2 x:collection1_local_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 2473085 INFO (qtp1736882781-54129) [n:127.0.0.1:44203_solr
c:collection1_local s:shard1 r:core_node2 x:collection1_local_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 2473085 INFO (qtp1736882781-54129) [n:127.0.0.1:44203_solr
c:collection1_local s:shard1 r:core_node2 x:collection1_local_shard1_replica1]
o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:44203/solr/collection1_local_shard1_replica1/
[junit4] 2> 2473085 ERROR (qtp1736882781-54129) [n:127.0.0.1:44203_solr
c:collection1_local s:shard1 r:core_node2 x:collection1_local_shard1_replica1]
o.a.s.c.SyncStrategy No UpdateLog found - cannot sync
[junit4] 2> 2473086 INFO (qtp1736882781-54129) [n:127.0.0.1:44203_solr
c:collection1_local s:shard1 r:core_node2 x:collection1_local_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> 2473089 INFO (qtp1736882781-54129) [n:127.0.0.1:44203_solr
c:collection1_local s:shard1 r:core_node2 x:collection1_local_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:44203/solr/collection1_local_shard1_replica1/ shard1
[junit4] 2> 2473196 INFO
(zkCallback-10597-thread-3-processing-n:127.0.0.1:60562_solr)
[n:127.0.0.1:60562_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1_local/state.json] for collection
[collection1_local] has occurred - updating... (live nodes size: [3])
[junit4] 2> 2473204 INFO
(zkCallback-10593-thread-1-processing-n:127.0.0.1:44203_solr)
[n:127.0.0.1:44203_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1_local/state.json] for collection
[collection1_local] has occurred - updating... (live nodes size: [3])
[junit4] 2> 2473238 INFO (qtp549509694-54117) [n:127.0.0.1:60562_solr
c:collection1_local s:shard2 r:core_node1 x:collection1_local_shard2_replica1]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 2473240 INFO (qtp549509694-54117) [n:127.0.0.1:60562_solr
c:collection1_local s:shard2 r:core_node1 x:collection1_local_shard2_replica1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf2&newCollection=true&name=collection1_local_shard2_replica1&action=CREATE&numShards=2&collection=collection1_local&shard=shard2&wt=javabin&version=2}
status=0 QTime=1208
[junit4] 2> 2473240 INFO (qtp1736882781-54129) [n:127.0.0.1:44203_solr
c:collection1_local s:shard1 r:core_node2 x:collection1_local_shard1_replica1]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 2473243 INFO (qtp1736882781-54129) [n:127.0.0.1:44203_solr
c:collection1_local s:shard1 r:core_node2 x:collection1_local_shard1_replica1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf2&newCollection=true&name=collection1_local_shard1_replica1&action=CREATE&numShards=2&collection=collection1_local&shard=shard1&wt=javabin&version=2}
status=0 QTime=1209
[junit4] 2> 2473246 INFO (qtp549509694-54116) [n:127.0.0.1:60562_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> 2473348 INFO
(zkCallback-10597-thread-1-processing-n:127.0.0.1:60562_solr)
[n:127.0.0.1:60562_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1_local/state.json] for collection
[collection1_local] has occurred - updating... (live nodes size: [3])
[junit4] 2> 2473348 INFO
(zkCallback-10593-thread-1-processing-n:127.0.0.1:44203_solr)
[n:127.0.0.1:44203_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1_local/state.json] for collection
[collection1_local] has occurred - updating... (live nodes size: [3])
[junit4] 2> 2473823 INFO
(OverseerCollectionConfigSetProcessor-97029437477158920-127.0.0.1:60562_solr-n_0000000000)
[n:127.0.0.1:60562_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000002 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 2474247 INFO (qtp549509694-54116) [n:127.0.0.1:60562_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={replicationFactor=1&collection.configName=conf2&maxShardsPerNode=1&name=collection1_local&action=CREATE&numShards=2&wt=javabin&version=2}
status=0 QTime=2429
[junit4] 2> 2474247 INFO
(TEST-TestDistribIDF.testMultiCollectionQuery-seed#[D55A06E42A659E6F]) [ ]
o.a.s.c.AbstractDistribZkTestBase Wait for recoveries to finish - collection:
collection1_local failOnTimeout:true timeout (sec):100
[junit4] 2> 2474248 INFO
(TEST-TestDistribIDF.testMultiCollectionQuery-seed#[D55A06E42A659E6F]) [ ]
o.a.s.c.AbstractDistribZkTestBase Recoveries finished - collection:
collection1_local
[junit4] 2> 2474249 INFO (qtp549509694-54118) [n:127.0.0.1:60562_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=1&collection.configName=conf1&maxShardsPerNode=1&name=collection2&action=CREATE&numShards=2&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2474252 INFO
(OverseerThreadFactory-12451-thread-3-processing-n:127.0.0.1:60562_solr)
[n:127.0.0.1:60562_solr ] o.a.s.c.CreateCollectionCmd Create collection
collection2
[junit4] 2> 2474458 INFO (qtp549509694-54109) [n:127.0.0.1:60562_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf1&newCollection=true&name=collection2_shard2_replica1&action=CREATE&numShards=2&collection=collection2&shard=shard2&wt=javabin&version=2
[junit4] 2> 2474458 INFO (qtp1736882781-54127) [n:127.0.0.1:44203_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf1&newCollection=true&name=collection2_shard1_replica1&action=CREATE&numShards=2&collection=collection2&shard=shard1&wt=javabin&version=2
[junit4] 2> 2474576 INFO
(zkCallback-10593-thread-1-processing-n:127.0.0.1:44203_solr)
[n:127.0.0.1:44203_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection2/state.json] for collection [collection2] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 2474576 INFO
(zkCallback-10597-thread-1-processing-n:127.0.0.1:60562_solr)
[n:127.0.0.1:60562_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection2/state.json] for collection [collection2] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 2475483 WARN (qtp549509694-54109) [n:127.0.0.1:60562_solr
c:collection2 s:shard2 x:collection2_shard2_replica1] o.a.s.c.Config Beginning
with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 2475485 INFO (qtp549509694-54109) [n:127.0.0.1:60562_solr
c:collection2 s:shard2 x:collection2_shard2_replica1] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 7.0.0
[junit4] 2> 2475494 WARN (qtp1736882781-54127) [n:127.0.0.1:44203_solr
c:collection2 s:shard1 x:collection2_shard1_replica1] o.a.s.c.Config Beginning
with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 2475496 INFO (qtp1736882781-54127) [n:127.0.0.1:44203_solr
c:collection2 s:shard1 x:collection2_shard1_replica1] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 7.0.0
[junit4] 2> 2475531 INFO (qtp549509694-54109) [n:127.0.0.1:60562_solr
c:collection2 s:shard2 x:collection2_shard2_replica1] o.a.s.s.IndexSchema
[collection2_shard2_replica1] Schema name=test
[junit4] 2> 2475551 INFO (qtp1736882781-54127) [n:127.0.0.1:44203_solr
c:collection2 s:shard1 x:collection2_shard1_replica1] o.a.s.s.IndexSchema
[collection2_shard1_replica1] Schema name=test
[junit4] 2> 2475634 WARN (qtp549509694-54109) [n:127.0.0.1:60562_solr
c:collection2 s:shard2 x:collection2_shard2_replica1] o.a.s.s.IndexSchema
[collection2_shard2_replica1] default search field in schema is text. WARNING:
Deprecated, please use 'df' on request instead.
[junit4] 2> 2475654 INFO (qtp549509694-54109) [n:127.0.0.1:60562_solr
c:collection2 s:shard2 x:collection2_shard2_replica1] o.a.s.s.IndexSchema
Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 2475668 INFO (qtp549509694-54109) [n:127.0.0.1:60562_solr
c:collection2 s:shard2 x:collection2_shard2_replica1] o.a.s.c.CoreContainer
Creating SolrCore 'collection2_shard2_replica1' using configuration from
collection collection2
[junit4] 2> 2475669 INFO (qtp549509694-54109) [n:127.0.0.1:60562_solr
c:collection2 s:shard2 r:core_node2 x:collection2_shard2_replica1]
o.a.s.c.SolrCore [[collection2_shard2_replica1] ] Opening new SolrCore at
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.search.stats.TestDistribIDF_D55A06E42A659E6F-001/tempDir-001/node2/collection2_shard2_replica1],
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.search.stats.TestDistribIDF_D55A06E42A659E6F-001/tempDir-001/node2/./collection2_shard2_replica1/data/]
[junit4] 2> 2475669 INFO (qtp549509694-54109) [n:127.0.0.1:60562_solr
c:collection2 s:shard2 r:core_node2 x:collection2_shard2_replica1]
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@3750ef26
[junit4] 2> 2475670 INFO (qtp549509694-54109) [n:127.0.0.1:60562_solr
c:collection2 s:shard2 r:core_node2 x:collection2_shard2_replica1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=31, maxMergeAtOnceExplicit=14, maxMergedSegmentMB=36.88671875,
floorSegmentMB=2.17578125, forceMergeDeletesPctAllowed=13.566005280621589,
segmentsPerTier=19.0, maxCFSSegmentSizeMB=1.078125,
noCFSRatio=0.7488659343794114
[junit4] 2> 2475677 WARN (qtp1736882781-54127) [n:127.0.0.1:44203_solr
c:collection2 s:shard1 x:collection2_shard1_replica1] o.a.s.s.IndexSchema
[collection2_shard1_replica1] default search field in schema is text. WARNING:
Deprecated, please use 'df' on request instead.
[junit4] 2> 2475679 INFO (qtp1736882781-54127) [n:127.0.0.1:44203_solr
c:collection2 s:shard1 x:collection2_shard1_replica1] o.a.s.s.IndexSchema
Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 2475694 INFO (qtp1736882781-54127) [n:127.0.0.1:44203_solr
c:collection2 s:shard1 x:collection2_shard1_replica1] o.a.s.c.CoreContainer
Creating SolrCore 'collection2_shard1_replica1' using configuration from
collection collection2
[junit4] 2> 2475694 INFO (qtp549509694-54109) [n:127.0.0.1:60562_solr
c:collection2 s:shard2 r:core_node2 x:collection2_shard2_replica1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 2475694 INFO (qtp549509694-54109) [n:127.0.0.1:60562_solr
c:collection2 s:shard2 r:core_node2 x:collection2_shard2_replica1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2475694 INFO (qtp1736882781-54127) [n:127.0.0.1:44203_solr
c:collection2 s:shard1 r:core_node1 x:collection2_shard1_replica1]
o.a.s.c.SolrCore [[collection2_shard1_replica1] ] Opening new SolrCore at
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.search.stats.TestDistribIDF_D55A06E42A659E6F-001/tempDir-001/node1/collection2_shard1_replica1],
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.search.stats.TestDistribIDF_D55A06E42A659E6F-001/tempDir-001/node1/./collection2_shard1_replica1/data/]
[junit4] 2> 2475694 INFO (qtp1736882781-54127) [n:127.0.0.1:44203_solr
c:collection2 s:shard1 r:core_node1 x:collection2_shard1_replica1]
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@3750ef26
[junit4] 2> 2475695 INFO (qtp549509694-54109) [n:127.0.0.1:60562_solr
c:collection2 s:shard2 r:core_node2 x:collection2_shard2_replica1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2475695 INFO (qtp549509694-54109) [n:127.0.0.1:60562_solr
c:collection2 s:shard2 r:core_node2 x:collection2_shard2_replica1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2475695 INFO (qtp1736882781-54127) [n:127.0.0.1:44203_solr
c:collection2 s:shard1 r:core_node1 x:collection2_shard1_replica1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=31, maxMergeAtOnceExplicit=14, maxMergedSegmentMB=36.88671875,
floorSegmentMB=2.17578125, forceMergeDeletesPctAllowed=13.566005280621589,
segmentsPerTier=19.0, maxCFSSegmentSizeMB=1.078125,
noCFSRatio=0.7488659343794114
[junit4] 2> 2475696 INFO (qtp549509694-54109) [n:127.0.0.1:60562_solr
c:collection2 s:shard2 r:core_node2 x:collection2_shard2_replica1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=26, maxMergeAtOnceExplicit=45, maxMergedSegmentMB=85.197265625,
floorSegmentMB=0.6767578125, forceMergeDeletesPctAllowed=21.366476022658585,
segmentsPerTier=40.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 2475696 INFO (qtp549509694-54109) [n:127.0.0.1:60562_solr
c:collection2 s:shard2 r:core_node2 x:collection2_shard2_replica1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@3711d4f4[collection2_shard2_replica1] main]
[junit4] 2> 2475697 INFO (qtp549509694-54109) [n:127.0.0.1:60562_solr
c:collection2 s:shard2 r:core_node2 x:collection2_shard2_replica1]
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 2475701 INFO (qtp549509694-54109) [n:127.0.0.1:60562_solr
c:collection2 s:shard2 r:core_node2 x:collection2_shard2_replica1]
o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 2475711 INFO (qtp1736882781-54127) [n:127.0.0.1:44203_solr
c:collection2 s:shard1 r:core_node1 x:collection2_shard1_replica1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 2475711 INFO (qtp1736882781-54127) [n:127.0.0.1:44203_solr
c:collection2 s:shard1 r:core_node1 x:collection2_shard1_replica1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2475712 INFO (qtp1736882781-54127) [n:127.0.0.1:44203_solr
c:collection2 s:shard1 r:core_node1 x:collection2_shard1_replica1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2475712 INFO (qtp1736882781-54127) [n:127.0.0.1:44203_solr
c:collection2 s:shard1 r:core_node1 x:collection2_shard1_replica1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2475713 INFO (qtp1736882781-54127) [n:127.0.0.1:44203_solr
c:collection2 s:shard1 r:core_node1 x:collection2_shard1_replica1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=26, maxMergeAtOnceExplicit=45, maxMergedSegmentMB=85.197265625,
floorSegmentMB=0.6767578125, forceMergeDeletesPctAllowed=21.366476022658585,
segmentsPerTier=40.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 2475713 INFO (qtp1736882781-54127) [n:127.0.0.1:44203_solr
c:collection2 s:shard1 r:core_node1 x:collection2_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@a28e433[collection2_shard1_replica1] main]
[junit4] 2> 2475715 INFO (qtp1736882781-54127) [n:127.0.0.1:44203_solr
c:collection2 s:shard1 r:core_node1 x:collection2_shard1_replica1]
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 2475721 INFO (qtp549509694-54109) [n:127.0.0.1:60562_solr
c:collection2 s:shard2 r:core_node2 x:collection2_shard2_replica1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 2475721 INFO (qtp549509694-54109) [n:127.0.0.1:60562_solr
c:collection2 s:shard2 r:core_node2 x:collection2_shard2_replica1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1552471007383519232
[junit4] 2> 2475722 INFO
(searcherExecutor-12476-thread-1-processing-n:127.0.0.1:60562_solr
x:collection2_shard2_replica1 s:shard2 c:collection2 r:core_node2)
[n:127.0.0.1:60562_solr c:collection2 s:shard2 r:core_node2
x:collection2_shard2_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: default
[junit4] 2> 2475722 INFO
(searcherExecutor-12476-thread-1-processing-n:127.0.0.1:60562_solr
x:collection2_shard2_replica1 s:shard2 c:collection2 r:core_node2)
[n:127.0.0.1:60562_solr c:collection2 s:shard2 r:core_node2
x:collection2_shard2_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: direct
[junit4] 2> 2475722 INFO
(searcherExecutor-12476-thread-1-processing-n:127.0.0.1:60562_solr
x:collection2_shard2_replica1 s:shard2 c:collection2 r:core_node2)
[n:127.0.0.1:60562_solr c:collection2 s:shard2 r:core_node2
x:collection2_shard2_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: wordbreak
[junit4] 2> 2475722 INFO
(searcherExecutor-12476-thread-1-processing-n:127.0.0.1:60562_solr
x:collection2_shard2_replica1 s:shard2 c:collection2 r:core_node2)
[n:127.0.0.1:60562_solr c:collection2 s:shard2 r:core_node2
x:collection2_shard2_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: multipleFields
[junit4] 2> 2475723 INFO
(searcherExecutor-12476-thread-1-processing-n:127.0.0.1:60562_solr
x:collection2_shard2_replica1 s:shard2 c:collection2 r:core_node2)
[n:127.0.0.1:60562_solr c:collection2 s:shard2 r:core_node2
x:collection2_shard2_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: jarowinkler
[junit4] 2> 2475723 INFO
(searcherExecutor-12476-thread-1-processing-n:127.0.0.1:60562_solr
x:collection2_shard2_replica1 s:shard2 c:collection2 r:core_node2)
[n:127.0.0.1:60562_solr c:collection2 s:shard2 r:core_node2
x:collection2_shard2_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: external
[junit4] 2> 2475723 INFO (qtp1736882781-54127) [n:127.0.0.1:44203_solr
c:collection2 s:shard1 r:core_node1 x:collection2_shard1_replica1]
o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 2475723 INFO
(searcherExecutor-12476-thread-1-processing-n:127.0.0.1:60562_solr
x:collection2_shard2_replica1 s:shard2 c:collection2 r:core_node2)
[n:127.0.0.1:60562_solr c:collection2 s:shard2 r:core_node2
x:collection2_shard2_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: freq
[junit4] 2> 2475724 INFO
(searcherExecutor-12476-thread-1-processing-n:127.0.0.1:60562_solr
x:collection2_shard2_replica1 s:shard2 c:collection2 r:core_node2)
[n:127.0.0.1:60562_solr c:collection2 s:shard2 r:core_node2
x:collection2_shard2_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: fqcn
[junit4] 2> 2475724 INFO
(searcherExecutor-12476-thread-1-processing-n:127.0.0.1:60562_solr
x:collection2_shard2_replica1 s:shard2 c:collection2 r:core_node2)
[n:127.0.0.1:60562_solr c:collection2 s:shard2 r:core_node2
x:collection2_shard2_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: perDict
[junit4] 2> 2475725 INFO
(searcherExecutor-12476-thread-1-processing-n:127.0.0.1:60562_solr
x:collection2_shard2_replica1 s:shard2 c:collection2 r:core_node2)
[n:127.0.0.1:60562_solr c:collection2 s:shard2 r:core_node2
x:collection2_shard2_replica1] o.a.s.c.SolrCore [collection2_shard2_replica1]
Registered new searcher Searcher@3711d4f4[collection2_shard2_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2475735 INFO (qtp549509694-54109) [n:127.0.0.1:60562_solr
c:collection2 s:shard2 r:core_node2 x:collection2_shard2_replica1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 2475735 INFO (qtp549509694-54109) [n:127.0.0.1:60562_solr
c:collection2 s:shard2 r:core_node2 x:collection2_shard2_replica1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 2475735 INFO (qtp549509694-54109) [n:127.0.0.1:60562_solr
c:collection2 s:shard2 r:core_node2 x:collection2_shard2_replica1]
o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:60562/solr/collection2_shard2_replica1/
[junit4] 2> 2475736 INFO (qtp549509694-54109) [n:127.0.0.1:60562_solr
c:collection2 s:shard2 r:core_node2 x:collection2_shard2_replica1]
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 2475736 INFO (qtp549509694-54109) [n:127.0.0.1:60562_solr
c:collection2 s:shard2 r:core_node2 x:collection2_shard2_replica1]
o.a.s.c.SyncStrategy http://127.0.0.1:60562/solr/collection2_shard2_replica1/
has no replicas
[junit4] 2> 2475743 INFO (qtp549509694-54109) [n:127.0.0.1:60562_solr
c:collection2 s:shard2 r:core_node2 x:collection2_shard2_replica1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:60562/solr/collection2_shard2_replica1/ shard2
[junit4] 2> 2475751 INFO (qtp1736882781-54127) [n:127.0.0.1:44203_solr
c:collection2 s:shard1 r:core_node1 x:collection2_shard1_replica1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 2475752 INFO
(searcherExecutor-12479-thread-1-processing-n:127.0.0.1:44203_solr
x:collection2_shard1_replica1 s:shard1 c:collection2 r:core_node1)
[n:127.0.0.1:44203_solr c:collection2 s:shard1 r:core_node1
x:collection2_shard1_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: default
[junit4] 2> 2475752 INFO
(searcherExecutor-12479-thread-1-processing-n:127.0.0.1:44203_solr
x:collection2_shard1_replica1 s:shard1 c:collection2 r:core_node1)
[n:127.0.0.1:44203_solr c:collection2 s:shard1 r:core_node1
x:collection2_shard1_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: direct
[junit4] 2> 2475752 INFO
(searcherExecutor-12479-thread-1-processing-n:127.0.0.1:44203_solr
x:collection2_shard1_replica1 s:shard1 c:collection2 r:core_node1)
[n:127.0.0.1:44203_solr c:collection2 s:shard1 r:core_node1
x:collection2_shard1_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: wordbreak
[junit4] 2> 2475752 INFO (qtp1736882781-54127) [n:127.0.0.1:44203_solr
c:collection2 s:shard1 r:core_node1 x:collection2_shard1_replica1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1552471007416025088
[junit4] 2> 2475752 INFO
(searcherExecutor-12479-thread-1-processing-n:127.0.0.1:44203_solr
x:collection2_shard1_replica1 s:shard1 c:collection2 r:core_node1)
[n:127.0.0.1:44203_solr c:collection2 s:shard1 r:core_node1
x:collection2_shard1_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: multipleFields
[junit4] 2> 2475753 INFO
(searcherExecutor-12479-thread-1-processing-n:127.0.0.1:44203_solr
x:collection2_shard1_replica1 s:shard1 c:collection2 r:core_node1)
[n:127.0.0.1:44203_solr c:collection2 s:shard1 r:core_node1
x:collection2_shard1_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: jarowinkler
[junit4] 2> 2475753 INFO
(searcherExecutor-12479-thread-1-processing-n:127.0.0.1:44203_solr
x:collection2_shard1_replica1 s:shard1 c:collection2 r:core_node1)
[n:127.0.0.1:44203_solr c:collection2 s:shard1 r:core_node1
x:collection2_shard1_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: external
[junit4] 2> 2475753 INFO
(searcherExecutor-12479-thread-1-processing-n:127.0.0.1:44203_solr
x:collection2_shard1_replica1 s:shard1 c:collection2 r:core_node1)
[n:127.0.0.1:44203_solr c:collection2 s:shard1 r:core_node1
x:collection2_shard1_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: freq
[junit4] 2> 2475754 INFO
(searcherExecutor-12479-thread-1-processing-n:127.0.0.1:44203_solr
x:collection2_shard1_replica1 s:shard1 c:collection2 r:core_node1)
[n:127.0.0.1:44203_solr c:collection2 s:shard1 r:core_node1
x:collection2_shard1_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: fqcn
[junit4] 2> 2475754 INFO
(searcherExecutor-12479-thread-1-processing-n:127.0.0.1:44203_solr
x:collection2_shard1_replica1 s:shard1 c:collection2 r:core_node1)
[n:127.0.0.1:44203_solr c:collection2 s:shard1 r:core_node1
x:collection2_shard1_replica1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: perDict
[junit4] 2> 2475755 INFO
(searcherExecutor-12479-thread-1-processing-n:127.0.0.1:44203_solr
x:collection2_shard1_replica1 s:shard1 c:collection2 r:core_node1)
[n:127.0.0.1:44203_solr c:collection2 s:shard1 r:core_node1
x:collection2_shard1_replica1] o.a.s.c.SolrCore [collection2_shard1_replica1]
Registered new searcher Searcher@a28e433[collection2_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2475762 INFO (qtp1736882781-54127) [n:127.0.0.1:44203_solr
c:collection2 s:shard1 r:core_node1 x:collection2_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 2475763 INFO (qtp1736882781-54127) [n:127.0.0.1:44203_solr
c:collection2 s:shard1 r:core_node1 x:collection2_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 2475763 INFO (qtp1736882781-54127) [n:127.0.0.1:44203_solr
c:collection2 s:shard1 r:core_node1 x:collection2_shard1_replica1]
o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:44203/solr/collection2_shard1_replica1/
[junit4] 2> 2475763 INFO (qtp1736882781-54127) [n:127.0.0.1:44203_solr
c:collection2 s:shard1 r:core_node1 x:collection2_shard1_replica1]
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 2475763 INFO (qtp1736882781-54127) [n:127.0.0.1:44203_solr
c:collection2 s:shard1 r:core_node1 x:collection2_shard1_replica1]
o.a.s.c.SyncStrategy http://127.0.0.1:44203/solr/collection2_shard1_replica1/
has no replicas
[junit4] 2> 2475770 INFO (qtp1736882781-54127) [n:127.0.0.1:44203_solr
c:collection2 s:shard1 r:core_node1 x:collection2_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:44203/solr/collection2_shard1_replica1/ shard1
[junit4] 2> 2475874 INFO
(zkCallback-10597-thread-3-processing-n:127.0.0.1:60562_solr)
[n:127.0.0.1:60562_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection2/state.json] for collection [collection2] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 2475874 INFO
(zkCallback-10593-thread-1-processing-n:127.0.0.1:44203_solr)
[n:127.0.0.1:44203_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection2/state.json] for collection [collection2] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 2475898 INFO (qtp549509694-54109) [n:127.0.0.1:60562_solr
c:collection2 s:shard2 r:core_node2 x:collection2_shard2_replica1]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 2475901 INFO (qtp549509694-54109) [n:127.0.0.1:60562_solr
c:collection2 s:shard2 r:core_node2 x:collection2_shard2_replica1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf1&newCollection=true&name=collection2_shard2_replica1&action=CREATE&numShards=2&collection=collection2&shard=shard2&wt=javabin&version=2}
status=0 QTime=1444
[junit4] 2> 2475922 INFO (qtp1736882781-54127) [n:127.0.0.1:44203_solr
c:collection2 s:shard1 r:core_node1 x:collection2_shard1_replica1]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 2475925 INFO (qtp1736882781-54127) [n:127.0.0.1:44203_solr
c:collection2 s:shard1 r:core_node1 x:collection2_shard1_replica1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf1&newCollection=true&name=collection2_shard1_replica1&action=CREATE&numShards=2&collection=collection2&shard=shard1&wt=javabin&version=2}
status=0 QTime=1467
[junit4] 2> 2475928 INFO (qtp549509694-54118) [n:127.0.0.1:60562_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> 2476029 INFO
(zkCallback-10597-thread-3-processing-n:127.0.0.1:60562_solr)
[n:127.0.0.1:60562_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection2/state.json] for collection [collection2] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 2476030 INFO
(zkCallback-10593-thread-1-processing-n:127.0.0.1:44203_solr)
[n:127.0.0.1:44203_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection2/state.json] for collection [collection2] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 2476255 INFO
(OverseerCollectionConfigSetProcessor-97029437477158920-127.0.0.1:60562_solr-n_0000000000)
[n:127.0.0.1:60562_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000004 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 2476929 INFO (qtp549509694-54118) [n:127.0.0.1:60562_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={replicationFactor=1&collection.configName=conf1&maxShardsPerNode=1&name=collection2&action=CREATE&numShards=2&wt=javabin&version=2}
status=0 QTime=2681
[junit4] 2> 2476930 INFO
(TEST-TestDistribIDF.testMultiCollectionQuery-seed#[D55A06E42A659E6F]) [ ]
o.a.s.c.AbstractDistribZkTestBase Wait for recoveries to finish - collection:
collection2 failOnTimeout:true timeout (sec):100
[junit4] 2> 2476930 INFO
(TEST-TestDistribIDF.testMultiCollectionQuery-seed#[D55A06E42A659E6F]) [ ]
o.a.s.c.AbstractDistribZkTestBase Recoveries finished - collection: collection2
[junit4] 2> 2476931 INFO (qtp549509694-54111) [n:127.0.0.1:60562_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=1&collection.configName=conf2&maxShardsPerNode=1&name=collection2_local&action=CREATE&numShards=2&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2476934 INFO
(OverseerThreadFactory-12451-thread-4-processing-n:127.0.0.1:60562_solr)
[n:127.0.0.1:60562_solr ] o.a.s.c.CreateCollectionCmd Create collection
collection2_local
[junit4] 2> 2477139 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf2&newCollection=true&name=collection2_local_shard2_replica1&action=CREATE&numShards=2&collection=collection2_local&shard=shard2&wt=javabin&version=2
[junit4] 2> 2477139 INFO (qtp1736882781-54130) [n:127.0.0.1:44203_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf2&newCollection=true&name=collection2_local_shard1_replica1&action=CREATE&numShards=2&collection=collection2_local&shard=shard1&wt=javabin&version=2
[junit4] 2> 2477247 INFO
(zkCallback-10593-thread-1-processing-n:127.0.0.1:44203_solr)
[n:127.0.0.1:44203_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection2_local/state.json] for collection
[collection2_local] has occurred - updating... (live nodes size: [3])
[junit4] 2> 2477247 INFO
(zkCallback-10597-thread-2-processing-n:127.0.0.1:60562_solr)
[n:127.0.0.1:60562_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection2_local/state.json] for collection
[collection2_local] has occurred - updating... (live nodes size: [3])
[junit4] 2> 2478150 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection2_local s:shard2 x:collection2_local_shard2_replica1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 2478150 INFO (qtp1736882781-54130) [n:127.0.0.1:44203_solr
c:collection2_local s:shard1 x:collection2_local_shard1_replica1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 2478156 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection2_local s:shard2 x:collection2_local_shard2_replica1]
o.a.s.s.IndexSchema [collection2_local_shard2_replica1] Schema name=minimal
[junit4] 2> 2478156 INFO (qtp1736882781-54130) [n:127.0.0.1:44203_solr
c:collection2_local s:shard1 x:collection2_local_shard1_replica1]
o.a.s.s.IndexSchema [collection2_local_shard1_replica1] Schema name=minimal
[junit4] 2> 2478158 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection2_local s:shard2 x:collection2_local_shard2_replica1]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 2478158 INFO (qtp1736882781-54130) [n:127.0.0.1:44203_solr
c:collection2_local s:shard1 x:collection2_local_shard1_replica1]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 2478160 INFO (qtp1736882781-54130) [n:127.0.0.1:44203_solr
c:collection2_local s:shard1 x:collection2_local_shard1_replica1]
o.a.s.c.CoreContainer Creating SolrCore 'collection2_local_shard1_replica1'
using configuration from collection collection2_local
[junit4] 2> 2478160 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection2_local s:shard2 x:collection2_local_shard2_replica1]
o.a.s.c.CoreContainer Creating SolrCore 'collection2_local_shard2_replica1'
using configuration from collection collection2_local
[junit4] 2> 2478160 INFO (qtp1736882781-54130) [n:127.0.0.1:44203_solr
c:collection2_local s:shard1 r:core_node2 x:collection2_local_shard1_replica1]
o.a.s.c.SolrCore [[collection2_local_shard1_replica1] ] Opening new SolrCore at
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.search.stats.TestDistribIDF_D55A06E42A659E6F-001/tempDir-001/node1/collection2_local_shard1_replica1],
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.search.stats.TestDistribIDF_D55A06E42A659E6F-001/tempDir-001/node1/./collection2_local_shard1_replica1/data/]
[junit4] 2> 2478160 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection2_local s:shard2 r:core_node1 x:collection2_local_shard2_replica1]
o.a.s.c.SolrCore [[collection2_local_shard2_replica1] ] Opening new SolrCore at
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.search.stats.TestDistribIDF_D55A06E42A659E6F-001/tempDir-001/node2/collection2_local_shard2_replica1],
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.search.stats.TestDistribIDF_D55A06E42A659E6F-001/tempDir-001/node2/./collection2_local_shard2_replica1/data/]
[junit4] 2> 2478170 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection2_local s:shard2 r:core_node1 x:collection2_local_shard2_replica1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2478170 INFO (qtp1736882781-54130) [n:127.0.0.1:44203_solr
c:collection2_local s:shard1 r:core_node2 x:collection2_local_shard1_replica1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2478171 INFO (qtp1736882781-54130) [n:127.0.0.1:44203_solr
c:collection2_local s:shard1 r:core_node2 x:collection2_local_shard1_replica1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2478171 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection2_local s:shard2 r:core_node1 x:collection2_local_shard2_replica1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2478171 INFO (qtp1736882781-54130) [n:127.0.0.1:44203_solr
c:collection2_local s:shard1 r:core_node2 x:collection2_local_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@4207e995[collection2_local_shard1_replica1] main]
[junit4] 2> 2478171 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection2_local s:shard2 r:core_node1 x:collection2_local_shard2_replica1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@6542a0f1[collection2_local_shard2_replica1] main]
[junit4] 2> 2478173 INFO (qtp1736882781-54130) [n:127.0.0.1:44203_solr
c:collection2_local s:shard1 r:core_node2 x:collection2_local_shard1_replica1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf2
[junit4] 2> 2478173 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection2_local s:shard2 r:core_node1 x:collection2_local_shard2_replica1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf2
[junit4] 2> 2478174 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection2_local s:shard2 r:core_node1 x:collection2_local_shard2_replica1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf2
[junit4] 2> 2478174 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection2_local s:shard2 r:core_node1 x:collection2_local_shard2_replica1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 2478174 INFO (qtp1736882781-54130) [n:127.0.0.1:44203_solr
c:collection2_local s:shard1 r:core_node2 x:collection2_local_shard1_replica1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf2
[junit4] 2> 2478174 INFO (qtp1736882781-54130) [n:127.0.0.1:44203_solr
c:collection2_local s:shard1 r:core_node2 x:collection2_local_shard1_replica1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 2478175 INFO
(searcherExecutor-12486-thread-1-processing-n:127.0.0.1:44203_solr
x:collection2_local_shard1_replica1 s:shard1 c:collection2_local r:core_node2)
[n:127.0.0.1:44203_solr c:collection2_local s:shard1 r:core_node2
x:collection2_local_shard1_replica1] o.a.s.c.SolrCore
[collection2_local_shard1_replica1] Registered new searcher
Searcher@4207e995[collection2_local_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2478175 INFO
(searcherExecutor-12487-thread-1-processing-n:127.0.0.1:60562_solr
x:collection2_local_shard2_replica1 s:shard2 c:collection2_local r:core_node1)
[n:127.0.0.1:60562_solr c:collection2_local s:shard2 r:core_node1
x:collection2_local_shard2_replica1] o.a.s.c.SolrCore
[collection2_local_shard2_replica1] Registered new searcher
Searcher@6542a0f1[collection2_local_shard2_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2478182 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection2_local s:shard2 r:core_node1 x:collection2_local_shard2_replica1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 2478182 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection2_local s:shard2 r:core_node1 x:collection2_local_shard2_replica1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 2478182 INFO (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection2_local s:shard2 r:core_node1 x:collection2_local_shard2_replica1]
o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:60562/solr/collection2_local_shard2_replica1/
[junit4] 2> 2478182 ERROR (qtp549509694-54115) [n:127.0.0.1:60562_solr
c:collection2_local s:shard2 r:core_node1 x:collection2_local_shard2_replica1]
o.a.s.c.SyncS
[...truncated too long message...]
> INFO: Starting to interrupt leaked threads:
[junit4] 2> 1) Thread[id=54257,
name=OverseerHdfsCoreFailoverThread-97029437477158917-127.0.0.1:44203_solr-n_0000000002,
state=TIMED_WAITING, group=Overseer Hdfs SolrCore Failover Thread.]
[junit4] 2> Dec 01, 2016 12:22:40 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: All leaked threads terminated.
[junit4] 2> NOTE: test params are: codec=Lucene70,
sim=RandomSimilarity(queryNorm=false): {}, locale=ar-LY,
timezone=America/Knox_IN
[junit4] 2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_102
(64-bit)/cpus=3,threads=1,free=279427816,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [TestImplicitCoreProperties,
FieldMutatingUpdateProcessorTest, TestTolerantUpdateProcessorCloud,
TestValueSourceCache, HdfsBasicDistributedZkTest, ScriptEngineTest,
QueryParsingTest, TestSimpleTrackingShardHandler,
DistributedTermsComponentTest, TestMiniSolrCloudCluster, SolrIndexSplitterTest,
DefaultValueUpdateProcessorTest, TestEmbeddedSolrServerConstructors,
RemoteQueryErrorTest, OverseerStatusTest, SignatureUpdateProcessorFactoryTest,
TestSearchPerf, TestDownShardTolerantSearch, CdcrReplicationHandlerTest,
SimpleCollectionCreateDeleteTest, TestNumericTerms32,
CoreAdminCreateDiscoverTest, TestSolrQueryParserResource,
LukeRequestHandlerTest, ConjunctionSolrSpellCheckerTest,
CachingDirectoryFactoryTest, ClassificationUpdateProcessorFactoryTest,
TestFieldCacheSortRandom, TestSerializedLuceneMatchVersion,
StatsReloadRaceTest, TestUnifiedSolrHighlighter, TestCoreDiscovery,
TestCrossCoreJoin, TestQueryTypes, TestJoin, TestFieldCacheWithThreads,
CdcrBootstrapTest, TestSQLHandler, CircularListTest, JsonLoaderTest,
TestFieldTypeCollectionResource, TestConfig, TestPivotHelperCode,
TestHdfsUpdateLog, BlockJoinFacetDistribTest, TestDistributedGrouping,
TestJmxMonitoredMap, SliceStateTest, PeerSyncReplicationTest, TestInitParams,
DistributedFacetPivotLargeTest, EchoParamsTest, TestSearcherReuse,
TestJsonRequest, TestManagedResourceStorage, DistanceFunctionTest,
TestClusterProperties, TestTrie, TestFiltering, TestSchemaSimilarityResource,
AnalyticsQueryTest, TestSmileRequest, HdfsWriteToMultipleCollectionsTest,
TestSolr4Spatial, DeleteInactiveReplicaTest, HdfsSyncSliceTest,
TestDynamicFieldCollectionResource, TestDocSet, BufferStoreTest,
TestCollationFieldDocValues, TestFieldSortValues, TestIndexingPerformance,
TestSchemaManager, DistributedFacetPivotWhiteBoxTest,
CurrencyFieldOpenExchangeTest, TestUtils, TestSortByMinMaxFunction,
TestStressCloudBlindAtomicUpdates, TestAtomicUpdateErrorCases,
AliasIntegrationTest, TestJsonFacetRefinement, BlockJoinFacetSimpleTest,
SecurityConfHandlerTest, HttpSolrCallGetCoreTest, TestConfigSetsAPIZkFailure,
TestPerFieldSimilarityWithDefaultOverride, TestSolrXml, TestTestInjection,
ReplicationFactorTest, TestStressUserVersions, FieldAnalysisRequestHandlerTest,
TestCustomDocTransformer, WordBreakSolrSpellCheckerTest,
TestDistributedMissingSort, TestSolrIndexConfig, TestLocalFSCloudBackupRestore,
StatsComponentTest, TestSolrCoreSnapshots, TestMacros,
DistributedQueryComponentOptimizationTest, ResourceLoaderTest,
ZkSolrClientTest, TestRecoveryHdfs, TestScoreJoinQPNoScore,
TestQueryWrapperFilter, TestCopyFieldCollectionResource, SortSpecParsingTest,
DebugComponentTest, LeaderElectionContextKeyTest, DirectoryFactoryTest,
FacetPivotSmallTest, DistributedFacetPivotSmallAdvancedTest, DeleteShardTest,
OverseerModifyCollectionTest, TestHdfsBackupRestoreCore,
TestFuzzyAnalyzedSuggestions, TestExactSharedStatsCache,
TestDocBasedVersionConstraints, CdcrVersionReplicationTest,
CreateCollectionCleanupTest, SpellPossibilityIteratorTest,
TestLMDirichletSimilarityFactory, TestXmlQParser, AnalysisErrorHandlingTest,
TestManagedStopFilterFactory, TestComplexPhraseQParserPlugin,
SolrCloudExampleTest, TestIntervalFaceting, TestSolrConfigHandler,
ParsingFieldUpdateProcessorsTest, PreAnalyzedFieldTest, NoCacheHeaderTest,
DistributedIntervalFacetingTest, BigEndianAscendingWordDeserializerTest,
TimerUtilsTest, SortByFunctionTest, TestBadConfig, TermVectorComponentTest,
SharedFSAutoReplicaFailoverTest, TestLeaderElectionZkExpiry, TestReload,
TermVectorComponentDistributedTest, TestRTimerTree, NotRequiredUniqueKeyTest,
AddSchemaFieldsUpdateProcessorFactoryTest, ConnectionReuseTest,
CleanupOldIndexTest, TestReqParamsAPI, TestConfigSetImmutable,
TestGraphTermsQParserPlugin, SuggesterTSTTest, CollectionReloadTest,
TestGeoJSONResponseWriter, BadComponentTest, TestRealTimeGet, TestZkChroot,
RegexBoostProcessorTest, ChangedSchemaMergeTest, TemplateUpdateProcessorTest,
BasicZkTest, ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test,
CollectionsAPIDistributedZkTest, SyncSliceTest, OpenCloseCoreStressTest,
LeaderElectionIntegrationTest, ShardRoutingTest, FullSolrCloudDistribCmdsTest,
ClusterStateUpdateTest, TestRandomFaceting, TestRandomDVFaceting, ZkCLITest,
ShardRoutingCustomTest, AutoCommitTest, TestRecovery, TestHashPartitioner,
ZkControllerTest, HardAutoCommitTest, TestRangeQuery, TestCoreContainer,
SpellCheckComponentTest, TestGroupingSearch, SolrCmdDistributorTest,
PeerSyncTest, BadIndexSchemaTest, ConvertedLegacyTest, TestSort,
BasicFunctionalityTest, DirectUpdateHandlerTest, TestIndexSearcher,
ShowFileRequestHandlerTest, DistributedQueryElevationComponentTest,
CurrencyFieldXmlFileTest, TestExtendedDismaxParser, SpellCheckCollatorTest,
CoreAdminHandlerTest, TestFoldingMultitermQuery, SuggesterTest,
TestStressLucene, SpatialFilterTest, SuggesterWFSTTest, PolyFieldTest,
SchemaVersionSpecificBehaviorTest, SolrCoreCheckLockOnStartupTest, TestUpdate,
TestWordDelimiterFilterFactory, QueryEqualityTest,
DirectUpdateHandlerOptimizeTest, StatelessScriptUpdateProcessorFactoryTest,
SolrInfoMBeanTest, CacheHeaderTest, IndexBasedSpellCheckerTest,
TestSurroundQueryParser, DisMaxRequestHandlerTest, TestQueryUtils,
TestWriterPerf, DirectSolrSpellCheckerTest, TestReversedWildcardFilterFactory,
DocumentAnalysisRequestHandlerTest, TestOmitPositions,
FileBasedSpellCheckerTest, RequestHandlersTest, DocumentBuilderTest,
RequiredFieldsTest, TestSolrQueryParser, FastVectorHighlighterTest,
IndexSchemaRuntimeFieldTest, LoggingHandlerTest, IndexSchemaTest,
TestJmxIntegration, TestCollationField, ReturnFieldsTest,
UpdateRequestProcessorFactoryTest, MBeansHandlerTest, TestAnalyzedSuggestions,
BinaryUpdateRequestHandlerTest, TestPartialUpdateDeduplication,
TestPHPSerializedResponseWriter, PingRequestHandlerTest, CSVRequestHandlerTest,
TestComponentsName, TestLFUCache, HighlighterConfigTest,
TestQuerySenderListener, UpdateParamsTest, TestQuerySenderNoQuery,
ResponseLogComponentTest, TestStressRecovery, TestSolrDeletionPolicy2,
MinimalSchemaTest, TestPostingsSolrHighlighter, TestCodecSupport,
TestLMJelinekMercerSimilarityFactory, TestFastOutputStream,
URLClassifyProcessorTest, DateMathParserTest, TestSuggestSpellingConverter,
DOMUtilTest, ClusterStateTest, TestDocumentBuilder, FileUtilsTest,
SolrTestCaseJ4Test, TestJettySolrRunner, ActionThrottleTest,
CdcrReplicationDistributedZkTest, CdcrRequestHandlerTest,
CloudExitableDirectoryReaderTest, CollectionsAPIAsyncDistributedZkTest,
ConcurrentDeleteAndCreateCollectionTest, ConfigSetsAPITest, DeleteNodeTest,
DeleteReplicaTest, DeleteStatusTest, DistribDocExpirationUpdateProcessorTest,
DocValuesNotIndexedTest, ForceLeaderTest,
OutOfBoxZkACLAndCredentialsProvidersTest,
OverriddenZkACLAndCredentialsProvidersTest,
OverseerCollectionConfigSetProcessorTest, OverseerTaskQueueTest,
RollingRestartTest, SolrCLIZkUtilsTest, TestAuthenticationFramework,
TestCloudPseudoReturnFields, TestCollectionAPI, TestCryptoKeys,
TestLeaderElectionWithEmptyReplica, TestLeaderInitiatedRecoveryThread,
TestOnReconnectListenerSupport, TestRebalanceLeaders,
TestSolrCloudWithDelegationTokens, TestSolrCloudWithKerberosAlt,
TestStressLiveNodes, HdfsRecoveryZkTest, TestClusterStateMutator,
ZkStateReaderTest, ZkStateWriterTest, RuleEngineTest, RulesTest,
HdfsDirectoryFactoryTest, TestNRTOpen, TestReloadAndDeleteDocs,
TestShardHandlerFactory, TestSolrDynamicMBean, TestSolrCloudSnapshots,
TestConfigReload, CoreMergeIndexesAdminHandlerTest,
SegmentsInfoRequestHandlerTest, DistributedExpandComponentTest,
DistributedFacetExistsSmallTest, DistributedFacetPivotSmallTest,
DistributedQueryComponentCustomSortTest, DistributedSuggestComponentTest,
ShufflingReplicaListTransformerTest, SpatialHeatmapFacetsTest,
TestTrackingShardHandlerFactory, JavabinLoaderTest,
WrapperMergePolicyFactoryTest, CheckHdfsIndexTest, TestCloudManagedSchema,
TestManagedSchemaThreadSafety, MergeStrategyTest, TestNoOpRegenerator,
TestOverriddenPrefixQueryForCustomFieldType, TestSolr4Spatial2,
TestXmlQParserPlugin, TestMinMaxOnMultiValuedField, BJQParserTest,
GraphQueryTest, CloudMLTQParserTest, SimpleMLTQParserTest,
TestDFISimilarityFactory, TestDefaultStatsCache, TestDistribIDF]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestDistribIDF
-Dtests.seed=D55A06E42A659E6F -Dtests.slow=true -Dtests.locale=ar-LY
-Dtests.timezone=America/Knox_IN -Dtests.asserts=true
-Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 0.00s J1 | TestDistribIDF (suite) <<<
[junit4] > Throwable #1:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE
scope at org.apache.solr.search.stats.TestDistribIDF:
[junit4] > 1) Thread[id=54257,
name=OverseerHdfsCoreFailoverThread-97029437477158917-127.0.0.1:44203_solr-n_0000000002,
state=TIMED_WAITING, group=Overseer Hdfs SolrCore Failover Thread.]
[junit4] > at java.lang.Thread.sleep(Native Method)
[junit4] > at
org.apache.solr.cloud.OverseerAutoReplicaFailoverThread.run(OverseerAutoReplicaFailoverThread.java:137)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > at
__randomizedtesting.SeedInfo.seed([D55A06E42A659E6F]:0)
[junit4] Completed [622/658 (1!)] on J1 in 41.44s, 2 tests, 1 error <<<
FAILURES!
[...truncated 62502 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
