Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-8.x/1331/
1 tests failed.
FAILED:
junit.framework.TestSuite.org.apache.solr.cloud.NestedShardedAtomicUpdateTest
Error Message:
Clean up static fields (in @AfterClass?) and null them, your test still has
references to classes of which the sizes cannot be measured due to security
restrictions or Java 9 module encapsulation: - private static
org.apache.solr.client.solrj.impl.CloudSolrClient
org.apache.solr.cloud.NestedShardedAtomicUpdateTest.cloudClient - private
static java.util.List
org.apache.solr.cloud.NestedShardedAtomicUpdateTest.clients
Stack Trace:
junit.framework.AssertionFailedError: Clean up static fields (in @AfterClass?)
and null them, your test still has references to classes of which the sizes
cannot be measured due to security restrictions or Java 9 module encapsulation:
- private static org.apache.solr.client.solrj.impl.CloudSolrClient
org.apache.solr.cloud.NestedShardedAtomicUpdateTest.cloudClient
- private static java.util.List
org.apache.solr.cloud.NestedShardedAtomicUpdateTest.clients
at __randomizedtesting.SeedInfo.seed([90716384F59E160C]:0)
at
com.carrotsearch.randomizedtesting.rules.StaticFieldsInvariantRule$1.afterAlways(StaticFieldsInvariantRule.java:146)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Caused by: java.security.AccessControlException: access denied
("java.lang.RuntimePermission" "accessClassInPackage.sun.security.ssl")
at
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
at
java.security.AccessController.checkPermission(AccessController.java:886)
at java.lang.SecurityManager.checkPermission(SecurityManager.java:549)
at
java.lang.SecurityManager.checkPackageAccess(SecurityManager.java:1564)
at java.lang.Class.checkPackageAccess(Class.java:2372)
at java.lang.Class.checkMemberAccess(Class.java:2351)
at java.lang.Class.getDeclaredFields(Class.java:1915)
at
com.carrotsearch.randomizedtesting.rules.RamUsageEstimator$2.run(RamUsageEstimator.java:585)
at
com.carrotsearch.randomizedtesting.rules.RamUsageEstimator$2.run(RamUsageEstimator.java:582)
at java.security.AccessController.doPrivileged(Native Method)
at
com.carrotsearch.randomizedtesting.rules.RamUsageEstimator.createCacheEntry(RamUsageEstimator.java:582)
at
com.carrotsearch.randomizedtesting.rules.RamUsageEstimator.measureSizeOf(RamUsageEstimator.java:545)
at
com.carrotsearch.randomizedtesting.rules.RamUsageEstimator.sizeOfAll(RamUsageEstimator.java:387)
at
com.carrotsearch.randomizedtesting.rules.StaticFieldsInvariantRule$1.afterAlways(StaticFieldsInvariantRule.java:129)
... 11 more
Build Log:
[...truncated 14635 lines...]
[junit4] Suite: org.apache.solr.cloud.NestedShardedAtomicUpdateTest
[junit4] 2> 1046983 INFO
(SUITE-NestedShardedAtomicUpdateTest-seed#[90716384F59E160C]-worker) [ ]
o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to
test-framework derived value of
'/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/server/solr/configsets/_default/conf'
[junit4] 2> 1046984 INFO
(SUITE-NestedShardedAtomicUpdateTest-seed#[90716384F59E160C]-worker) [ ]
o.a.s.SolrTestCaseJ4 Created dataDir:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.cloud.NestedShardedAtomicUpdateTest_90716384F59E160C-001/data-dir-98-001
[junit4] 2> 1046984 INFO
(SUITE-NestedShardedAtomicUpdateTest-seed#[90716384F59E160C]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 1046986 INFO
(SUITE-NestedShardedAtomicUpdateTest-seed#[90716384F59E160C]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 1046986 INFO
(SUITE-NestedShardedAtomicUpdateTest-seed#[90716384F59E160C]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1046986 INFO
(SUITE-NestedShardedAtomicUpdateTest-seed#[90716384F59E160C]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.cloud.NestedShardedAtomicUpdateTest_90716384F59E160C-001/tempDir-001
[junit4] 2> 1046987 INFO
(SUITE-NestedShardedAtomicUpdateTest-seed#[90716384F59E160C]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1046987 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 1046987 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1046988 WARN (ZkTestServer Run Thread) [ ]
o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
[junit4] 2> 1047087 INFO
(SUITE-NestedShardedAtomicUpdateTest-seed#[90716384F59E160C]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port: 44177
[junit4] 2> 1047087 INFO
(SUITE-NestedShardedAtomicUpdateTest-seed#[90716384F59E160C]-worker) [ ]
o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:44177
[junit4] 2> 1047087 INFO
(SUITE-NestedShardedAtomicUpdateTest-seed#[90716384F59E160C]-worker) [ ]
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:44177
[junit4] 2> 1047087 INFO
(SUITE-NestedShardedAtomicUpdateTest-seed#[90716384F59E160C]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1 44177
[junit4] 2> 1047089 INFO
(SUITE-NestedShardedAtomicUpdateTest-seed#[90716384F59E160C]-worker) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1047091 INFO (zkConnectionManagerCallback-13197-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1047091 INFO
(SUITE-NestedShardedAtomicUpdateTest-seed#[90716384F59E160C]-worker) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1047102 INFO
(SUITE-NestedShardedAtomicUpdateTest-seed#[90716384F59E160C]-worker) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1047103 INFO (zkConnectionManagerCallback-13199-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1047104 INFO
(SUITE-NestedShardedAtomicUpdateTest-seed#[90716384F59E160C]-worker) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1047105 INFO
(SUITE-NestedShardedAtomicUpdateTest-seed#[90716384F59E160C]-worker) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1047108 INFO (zkConnectionManagerCallback-13201-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1047108 INFO
(SUITE-NestedShardedAtomicUpdateTest-seed#[90716384F59E160C]-worker) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1047117 WARN
(SUITE-NestedShardedAtomicUpdateTest-seed#[90716384F59E160C]-worker-SendThread(127.0.0.1:44177))
[ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for
session 0x10297b19cd80002.
[junit4] 2> => EndOfStreamException: Unable to read additional
data from server sessionid 0x10297b19cd80002, likely server has closed socket
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable
to read additional data from server sessionid 0x10297b19cd80002, likely server
has closed socket
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350)
~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275)
[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 1047220 INFO (jetty-launcher-13202-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1047220 INFO (jetty-launcher-13202-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1047220 INFO (jetty-launcher-13202-thread-1) [ ]
o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git:
e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 1047225 INFO (jetty-launcher-13202-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1047225 INFO (jetty-launcher-13202-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1047225 INFO (jetty-launcher-13202-thread-1) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1047226 INFO (jetty-launcher-13202-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@5c9328f4{/solr,null,AVAILABLE}
[junit4] 2> 1047227 INFO (jetty-launcher-13202-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@3e9fad13{SSL, (ssl,
http/1.1)}{127.0.0.1:36177}
[junit4] 2> 1047227 INFO (jetty-launcher-13202-thread-1) [ ]
o.e.j.s.Server Started @1047253ms
[junit4] 2> 1047227 INFO (jetty-launcher-13202-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
zkHost=127.0.0.1:44177/solr, hostPort=36177}
[junit4] 2> 1047227 ERROR (jetty-launcher-13202-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1047227 INFO (jetty-launcher-13202-thread-1) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1047228 INFO (jetty-launcher-13202-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
8.8.0
[junit4] 2> 1047228 INFO (jetty-launcher-13202-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1047228 INFO (jetty-launcher-13202-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
[junit4] 2> 1047228 INFO (jetty-launcher-13202-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2021-01-08T06:54:45.126Z
[junit4] 2> 1047231 INFO (jetty-launcher-13202-thread-1) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1047232 INFO (zkConnectionManagerCallback-13204-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1047232 INFO (jetty-launcher-13202-thread-1) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1047232 INFO (jetty-launcher-13202-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1047236 INFO (jetty-launcher-13202-thread-1) [ ]
o.a.s.c.SolrXmlConfig Metrics collection is disabled.
[junit4] 2> 1048109 INFO (jetty-launcher-13202-thread-1) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1048110 WARN (jetty-launcher-13202-thread-1) [ ]
o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport
since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 1048110 WARN (jetty-launcher-13202-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@20212a7d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1048110 WARN (jetty-launcher-13202-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@20212a7d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1048112 WARN (jetty-launcher-13202-thread-1) [ ]
o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport
since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 1048113 WARN (jetty-launcher-13202-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@3bd1cb16[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1048113 WARN (jetty-launcher-13202-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@3bd1cb16[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1048113 INFO (jetty-launcher-13202-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44177/solr
[junit4] 2> 1048115 INFO (jetty-launcher-13202-thread-1) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1048116 INFO (zkConnectionManagerCallback-13215-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1048116 INFO (jetty-launcher-13202-thread-1) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1048118 WARN
(jetty-launcher-13202-thread-1-SendThread(127.0.0.1:44177)) [ ]
o.a.z.ClientCnxn An exception was thrown while closing send thread for session
0x10297b19cd80004.
[junit4] 2> => EndOfStreamException: Unable to read additional
data from server sessionid 0x10297b19cd80004, likely server has closed socket
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable
to read additional data from server sessionid 0x10297b19cd80004, likely server
has closed socket
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350)
~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275)
[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 1048219 INFO (jetty-launcher-13202-thread-1)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 1048220 INFO (zkConnectionManagerCallback-13217-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1048220 INFO (jetty-launcher-13202-thread-1)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 1048304 INFO (jetty-launcher-13202-thread-1)
[n:127.0.0.1:36177_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:36177_solr
[junit4] 2> 1048304 INFO (jetty-launcher-13202-thread-1)
[n:127.0.0.1:36177_solr ] o.a.s.c.Overseer Overseer
(id=72787333087756293-127.0.0.1:36177_solr-n_0000000000) starting
[junit4] 2> 1048310 INFO
(OverseerStateUpdate-72787333087756293-127.0.0.1:36177_solr-n_0000000000)
[n:127.0.0.1:36177_solr ] o.a.s.c.Overseer Starting to work on the main
queue : 127.0.0.1:36177_solr
[junit4] 2> 1048322 INFO (jetty-launcher-13202-thread-1)
[n:127.0.0.1:36177_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:36177_solr
[junit4] 2> 1048324 INFO (jetty-launcher-13202-thread-1)
[n:127.0.0.1:36177_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 1048325 WARN (jetty-launcher-13202-thread-1)
[n:127.0.0.1:36177_solr ] o.a.s.c.CoreContainer Not all security plugins
configured! authentication=disabled authorization=disabled. Solr is only as
secure as you make it. Consider configuring authentication/authorization before
exposing Solr to users internal or external. See
https://s.apache.org/solrsecurity for more info
[junit4] 2> 1048340 INFO (zkCallback-13216-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1048342 INFO (jetty-launcher-13202-thread-1)
[n:127.0.0.1:36177_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.cloud.NestedShardedAtomicUpdateTest_90716384F59E160C-001/tempDir-001/node1
[junit4] 2> 1048360 INFO
(SUITE-NestedShardedAtomicUpdateTest-seed#[90716384F59E160C]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=1
[junit4] 2> 1048362 INFO
(SUITE-NestedShardedAtomicUpdateTest-seed#[90716384F59E160C]-worker) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1048366 INFO (zkConnectionManagerCallback-13232-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1048366 INFO
(SUITE-NestedShardedAtomicUpdateTest-seed#[90716384F59E160C]-worker) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1048367 INFO
(SUITE-NestedShardedAtomicUpdateTest-seed#[90716384F59E160C]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1048368 INFO
(SUITE-NestedShardedAtomicUpdateTest-seed#[90716384F59E160C]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:44177/solr ready
[junit4] 2> 1048415 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection
col1
[junit4] 2> 1048415 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default to /configs/col1.AUTOCREATED
[junit4] 2> 1048416 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/protwords.txt to /configs/col1.AUTOCREATED/protwords.txt
[junit4] 2> 1048417 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/managed-schema to /configs/col1.AUTOCREATED/managed-schema
[junit4] 2> 1048419 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/solrconfig.xml to /configs/col1.AUTOCREATED/solrconfig.xml
[junit4] 2> 1048420 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/synonyms.txt to /configs/col1.AUTOCREATED/synonyms.txt
[junit4] 2> 1048421 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/stopwords.txt to /configs/col1.AUTOCREATED/stopwords.txt
[junit4] 2> 1048422 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/schema.xml to /configs/col1.AUTOCREATED/schema.xml
[junit4] 2> 1048423 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/contractions_it.txt to
/configs/col1.AUTOCREATED/lang/contractions_it.txt
[junit4] 2> 1048424 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_no.txt to
/configs/col1.AUTOCREATED/lang/stopwords_no.txt
[junit4] 2> 1048425 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/contractions_ca.txt to
/configs/col1.AUTOCREATED/lang/contractions_ca.txt
[junit4] 2> 1048427 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stemdict_nl.txt to
/configs/col1.AUTOCREATED/lang/stemdict_nl.txt
[junit4] 2> 1048428 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_hy.txt to
/configs/col1.AUTOCREATED/lang/stopwords_hy.txt
[junit4] 2> 1048429 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_id.txt to
/configs/col1.AUTOCREATED/lang/stopwords_id.txt
[junit4] 2> 1048430 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_et.txt to
/configs/col1.AUTOCREATED/lang/stopwords_et.txt
[junit4] 2> 1048431 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ga.txt to
/configs/col1.AUTOCREATED/lang/stopwords_ga.txt
[junit4] 2> 1048432 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_da.txt to
/configs/col1.AUTOCREATED/lang/stopwords_da.txt
[junit4] 2> 1048433 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_hi.txt to
/configs/col1.AUTOCREATED/lang/stopwords_hi.txt
[junit4] 2> 1048434 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ja.txt to
/configs/col1.AUTOCREATED/lang/stopwords_ja.txt
[junit4] 2> 1048435 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_pt.txt to
/configs/col1.AUTOCREATED/lang/stopwords_pt.txt
[junit4] 2> 1048436 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_hu.txt to
/configs/col1.AUTOCREATED/lang/stopwords_hu.txt
[junit4] 2> 1048437 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_el.txt to
/configs/col1.AUTOCREATED/lang/stopwords_el.txt
[junit4] 2> 1048442 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ru.txt to
/configs/col1.AUTOCREATED/lang/stopwords_ru.txt
[junit4] 2> 1048446 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_tr.txt to
/configs/col1.AUTOCREATED/lang/stopwords_tr.txt
[junit4] 2> 1048447 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ar.txt to
/configs/col1.AUTOCREATED/lang/stopwords_ar.txt
[junit4] 2> 1048448 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/userdict_ja.txt to
/configs/col1.AUTOCREATED/lang/userdict_ja.txt
[junit4] 2> 1048449 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_it.txt to
/configs/col1.AUTOCREATED/lang/stopwords_it.txt
[junit4] 2> 1048452 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_eu.txt to
/configs/col1.AUTOCREATED/lang/stopwords_eu.txt
[junit4] 2> 1048455 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_cz.txt to
/configs/col1.AUTOCREATED/lang/stopwords_cz.txt
[junit4] 2> 1048461 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stoptags_ja.txt to
/configs/col1.AUTOCREATED/lang/stoptags_ja.txt
[junit4] 2> 1048466 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/contractions_fr.txt to
/configs/col1.AUTOCREATED/lang/contractions_fr.txt
[junit4] 2> 1048468 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_de.txt to
/configs/col1.AUTOCREATED/lang/stopwords_de.txt
[junit4] 2> 1048469 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_fa.txt to
/configs/col1.AUTOCREATED/lang/stopwords_fa.txt
[junit4] 2> 1048471 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/contractions_ga.txt to
/configs/col1.AUTOCREATED/lang/contractions_ga.txt
[junit4] 2> 1048472 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ca.txt to
/configs/col1.AUTOCREATED/lang/stopwords_ca.txt
[junit4] 2> 1048473 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_nl.txt to
/configs/col1.AUTOCREATED/lang/stopwords_nl.txt
[junit4] 2> 1048475 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_bg.txt to
/configs/col1.AUTOCREATED/lang/stopwords_bg.txt
[junit4] 2> 1048476 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_en.txt to
/configs/col1.AUTOCREATED/lang/stopwords_en.txt
[junit4] 2> 1048477 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_lv.txt to
/configs/col1.AUTOCREATED/lang/stopwords_lv.txt
[junit4] 2> 1048479 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_es.txt to
/configs/col1.AUTOCREATED/lang/stopwords_es.txt
[junit4] 2> 1048480 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_th.txt to
/configs/col1.AUTOCREATED/lang/stopwords_th.txt
[junit4] 2> 1048481 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ro.txt to
/configs/col1.AUTOCREATED/lang/stopwords_ro.txt
[junit4] 2> 1048482 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_fr.txt to
/configs/col1.AUTOCREATED/lang/stopwords_fr.txt
[junit4] 2> 1048484 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_sv.txt to
/configs/col1.AUTOCREATED/lang/stopwords_sv.txt
[junit4] 2> 1048485 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_fi.txt to
/configs/col1.AUTOCREATED/lang/stopwords_fi.txt
[junit4] 2> 1048486 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/hyphenations_ga.txt to
/configs/col1.AUTOCREATED/lang/hyphenations_ga.txt
[junit4] 2> 1048488 INFO
(OverseerThreadFactory-13224-thread-1-processing-n:127.0.0.1:36177_solr)
[n:127.0.0.1:36177_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_gl.txt to
/configs/col1.AUTOCREATED/lang/stopwords_gl.txt
[junit4] 2> 1048597 INFO
(OverseerStateUpdate-72787333087756293-127.0.0.1:36177_solr-n_0000000000)
[n:127.0.0.1:36177_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"col1",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"col1_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:36177_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1048600 INFO
(OverseerStateUpdate-72787333087756293-127.0.0.1:36177_solr-n_0000000000)
[n:127.0.0.1:36177_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"col1",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"col1_shard2_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:36177_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1048602 INFO
(OverseerStateUpdate-72787333087756293-127.0.0.1:36177_solr-n_0000000000)
[n:127.0.0.1:36177_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"col1",
[junit4] 2> "shard":"shard3",
[junit4] 2> "core":"col1_shard3_replica_n4",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:36177_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1048606 INFO
(OverseerStateUpdate-72787333087756293-127.0.0.1:36177_solr-n_0000000000)
[n:127.0.0.1:36177_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"col1",
[junit4] 2> "shard":"shard4",
[junit4] 2> "core":"col1_shard4_replica_n6",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:36177_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1048811 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
x:col1_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node3&collection.configName=col1.AUTOCREATED&newCollection=true&name=col1_shard1_replica_n1&action=CREATE&numShards=4&collection=col1&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1048811 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
x:col1_shard1_replica_n1 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 1048812 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
x:col1_shard4_replica_n6 ] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node8&collection.configName=col1.AUTOCREATED&newCollection=true&name=col1_shard4_replica_n6&action=CREATE&numShards=4&collection=col1&shard=shard4&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1048812 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
x:col1_shard3_replica_n4 ] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node7&collection.configName=col1.AUTOCREATED&newCollection=true&name=col1_shard3_replica_n4&action=CREATE&numShards=4&collection=col1&shard=shard3&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1048813 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
x:col1_shard2_replica_n2 ] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node5&collection.configName=col1.AUTOCREATED&newCollection=true&name=col1_shard2_replica_n2&action=CREATE&numShards=4&collection=col1&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1048825 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 8.8.0
[junit4] 2> 1048826 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 8.8.0
[junit4] 2> 1048827 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 8.8.0
[junit4] 2> 1048830 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 8.8.0
[junit4] 2> 1048832 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ] o.a.s.s.IndexSchema
Schema name=nested-docs
[junit4] 2> 1048833 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ] o.a.s.s.IndexSchema
Schema name=nested-docs
[junit4] 2> 1048844 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ] o.a.s.s.IndexSchema
Loaded schema nested-docs/1.6 with uniqueid field id
[junit4] 2> 1048844 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ] o.a.s.c.CoreContainer
Creating SolrCore 'col1_shard2_replica_n2' using configuration from configset
col1.AUTOCREATED, trusted=true
[junit4] 2> 1048844 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ] o.a.s.c.SolrCore
[[col1_shard2_replica_n2] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.cloud.NestedShardedAtomicUpdateTest_90716384F59E160C-001/tempDir-001/node1/col1_shard2_replica_n2],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.cloud.NestedShardedAtomicUpdateTest_90716384F59E160C-001/tempDir-001/node1/col1_shard2_replica_n2/data/]
[junit4] 2> 1048844 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ] o.a.s.s.IndexSchema
Loaded schema nested-docs/1.6 with uniqueid field id
[junit4] 2> 1048844 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ] o.a.s.c.CoreContainer
Creating SolrCore 'col1_shard1_replica_n1' using configuration from configset
col1.AUTOCREATED, trusted=true
[junit4] 2> 1048845 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ] o.a.s.s.IndexSchema
Schema name=nested-docs
[junit4] 2> 1048845 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ] o.a.s.c.SolrCore
[[col1_shard1_replica_n1] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.cloud.NestedShardedAtomicUpdateTest_90716384F59E160C-001/tempDir-001/node1/col1_shard1_replica_n1],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.cloud.NestedShardedAtomicUpdateTest_90716384F59E160C-001/tempDir-001/node1/col1_shard1_replica_n1/data/]
[junit4] 2> 1048846 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ] o.a.s.s.IndexSchema
Schema name=nested-docs
[junit4] 2> 1048850 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ] o.a.s.s.IndexSchema
Loaded schema nested-docs/1.6 with uniqueid field id
[junit4] 2> 1048850 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ] o.a.s.c.CoreContainer
Creating SolrCore 'col1_shard3_replica_n4' using configuration from configset
col1.AUTOCREATED, trusted=true
[junit4] 2> 1048850 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ] o.a.s.c.SolrCore
[[col1_shard3_replica_n4] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.cloud.NestedShardedAtomicUpdateTest_90716384F59E160C-001/tempDir-001/node1/col1_shard3_replica_n4],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.cloud.NestedShardedAtomicUpdateTest_90716384F59E160C-001/tempDir-001/node1/col1_shard3_replica_n4/data/]
[junit4] 2> 1048850 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ] o.a.s.s.IndexSchema
Loaded schema nested-docs/1.6 with uniqueid field id
[junit4] 2> 1048850 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ] o.a.s.c.CoreContainer
Creating SolrCore 'col1_shard4_replica_n6' using configuration from configset
col1.AUTOCREATED, trusted=true
[junit4] 2> 1048851 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ] o.a.s.c.SolrCore
[[col1_shard4_replica_n6] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.cloud.NestedShardedAtomicUpdateTest_90716384F59E160C-001/tempDir-001/node1/col1_shard4_replica_n6],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.cloud.NestedShardedAtomicUpdateTest_90716384F59E160C-001/tempDir-001/node1/col1_shard4_replica_n6/data/]
[junit4] 2> 1048879 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ] o.a.s.u.UpdateHandler
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1048879 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1048879 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ] o.a.s.u.UpdateHandler
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1048879 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1048879 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ] o.a.s.u.CommitTracker
Hard AutoCommit: disabled
[junit4] 2> 1048879 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ] o.a.s.u.CommitTracker
Soft AutoCommit: disabled
[junit4] 2> 1048880 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ] o.a.s.u.CommitTracker
Hard AutoCommit: disabled
[junit4] 2> 1048880 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ] o.a.s.u.CommitTracker
Soft AutoCommit: disabled
[junit4] 2> 1048881 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/col1.AUTOCREATED
[junit4] 2> 1048881 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ] o.a.s.u.UpdateHandler
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1048881 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1048881 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ] o.a.s.u.UpdateHandler
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1048881 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1048881 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/col1.AUTOCREATED
[junit4] 2> 1048881 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/col1.AUTOCREATED
[junit4] 2> 1048881 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 1048881 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ] o.a.s.u.UpdateLog Could
not find max version in index or recent updates, using new clock
1688300564543176704
[junit4] 2> 1048882 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ] o.a.s.u.CommitTracker
Hard AutoCommit: disabled
[junit4] 2> 1048882 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ] o.a.s.u.CommitTracker
Hard AutoCommit: disabled
[junit4] 2> 1048882 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ] o.a.s.u.CommitTracker
Soft AutoCommit: disabled
[junit4] 2> 1048882 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ] o.a.s.u.CommitTracker
Soft AutoCommit: disabled
[junit4] 2> 1048883 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/col1.AUTOCREATED
[junit4] 2> 1048883 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 1048883 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ] o.a.s.u.UpdateLog Could
not find max version in index or recent updates, using new clock
1688300564545273856
[junit4] 2> 1048884 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/col1.AUTOCREATED
[junit4] 2> 1048884 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/col1.AUTOCREATED
[junit4] 2> 1048885 INFO
(searcherExecutor-13234-thread-1-processing-n:127.0.0.1:36177_solr
x:col1_shard2_replica_n2 c:col1 s:shard2 r:core_node5) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ] o.a.s.c.SolrCore
[col1_shard2_replica_n2] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1048885 INFO
(searcherExecutor-13238-thread-1-processing-n:127.0.0.1:36177_solr
x:col1_shard3_replica_n4 c:col1 s:shard3 r:core_node7) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ] o.a.s.c.SolrCore
[col1_shard3_replica_n4] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1048885 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/col1.AUTOCREATED
[junit4] 2> 1048885 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 1048886 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ] o.a.s.u.UpdateLog Could
not find max version in index or recent updates, using new clock
1688300564548419584
[junit4] 2> 1048886 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/col1.AUTOCREATED
[junit4] 2> 1048886 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 1048886 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ] o.a.s.u.UpdateLog Could
not find max version in index or recent updates, using new clock
1688300564548419584
[junit4] 2> 1048887 INFO
(searcherExecutor-13240-thread-1-processing-n:127.0.0.1:36177_solr
x:col1_shard4_replica_n6 c:col1 s:shard4 r:core_node8) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ] o.a.s.c.SolrCore
[col1_shard4_replica_n6] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1048888 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ] o.a.s.c.ZkShardTerms
Successful update of terms at /collections/col1/terms/shard3 to
Terms{values={core_node7=0}, version=0}
[junit4] 2> 1048889 INFO
(searcherExecutor-13236-thread-1-processing-n:127.0.0.1:36177_solr
x:col1_shard1_replica_n1 c:col1 s:shard1 r:core_node3) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ] o.a.s.c.SolrCore
[col1_shard1_replica_n1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1048891 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ] o.a.s.c.ZkShardTerms
Successful update of terms at /collections/col1/terms/shard4 to
Terms{values={core_node8=0}, version=0}
[junit4] 2> 1048891 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ]
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created
/collections/col1/leaders/shard4
[junit4] 2> 1048894 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ] o.a.s.c.ZkShardTerms
Successful update of terms at /collections/col1/terms/shard1 to
Terms{values={core_node3=0}, version=0}
[junit4] 2> 1048894 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created
/collections/col1/leaders/shard1
[junit4] 2> 1048894 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ]
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created
/collections/col1/leaders/shard3
[junit4] 2> 1048897 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1048899 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ] o.a.s.c.ZkShardTerms
Successful update of terms at /collections/col1/terms/shard2 to
Terms{values={core_node5=0}, version=0}
[junit4] 2> 1048899 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ]
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created
/collections/col1/leaders/shard2
[junit4] 2> 1048899 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1048899 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ] o.a.s.c.SyncStrategy
Sync replicas to https://127.0.0.1:36177/solr/col1_shard4_replica_n6/
[junit4] 2> 1048899 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ] o.a.s.c.SyncStrategy
Sync Success - now sync replicas to me
[junit4] 2> 1048900 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ] o.a.s.c.SyncStrategy
https://127.0.0.1:36177/solr/col1_shard4_replica_n6/ has no replicas
[junit4] 2> 1048900 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ]
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
/collections/col1/leaders/shard4/leader after winning as
/collections/col1/leader_elect/shard4/election/72787333087756293-core_node8-n_0000000000
[junit4] 2> 1048902 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1048902 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1048902 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ] o.a.s.c.SyncStrategy
Sync replicas to https://127.0.0.1:36177/solr/col1_shard3_replica_n4/
[junit4] 2> 1048903 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1048903 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1048903 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ] o.a.s.c.SyncStrategy
Sync replicas to https://127.0.0.1:36177/solr/col1_shard1_replica_n1/
[junit4] 2> 1048904 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:36177/solr/col1_shard4_replica_n6/ shard4
[junit4] 2> 1048904 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1048904 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1048904 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ] o.a.s.c.SyncStrategy
Sync Success - now sync replicas to me
[junit4] 2> 1048904 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ] o.a.s.c.SyncStrategy
Sync replicas to https://127.0.0.1:36177/solr/col1_shard2_replica_n2/
[junit4] 2> 1048905 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ] o.a.s.c.SyncStrategy
https://127.0.0.1:36177/solr/col1_shard3_replica_n4/ has no replicas
[junit4] 2> 1048905 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ]
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
/collections/col1/leaders/shard3/leader after winning as
/collections/col1/leader_elect/shard3/election/72787333087756293-core_node7-n_0000000000
[junit4] 2> 1048905 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ] o.a.s.c.SyncStrategy
Sync Success - now sync replicas to me
[junit4] 2> 1048905 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ] o.a.s.c.SyncStrategy
https://127.0.0.1:36177/solr/col1_shard1_replica_n1/ has no replicas
[junit4] 2> 1048905 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
/collections/col1/leaders/shard1/leader after winning as
/collections/col1/leader_elect/shard1/election/72787333087756293-core_node3-n_0000000000
[junit4] 2> 1048906 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ] o.a.s.c.SyncStrategy
Sync Success - now sync replicas to me
[junit4] 2> 1048906 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ] o.a.s.c.SyncStrategy
https://127.0.0.1:36177/solr/col1_shard2_replica_n2/ has no replicas
[junit4] 2> 1048906 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ]
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
/collections/col1/leaders/shard2/leader after winning as
/collections/col1/leader_elect/shard2/election/72787333087756293-core_node5-n_0000000000
[junit4] 2> 1048915 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:36177/solr/col1_shard3_replica_n4/ shard3
[junit4] 2> 1048916 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:36177/solr/col1_shard1_replica_n1/ shard1
[junit4] 2> 1048916 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:36177/solr/col1_shard2_replica_n2/ shard2
[junit4] 2> 1049018 INFO (zkCallback-13216-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/col1/state.json] for
collection [col1] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1049018 INFO (zkCallback-13216-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/col1/state.json] for
collection [col1] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1049018 INFO (zkCallback-13216-thread-3) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/col1/state.json] for
collection [col1] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1049019 INFO (zkCallback-13216-thread-4) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/col1/state.json] for
collection [col1] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1049019 INFO (zkCallback-13216-thread-5) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/col1/state.json] for
collection [col1] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1049019 INFO (zkCallback-13216-thread-6) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/col1/state.json] for
collection [col1] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1049019 INFO (zkCallback-13216-thread-7) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/col1/state.json] for
collection [col1] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1049020 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ] o.a.s.c.ZkController I
am the leader, no recovery necessary
[junit4] 2> 1049021 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ] o.a.s.c.ZkController I
am the leader, no recovery necessary
[junit4] 2> 1049021 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ] o.a.s.c.ZkController I
am the leader, no recovery necessary
[junit4] 2> 1049021 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ] o.a.s.c.ZkController I
am the leader, no recovery necessary
[junit4] 2> 1049024 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node5&collection.configName=col1.AUTOCREATED&newCollection=true&name=col1_shard2_replica_n2&action=CREATE&numShards=4&collection=col1&shard=shard2&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=210
[junit4] 2> 1049025 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node8&collection.configName=col1.AUTOCREATED&newCollection=true&name=col1_shard4_replica_n6&action=CREATE&numShards=4&collection=col1&shard=shard4&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=213
[junit4] 2> 1049025 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=col1.AUTOCREATED&newCollection=true&name=col1_shard1_replica_n1&action=CREATE&numShards=4&collection=col1&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=214
[junit4] 2> 1049026 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node7&collection.configName=col1.AUTOCREATED&newCollection=true&name=col1_shard3_replica_n4&action=CREATE&numShards=4&collection=col1&shard=shard3&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=213
[junit4] 2> 1049028 INFO (qtp879216227-19669) [n:127.0.0.1:36177_solr
] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most
45 seconds. Check all shard replicas
[junit4] 2> 1049124 INFO (zkCallback-13216-thread-4) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/col1/state.json] for
collection [col1] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1049124 INFO (zkCallback-13216-thread-5) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/col1/state.json] for
collection [col1] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1049124 INFO (zkCallback-13216-thread-7) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/col1/state.json] for
collection [col1] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1049124 INFO (zkCallback-13216-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/col1/state.json] for
collection [col1] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1049124 INFO (zkCallback-13216-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/col1/state.json] for
collection [col1] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1049124 INFO (zkCallback-13216-thread-3) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/col1/state.json] for
collection [col1] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1049124 INFO (zkCallback-13216-thread-6) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/col1/state.json] for
collection [col1] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1049124 INFO (zkCallback-13216-thread-8) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/col1/state.json] for
collection [col1] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1049124 INFO (qtp879216227-19669) [n:127.0.0.1:36177_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={pullReplicas=0&maxShardsPerNode=4&name=col1&nrtReplicas=1&action=CREATE&numShards=4&tlogReplicas=0&wt=javabin&version=2}
status=0 QTime=719
[junit4] 2> 1049144 INFO
(TEST-NestedShardedAtomicUpdateTest.sendWrongRouteParam-seed#[90716384F59E160C])
[ ] o.a.s.SolrTestCaseJ4 ###Starting sendWrongRouteParam
[junit4] 2> 1049173 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ] o.a.s.c.ZkShardTerms
Successful update of terms at /collections/col1/terms/shard1 to
Terms{values={core_node3=1}, version=1}
[junit4] 2> 1049173 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard1_replica_n1] webapp=/solr
path=/update
params={update.distrib=TOLEADER&distrib.from=https://127.0.0.1:36177/solr/col1_shard2_replica_n2/&wt=javabin&version=2&_route_=1}{add=[1
(1688300564847263744)]} 0 2
[junit4] 2> 1049174 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard2_replica_n2] webapp=/solr
path=/update params={wt=javabin&version=2&_route_=1}{add=[1]} 0 26
[junit4] 2> 1049176 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard1_replica_n1] webapp=/solr
path=/update
params={update.distrib=TOLEADER&distrib.from=https://127.0.0.1:36177/solr/col1_shard2_replica_n2/&wt=javabin&version=2&_route_=1}{add=[1
(1688300564852506624)]} 0 1
[junit4] 2> 1049177 INFO (qtp879216227-19669) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard2_replica_n2] webapp=/solr
path=/update params={wt=javabin&version=2&_route_=1}{add=[1]} 0 2
[junit4] 2> 1049178 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard2_replica_n2] webapp=/solr
path=/update params={wt=javabin&version=2&_route_=c}{} 0 0
[junit4] 2> 1049179 INFO
(TEST-NestedShardedAtomicUpdateTest.sendWrongRouteParam-seed#[90716384F59E160C])
[ ] o.a.s.SolrTestCaseJ4 ###Ending sendWrongRouteParam
[junit4] 2> 1049197 INFO
(TEST-NestedShardedAtomicUpdateTest.doRootShardRoutingTest-seed#[90716384F59E160C])
[ ] o.a.s.SolrTestCaseJ4 ###Starting doRootShardRoutingTest
[junit4] 2> 1049200 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard1_replica_n1] webapp=/solr
path=/update
params={update.distrib=TOLEADER&distrib.from=https://127.0.0.1:36177/solr/col1_shard2_replica_n2/&wt=javabin&version=2&_route_=1}{add=[1
(1688300564877672448)]} 0 0
[junit4] 2> 1049200 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard2_replica_n2] webapp=/solr
path=/update params={wt=javabin&version=2&_route_=1}{add=[1]} 0 2
[junit4] 2> 1049202 INFO (qtp879216227-19669) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard1_replica_n1] webapp=/solr
path=/update
params={update.distrib=TOLEADER&distrib.from=https://127.0.0.1:36177/solr/col1_shard2_replica_n2/&wt=javabin&version=2&_route_=1}{add=[1
(1688300564878721024)]} 0 0
[junit4] 2> 1049202 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard2_replica_n2] webapp=/solr
path=/update params={wt=javabin&version=2&_route_=1}{add=[1]} 0 1
[junit4] 2> 1049205 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2&_route_=1}{add=[2 (root=1)
(1688300564881866752)]} 0 0
[junit4] 2> 1049208 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard1_replica_n1] webapp=/solr
path=/update
params={update.distrib=TOLEADER&distrib.from=https://127.0.0.1:36177/solr/col1_shard3_replica_n4/&wt=javabin&version=2&_route_=1}{add=[3
(root=1) (1688300564886061056)]} 0 0
[junit4] 2> 1049208 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard3_replica_n4] webapp=/solr
path=/update params={wt=javabin&version=2&_route_=1}{add=[3 (root=1)]} 0 1
[junit4] 2> 1049209 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ]
o.a.s.h.c.RealTimeGetComponent
LOOKUP_SLICE:shard1=https://127.0.0.1:36177/solr/col1_shard1_replica_n1/
[junit4] 2> 1049237 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ] o.a.s.c.S.Request
[col1_shard1_replica_n1] webapp=/solr path=/get
params={distrib=false&qt=/get&_stateVer_=col1:3&shards.purpose=1&shard.url=https://127.0.0.1:36177/solr/col1_shard1_replica_n1/&rid=127.0.0.1-86653&version=2&shards.qt=/get&omitHeader=false&NOW=1610088887107&ids=2&isShard=true&wt=javabin&_route_=1}
status=0 QTime=4
[junit4] 2> 1049238 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ] o.a.s.c.S.Request
[col1_shard3_replica_n4] webapp=/solr path=/get
params={qt=/get&_stateVer_=col1:3&id=2&wt=javabin&version=2&_route_=1}
rid=127.0.0.1-86653 status=0 QTime=28
[junit4] 2> 1049241 INFO
(searcherExecutor-13236-thread-1-processing-n:127.0.0.1:36177_solr
x:col1_shard1_replica_n1 c:col1 s:shard1 r:core_node3) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ] o.a.s.c.SolrCore
[col1_shard1_replica_n1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1049242 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard1_replica_n1] webapp=/solr
path=/update
params={update.distrib=TOLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:36177/solr/col1_shard2_replica_n2/&commit_end_point=leaders&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 2
[junit4] 2> 1049244 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard3_replica_n4] webapp=/solr
path=/update
params={update.distrib=TOLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:36177/solr/col1_shard2_replica_n2/&commit_end_point=leaders&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 0
[junit4] 2> 1049247 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard4_replica_n6] webapp=/solr
path=/update
params={update.distrib=TOLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:36177/solr/col1_shard2_replica_n2/&commit_end_point=leaders&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 0
[junit4] 2> 1049249 INFO (qtp879216227-19669) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard2_replica_n2] webapp=/solr
path=/update
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
0 11
[junit4] 2> 1049252 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ] o.a.s.c.S.Request
[col1_shard2_replica_n2] webapp=/solr path=/select
params={df=text&distrib=false&fl=id&fl=score&shards.purpose=16388&start=0&fsv=true&shard.url=https://127.0.0.1:36177/solr/col1_shard2_replica_n2/&rid=127.0.0.1-86654&rows=10&version=2&q=-_root_:1&omitHeader=false&NOW=1610088887149&isShard=true&wt=javabin}
hits=0 status=0 QTime=0
[junit4] 2> 1049255 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ] o.a.s.c.S.Request
[col1_shard4_replica_n6] webapp=/solr path=/select
params={df=text&distrib=false&fl=id&fl=score&shards.purpose=16388&start=0&fsv=true&shard.url=https://127.0.0.1:36177/solr/col1_shard4_replica_n6/&rid=127.0.0.1-86654&rows=10&version=2&q=-_root_:1&omitHeader=false&NOW=1610088887149&isShard=true&wt=javabin}
hits=0 status=0 QTime=0
[junit4] 2> 1049257 INFO (qtp879216227-19669) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ] o.a.s.c.S.Request
[col1_shard1_replica_n1] webapp=/solr path=/select
params={df=text&distrib=false&fl=id&fl=score&shards.purpose=16388&start=0&fsv=true&shard.url=https://127.0.0.1:36177/solr/col1_shard1_replica_n1/&rid=127.0.0.1-86654&rows=10&version=2&q=-_root_:1&omitHeader=false&NOW=1610088887149&isShard=true&wt=javabin}
hits=0 status=0 QTime=0
[junit4] 2> 1049258 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ] o.a.s.c.S.Request
[col1_shard3_replica_n4] webapp=/solr path=/select
params={df=text&distrib=false&fl=id&fl=score&shards.purpose=16388&start=0&fsv=true&shard.url=https://127.0.0.1:36177/solr/col1_shard3_replica_n4/&rid=127.0.0.1-86654&rows=10&version=2&q=-_root_:1&omitHeader=false&NOW=1610088887149&isShard=true&wt=javabin}
hits=0 status=0 QTime=0
[junit4] 2> 1049259 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ] o.a.s.c.S.Request
[col1_shard1_replica_n1] webapp=/solr path=/select
params={q=-_root_:1&wt=javabin&version=2} rid=127.0.0.1-86654 hits=0 status=0
QTime=8
[junit4] 2> 1049264 INFO (qtp879216227-19669) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ]
o.a.s.h.c.RealTimeGetComponent
LOOKUP_SLICE:shard2=https://127.0.0.1:36177/solr/col1_shard2_replica_n2/
[junit4] 2> 1049264 INFO (qtp879216227-19669) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ]
o.a.s.h.c.RealTimeGetComponent
LOOKUP_SLICE:shard3=https://127.0.0.1:36177/solr/col1_shard3_replica_n4/
[junit4] 2> 1049264 INFO (qtp879216227-19669) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ]
o.a.s.h.c.RealTimeGetComponent
LOOKUP_SLICE:shard4=https://127.0.0.1:36177/solr/col1_shard4_replica_n6/
[junit4] 2> 1049264 INFO (qtp879216227-19669) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ]
o.a.s.h.c.RealTimeGetComponent
LOOKUP_SLICE:shard1=https://127.0.0.1:36177/solr/col1_shard1_replica_n1/
[junit4] 2> 1049281 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ] o.a.s.c.S.Request
[col1_shard1_replica_n1] webapp=/solr path=/get
params={distrib=false&qt=/get&fl=*,+[child]&shards.purpose=1&shard.url=https://127.0.0.1:36177/solr/col1_shard1_replica_n1/&rid=127.0.0.1-86655&version=2&shards.qt=/get&omitHeader=false&NOW=1610088887160&ids=1&isShard=true&wt=javabin}
status=0 QTime=16
[junit4] 2> 1049281 INFO (qtp879216227-19669) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ] o.a.s.c.S.Request
[col1_shard4_replica_n6] webapp=/solr path=/get
params={qt=/get&fl=*,+[child]&id=1&wt=javabin&version=2} rid=127.0.0.1-86655
status=0 QTime=19
[junit4] 2> 1049284 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard1_replica_n1] webapp=/solr
path=/update
params={update.distrib=TOLEADER&distrib.from=https://127.0.0.1:36177/solr/col1_shard4_replica_n6/&wt=javabin&version=2&_route_=1}{add=[2
(root=1) (1688300564964704256)]} 0 1
[junit4] 2> 1049284 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard4_replica_n6] webapp=/solr
path=/update params={wt=javabin&version=2&_route_=1}{add=[2 (root=1)]} 0 2
[junit4] 2> 1049286 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard1_replica_n1] webapp=/solr
path=/update
params={update.distrib=TOLEADER&distrib.from=https://127.0.0.1:36177/solr/col1_shard2_replica_n2/&wt=javabin&version=2&_route_=1}{add=[3
(root=1) (1688300564967849984)]} 0 0
[junit4] 2> 1049286 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard2_replica_n2] webapp=/solr
path=/update params={wt=javabin&version=2&_route_=1}{add=[3 (root=1)]} 0 1
[junit4] 2> 1049287 INFO (qtp879216227-19669) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ]
o.a.s.h.c.RealTimeGetComponent
LOOKUP_SLICE:shard1=https://127.0.0.1:36177/solr/col1_shard1_replica_n1/
[junit4] 2> 1049291 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ] o.a.s.c.S.Request
[col1_shard1_replica_n1] webapp=/solr path=/get
params={distrib=false&qt=/get&shards.purpose=1&shard.url=https://127.0.0.1:36177/solr/col1_shard1_replica_n1/&rid=127.0.0.1-86656&version=2&shards.qt=/get&omitHeader=false&NOW=1610088887185&ids=2&isShard=true&wt=javabin&_route_=1}
status=0 QTime=3
[junit4] 2> 1049291 INFO (qtp879216227-19669) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ] o.a.s.c.S.Request
[col1_shard2_replica_n2] webapp=/solr path=/get
params={qt=/get&id=2&wt=javabin&version=2&_route_=1} rid=127.0.0.1-86656
status=0 QTime=4
[junit4] 2> 1049293 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard3_replica_n4] webapp=/solr
path=/update
params={update.distrib=TOLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:36177/solr/col1_shard2_replica_n2/&commit_end_point=leaders&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 1
[junit4] 2> 1049294 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard4_replica_n6] webapp=/solr
path=/update
params={update.distrib=TOLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:36177/solr/col1_shard2_replica_n2/&commit_end_point=leaders&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 1
[junit4] 2> 1049295 INFO
(searcherExecutor-13236-thread-1-processing-n:127.0.0.1:36177_solr
x:col1_shard1_replica_n1 c:col1 s:shard1 r:core_node3) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ] o.a.s.c.SolrCore
[col1_shard1_replica_n1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1049295 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard1_replica_n1] webapp=/solr
path=/update
params={update.distrib=TOLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:36177/solr/col1_shard2_replica_n2/&commit_end_point=leaders&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 1
[junit4] 2> 1049298 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard2_replica_n2] webapp=/solr
path=/update
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
0 6
[junit4] 2> 1049300 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ] o.a.s.c.S.Request
[col1_shard2_replica_n2] webapp=/solr path=/select
params={df=text&distrib=false&fl=id&fl=score&shards.purpose=16388&start=0&fsv=true&shard.url=https://127.0.0.1:36177/solr/col1_shard2_replica_n2/&rid=127.0.0.1-86657&rows=10&version=2&q=-_root_:1&omitHeader=false&NOW=1610088887197&isShard=true&wt=javabin}
hits=0 status=0 QTime=0
[junit4] 2> 1049300 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ] o.a.s.c.S.Request
[col1_shard1_replica_n1] webapp=/solr path=/select
params={df=text&distrib=false&fl=id&fl=score&shards.purpose=16388&start=0&fsv=true&shard.url=https://127.0.0.1:36177/solr/col1_shard1_replica_n1/&rid=127.0.0.1-86657&rows=10&version=2&q=-_root_:1&omitHeader=false&NOW=1610088887197&isShard=true&wt=javabin}
hits=0 status=0 QTime=0
[junit4] 2> 1049300 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ] o.a.s.c.S.Request
[col1_shard4_replica_n6] webapp=/solr path=/select
params={df=text&distrib=false&fl=id&fl=score&shards.purpose=16388&start=0&fsv=true&shard.url=https://127.0.0.1:36177/solr/col1_shard4_replica_n6/&rid=127.0.0.1-86657&rows=10&version=2&q=-_root_:1&omitHeader=false&NOW=1610088887197&isShard=true&wt=javabin}
hits=0 status=0 QTime=0
[junit4] 2> 1049302 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ] o.a.s.c.S.Request
[col1_shard3_replica_n4] webapp=/solr path=/select
params={df=text&distrib=false&fl=id&fl=score&shards.purpose=16388&start=0&fsv=true&shard.url=https://127.0.0.1:36177/solr/col1_shard3_replica_n4/&rid=127.0.0.1-86657&rows=10&version=2&q=-_root_:1&omitHeader=false&NOW=1610088887197&isShard=true&wt=javabin}
hits=0 status=0 QTime=0
[junit4] 2> 1049303 INFO (qtp879216227-19669) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ] o.a.s.c.S.Request
[col1_shard3_replica_n4] webapp=/solr path=/select
params={q=-_root_:1&wt=javabin&version=2} rid=127.0.0.1-86657 hits=0 status=0
QTime=3
[junit4] 2> 1049303 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ]
o.a.s.h.c.RealTimeGetComponent
LOOKUP_SLICE:shard2=https://127.0.0.1:36177/solr/col1_shard2_replica_n2/
[junit4] 2> 1049304 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ]
o.a.s.h.c.RealTimeGetComponent
LOOKUP_SLICE:shard3=https://127.0.0.1:36177/solr/col1_shard3_replica_n4/
[junit4] 2> 1049304 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ]
o.a.s.h.c.RealTimeGetComponent
LOOKUP_SLICE:shard4=https://127.0.0.1:36177/solr/col1_shard4_replica_n6/
[junit4] 2> 1049304 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ]
o.a.s.h.c.RealTimeGetComponent
LOOKUP_SLICE:shard1=https://127.0.0.1:36177/solr/col1_shard1_replica_n1/
[junit4] 2> 1049304 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ] o.a.s.c.S.Request
[col1_shard1_replica_n1] webapp=/solr path=/get
params={distrib=false&qt=/get&fl=*,+[child]&shards.purpose=1&shard.url=https://127.0.0.1:36177/solr/col1_shard1_replica_n1/&rid=127.0.0.1-86658&version=2&shards.qt=/get&omitHeader=false&NOW=1610088887201&ids=1&isShard=true&wt=javabin}
status=0 QTime=0
[junit4] 2> 1049305 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ] o.a.s.c.S.Request
[col1_shard2_replica_n2] webapp=/solr path=/get
params={qt=/get&fl=*,+[child]&id=1&wt=javabin&version=2} rid=127.0.0.1-86658
status=0 QTime=1
[junit4] 2> 1049307 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard1_replica_n1] webapp=/solr
path=/update
params={update.distrib=TOLEADER&distrib.from=https://127.0.0.1:36177/solr/col1_shard2_replica_n2/&wt=javabin&version=2&_route_=1}{add=[2
(root=1) (1688300564989870080)]} 0 1
[junit4] 2> 1049308 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard2_replica_n2] webapp=/solr
path=/update params={wt=javabin&version=2&_route_=1}{add=[2 (root=1)]} 0 2
[junit4] 2> 1049310 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard4_replica_n6] webapp=/solr
path=/update
params={update.distrib=TOLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:36177/solr/col1_shard2_replica_n2/&commit_end_point=leaders&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 0
[junit4] 2> 1049310 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard3_replica_n4] webapp=/solr
path=/update
params={update.distrib=TOLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:36177/solr/col1_shard2_replica_n2/&commit_end_point=leaders&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 0
[junit4] 2> 1049313 INFO
(searcherExecutor-13236-thread-1-processing-n:127.0.0.1:36177_solr
x:col1_shard1_replica_n1 c:col1 s:shard1 r:core_node3) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ] o.a.s.c.SolrCore
[col1_shard1_replica_n1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1049313 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard1_replica_n1] webapp=/solr
path=/update
params={update.distrib=TOLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:36177/solr/col1_shard2_replica_n2/&commit_end_point=leaders&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 3
[junit4] 2> 1049313 INFO (qtp879216227-19669) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard2_replica_n2] webapp=/solr
path=/update
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
0 4
[junit4] 2> 1049315 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard1_replica_n1] webapp=/solr
path=/update
params={update.distrib=TOLEADER&distrib.from=https://127.0.0.1:36177/solr/col1_shard3_replica_n4/&wt=javabin&version=2&_route_=1}{add=[3
(root=1) (1688300564998258688)]} 0 0
[junit4] 2> 1049316 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard3 r:core_node7 x:col1_shard3_replica_n4 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard3_replica_n4] webapp=/solr
path=/update params={wt=javabin&version=2&_route_=1}{add=[3 (root=1)]} 0 1
[junit4] 2> 1049316 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ]
o.a.s.h.c.RealTimeGetComponent
LOOKUP_SLICE:shard1=https://127.0.0.1:36177/solr/col1_shard1_replica_n1/
[junit4] 2> 1049319 INFO (qtp879216227-19671) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ] o.a.s.c.S.Request
[col1_shard1_replica_n1] webapp=/solr path=/get
params={distrib=false&qt=/get&shards.purpose=1&shard.url=https://127.0.0.1:36177/solr/col1_shard1_replica_n1/&rid=127.0.0.1-86659&version=2&shards.qt=/get&omitHeader=false&NOW=1610088887214&ids=2&isShard=true&wt=javabin&_route_=1}
status=0 QTime=1
[junit4] 2> 1049319 INFO (qtp879216227-19672) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ] o.a.s.c.S.Request
[col1_shard4_replica_n6] webapp=/solr path=/get
params={qt=/get&id=2&wt=javabin&version=2&_route_=1} rid=127.0.0.1-86659
status=0 QTime=3
[junit4] 2> 1049322 INFO
(searcherExecutor-13236-thread-1-processing-n:127.0.0.1:36177_solr
x:col1_shard1_replica_n1 c:col1 s:shard1 r:core_node3) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ] o.a.s.c.SolrCore
[col1_shard1_replica_n1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1049322 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard1 r:core_node3 x:col1_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard1_replica_n1] webapp=/solr
path=/update
params={update.distrib=TOLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:36177/solr/col1_shard3_replica_n4/&commit_end_point=leaders&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 1
[junit4] 2> 1049323 INFO (qtp879216227-19668) [n:127.0.0.1:36177_solr
c:col1 s:shard4 r:core_node8 x:col1_shard4_replica_n6 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard4_replica_n6] webapp=/solr
path=/update
params={update.distrib=TOLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:36177/solr/col1_shard3_replica_n4/&commit_end_point=leaders&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 0
[junit4] 2> 1049323 INFO (qtp879216227-19670) [n:127.0.0.1:36177_solr
c:col1 s:shard2 r:core_node5 x:col1_shard2_replica_n2 ]
o.a.s.u.p.LogUpdateProcessorFactory [col1_shard2_replica_n2] webapp=/solr
path=/update params={update.distrib=TOLEADER&waitSearcher=tru
[...truncated too long message...]
etty-closer-13257-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.node tag=null
[junit4] 2> 1049587 INFO (jetty-closer-13257-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm
tag=null
[junit4] 2> 1049587 INFO (jetty-closer-13257-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty
tag=null
[junit4] 2> 1049587 INFO (jetty-closer-13257-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster
tag=null
[junit4] 2> 1049588 INFO (closeThreadPool-13263-thread-2) [ ]
o.a.s.c.Overseer Overseer
(id=72787333087756293-127.0.0.1:36177_solr-n_0000000000) closing
[junit4] 2> 1049588 INFO
(OverseerAutoScalingTriggerThread-72787333087756293-127.0.0.1:36177_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we
are closed, exiting.
[junit4] 2> 1049590 INFO
(OverseerStateUpdate-72787333087756293-127.0.0.1:36177_solr-n_0000000000)
[n:127.0.0.1:36177_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:36177_solr
[junit4] 2> 1049590 INFO (closeThreadPool-13263-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=72787333087756293-127.0.0.1:36177_solr-n_0000000000) closing
[junit4] 2> 1049591 WARN
(jetty-launcher-13202-thread-1-SendThread(127.0.0.1:44177)) [ ]
o.a.z.ClientCnxn An exception was thrown while closing send thread for session
0x10297b19cd80005.
[junit4] 2> => EndOfStreamException: Unable to read additional
data from server sessionid 0x10297b19cd80005, likely server has closed socket
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable
to read additional data from server sessionid 0x10297b19cd80005, likely server
has closed socket
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350)
~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275)
[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 1049692 INFO (jetty-closer-13257-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=72787333087756293-127.0.0.1:36177_solr-n_0000000000) closing
[junit4] 2> 1049693 INFO (jetty-closer-13257-thread-1) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@3e9fad13{SSL, (ssl,
http/1.1)}{127.0.0.1:0}
[junit4] 2> 1049693 INFO (jetty-closer-13257-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@5c9328f4{/solr,null,STOPPED}
[junit4] 2> 1049694 INFO (jetty-closer-13257-thread-1) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1049694 INFO
(SUITE-NestedShardedAtomicUpdateTest-seed#[90716384F59E160C]-worker) [ ]
o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 1049896 WARN (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 3 /solr/collections/col1/terms/shard1
[junit4] 2> 2 /solr/aliases.json
[junit4] 2> 2 /solr/collections/col1/terms/shard3
[junit4] 2> 2 /solr/collections/col1/terms/shard2
[junit4] 2> 2 /solr/collections/col1/terms/shard4
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 23 /solr/collections/col1/state.json
[junit4] 2> 2 /solr/clusterstate.json
[junit4] 2> 2 /solr/clusterprops.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 18 /solr/overseer/queue
[junit4] 2> 4 /solr/collections
[junit4] 2> 4 /solr/overseer/collection-queue-work
[junit4] 2> 3 /solr/live_nodes
[junit4] 2>
[junit4] 2> 1049900 INFO
(SUITE-NestedShardedAtomicUpdateTest-seed#[90716384F59E160C]-worker) [ ]
o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:44177
[junit4] 2> 1049900 INFO
(SUITE-NestedShardedAtomicUpdateTest-seed#[90716384F59E160C]-worker) [ ]
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:44177
[junit4] 2> 1049900 INFO
(SUITE-NestedShardedAtomicUpdateTest-seed#[90716384F59E160C]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1 44177
[junit4] 2> 1049900 INFO
(SUITE-NestedShardedAtomicUpdateTest-seed#[90716384F59E160C]-worker) [ ]
o.a.s.SolrTestCaseJ4 -------------------------------------------------------
Done waiting for tracked resources to be released
[junit4] 2> Jan 08, 2021 6:54:47 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene87):
{level_s=PostingsFormat(name=LuceneVarGapDocFreqInterval),
_root_=PostingsFormat(name=LuceneVarGapDocFreqInterval),
_nest_parent_=PostingsFormat(name=Asserting), _nest_path_=FST50,
id=PostingsFormat(name=LuceneVarGapFixedInterval)},
docValues:{id_i=DocValuesFormat(name=Asserting),
_version_=DocValuesFormat(name=Direct),
_nest_path_=DocValuesFormat(name=Lucene80),
inplace_updatable_int=DocValuesFormat(name=Asserting)},
maxPointsInLeafNode=1427, maxMBSortInHeap=7.0443750915615455,
sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=sk,
timezone=SystemV/AST4
[junit4] 2> NOTE: Linux 4.15.0-112-generic amd64/Oracle Corporation
1.8.0_252 (64-bit)/cpus=4,threads=1,free=437826168,total=531103744
[junit4] 2> NOTE: All tests run in this JVM:
[TestSlowCompositeReaderWrapper, LukeRequestHandlerTest, PrimUtilsTest,
TestLegacyNumericUtils, TestCollapseQParserPlugin, ZkNodePropsTest,
UpdateParamsTest, TestSolrCoreSnapshots, TestSolrConfigHandler,
TestStandardQParsers, TestRecovery, BasicFunctionalityTest, TestTrieFacet,
DocumentAnalysisRequestHandlerTest, TestSolrCoreProperties,
TestManagedResourceStorage, Tagger2Test, TestManagedStopFilterFactory,
TestReplicaProperties, TestDistribIDF, TestBackupRepositoryFactory,
CollectionsAPIDistributedZkTest, DocValuesNotIndexedTest,
TestReversedWildcardFilterFactory, TestSolrXml,
OverseerSolrResponseUnsafeSerializationTest, MaxSizeAutoCommitTest,
TestAuthorizationFramework, AuditLoggerIntegrationTest, TestDistributedSearch,
TestCircuitBreaker, CollectionsAPISolrJTest, AggValueSourceTest,
CdcrUpdateLogTest, ParsingFieldUpdateProcessorsTest,
TestRandomCollapseQParserPlugin, PropertiesRequestHandlerTest,
TestFieldCacheVsDocValues, TestCollectionAPI, TestPushWriter, TestOrdValues,
TestShortCircuitedRequests, TimeZoneUtilsTest, ResponseHeaderTest,
ResponseBuilderTest, TestLMJelinekMercerSimilarityFactory,
CurrencyFieldTypeTest, DimensionalRoutedAliasUpdateProcessorTest,
TestCSVLoader, TestPullReplicaErrorHandling,
PeerSyncWithLeaderAndIndexFingerprintCachingTest, SmileWriterTest,
TestConfigSetsAPIZkFailure, MetricTriggerIntegrationTest, SchemaApiFailureTest,
PingRequestHandlerTest, TestSolrQueryResponse, SampleTest,
TestSortableTextField, MergeStrategyTest, DirectoryFactoriesTest,
HttpTriggerListenerTest, ReplicationFactorTest, DynamicMapsTest,
NumericFieldsTest, HttpPartitionOnCommitTest,
DistributedFacetPivotLongTailTest, SpellCheckCollatorWithCollapseTest,
GraphQueryTest, TestFoldingMultitermQuery, TestFieldCache,
TestSchemaSimilarityResource, SolrRrdBackendFactoryTest,
ClassificationUpdateProcessorIntegrationTest, TestNumericTerms64,
ZkDynamicConfigTest, CdcrVersionReplicationTest, CacheHeaderTest,
AssignBackwardCompatibilityTest, ProtectedTermFilterFactoryTest,
ReindexCollectionTest, TestPerFieldSimilarityWithDefaultOverride,
BigEndianAscendingWordSerializerTest, InfixSuggestersTest, TestWriterPerf,
WordBreakSolrSpellCheckerTest, SolrCLIZkUtilsTest,
NestedShardedAtomicUpdateTest]
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=NestedShardedAtomicUpdateTest -Dtests.seed=90716384F59E160C
-Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=sk
-Dtests.timezone=SystemV/AST4 -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J1 | NestedShardedAtomicUpdateTest (suite) <<<
[junit4] > Throwable #1: junit.framework.AssertionFailedError: Clean up
static fields (in @AfterClass?) and null them, your test still has references
to classes of which the sizes cannot be measured due to security restrictions
or Java 9 module encapsulation:
[junit4] > - private static
org.apache.solr.client.solrj.impl.CloudSolrClient
org.apache.solr.cloud.NestedShardedAtomicUpdateTest.cloudClient
[junit4] > - private static java.util.List
org.apache.solr.cloud.NestedShardedAtomicUpdateTest.clients
[junit4] > at
__randomizedtesting.SeedInfo.seed([90716384F59E160C]:0)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > Caused by: java.security.AccessControlException: access denied
("java.lang.RuntimePermission" "accessClassInPackage.sun.security.ssl")
[junit4] > at
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
[junit4] > at
java.security.AccessController.checkPermission(AccessController.java:886)
[junit4] > at
java.lang.SecurityManager.checkPermission(SecurityManager.java:549)
[junit4] > at
java.lang.SecurityManager.checkPackageAccess(SecurityManager.java:1564)
[junit4] > at java.lang.Class.checkPackageAccess(Class.java:2372)
[junit4] > at java.lang.Class.checkMemberAccess(Class.java:2351)
[junit4] > at java.lang.Class.getDeclaredFields(Class.java:1915)
[junit4] > at java.security.AccessController.doPrivileged(Native
Method)
[junit4] > ... 11 more
[junit4] Completed [411/924 (1!)] on J1 in 4.01s, 3 tests, 1 failure <<<
FAILURES!
[...truncated 52432 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
