Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-MacOSX/5872/
Java: 64bit/jdk-13.0.2 -XX:-UseCompressedOops -XX:+UseSerialGC

1 tests failed.
FAILED:  junit.framework.TestSuite.org.apache.solr.TestHighlightDedupGrouping

Error Message:
Suite timeout exceeded (>= 7200000 msec).

Stack Trace:
java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
        at __randomizedtesting.SeedInfo.seed([BB9B3BC38E7156BE]:0)




Build Log:
[...truncated 16071 lines...]
   [junit4] Suite: org.apache.solr.TestHighlightDedupGrouping
   [junit4]   2> 1065884 INFO  
(SUITE-TestHighlightDedupGrouping-seed#[BB9B3BC38E7156BE]-worker) [     ] 
o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to 
test-framework derived value of 
'/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/server/solr/configsets/_default/conf'
   [junit4]   2> 1065884 INFO  
(SUITE-TestHighlightDedupGrouping-seed#[BB9B3BC38E7156BE]-worker) [     ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 1065885 INFO  
(SUITE-TestHighlightDedupGrouping-seed#[BB9B3BC38E7156BE]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Created dataDir: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestHighlightDedupGrouping_BB9B3BC38E7156BE-001/data-dir-93-001
   [junit4]   2> 1065885 WARN  
(SUITE-TestHighlightDedupGrouping-seed#[BB9B3BC38E7156BE]-worker) [     ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=57 numCloses=57
   [junit4]   2> 1065885 INFO  
(SUITE-TestHighlightDedupGrouping-seed#[BB9B3BC38E7156BE]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 1065886 INFO  
(SUITE-TestHighlightDedupGrouping-seed#[BB9B3BC38E7156BE]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, 
clientAuth=0.0/0.0) w/ MAC_OS_X supressed clientAuth
   [junit4]   2> 1065886 INFO  
(SUITE-TestHighlightDedupGrouping-seed#[BB9B3BC38E7156BE]-worker) [     ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /yo/gu
   [junit4]   2> 1066272 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestHighlightDedupGrouping_BB9B3BC38E7156BE-001/tempDir-001/control/cores/collection1
   [junit4]   2> 1066275 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 1066275 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 1066276 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: 
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 13.0.2+8
   [junit4]   2> 1066278 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1066278 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1066279 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1066281 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@623bc5ac{/yo/gu,null,AVAILABLE}
   [junit4]   2> 1066282 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@d5c4780{HTTP/1.1, (http/1.1, 
h2c)}{127.0.0.1:53910}
   [junit4]   2> 1066282 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.s.Server Started @1066351ms
   [junit4]   2> 1066282 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/yo/gu, 
hostPort=53910, 
coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestHighlightDedupGrouping_BB9B3BC38E7156BE-001/tempDir-001/control/cores}
   [junit4]   2> 1066282 ERROR 
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1066283 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1066283 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
9.0.0
   [junit4]   2> 1066283 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 1066283 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr
   [junit4]   2> 1066283 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2020-04-10T06:06:14.258411Z
   [junit4]   2> 1066283 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestHighlightDedupGrouping_BB9B3BC38E7156BE-001/tempDir-001/control/solr.xml
   [junit4]   2> 1066287 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6c15675, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1066397 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 1066399 WARN  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@2184c17d[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1066399 WARN  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@2184c17d[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1066403 WARN  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@3553d513[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1066404 WARN  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@3553d513[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1066405 WARN  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
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> 1066427 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1066428 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history 
in memory.
   [junit4]   2> 1066464 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6c15675
   [junit4]   2> 1066493 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6c15675
   [junit4]   2> 1066493 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6c15675
   [junit4]   2> 1066495 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestHighlightDedupGrouping_BB9B3BC38E7156BE-001/tempDir-001/control/cores
   [junit4]   2> 1066495 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1066504 INFO  (coreLoadExecutor-3792-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
   [junit4]   2> 1066544 INFO  (coreLoadExecutor-3792-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 1066693 INFO  (coreLoadExecutor-3792-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field 
id
   [junit4]   2> 1066727 INFO  (coreLoadExecutor-3792-thread-1) [    
x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 1066732 INFO  (coreLoadExecutor-3792-thread-1) [    
x:collection1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6c15675
   [junit4]   2> 1066732 INFO  (coreLoadExecutor-3792-thread-1) [    
x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestHighlightDedupGrouping_BB9B3BC38E7156BE-001/tempDir-001/control/cores/collection1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestHighlightDedupGrouping_BB9B3BC38E7156BE-001/tempDir-001/control/cores/collection1/data/]
   [junit4]   2> 1066735 INFO  (coreLoadExecutor-3792-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=15, maxMergeAtOnceExplicit=18, maxMergedSegmentMB=22.765625, 
floorSegmentMB=1.15625, forceMergeDeletesPctAllowed=7.971810532833699, 
segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.5917722645522187, deletesPctAllowed=47.34581742595319
   [junit4]   2> 1066875 INFO  (coreLoadExecutor-3792-thread-1) [    
x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1066875 INFO  (coreLoadExecutor-3792-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 1066877 INFO  (coreLoadExecutor-3792-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1066877 INFO  (coreLoadExecutor-3792-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1066882 INFO  (coreLoadExecutor-3792-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=17, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.4657402078219245]
   [junit4]   2> 1066885 INFO  (coreLoadExecutor-3792-thread-1) [    
x:collection1 ] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@5bfe93ef[collection1] main]
   [junit4]   2> 1066887 INFO  (coreLoadExecutor-3792-thread-1) [    
x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1066961 INFO  (coreLoadExecutor-3792-thread-1) [    
x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct, 
classname=DirectSolrSpellChecker, field=lowerfilt, minQueryLength=3}
   [junit4]   2> 1067093 INFO  (coreLoadExecutor-3792-thread-1) [    
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1067093 INFO  (coreLoadExecutor-3792-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1663564539565703168
   [junit4]   2> 1067094 INFO  
(searcherExecutor-3793-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1067094 INFO  
(searcherExecutor-3793-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1067094 INFO  
(searcherExecutor-3793-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1067094 INFO  
(searcherExecutor-3793-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 1067095 INFO  
(searcherExecutor-3793-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1067095 INFO  
(searcherExecutor-3793-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1067095 ERROR (coreZkRegister-3784-thread-1) [    
x:collection1 ] o.a.s.c.ZkContainer 
   [junit4]   2>           => java.lang.NullPointerException
   [junit4]   2>        at 
org.apache.solr.core.ZkContainer.lambda$registerInZk$1(ZkContainer.java:196)
   [junit4]   2> java.lang.NullPointerException: null
   [junit4]   2>        at 
org.apache.solr.core.ZkContainer.lambda$registerInZk$1(ZkContainer.java:196) 
~[java/:?]
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
 ~[java/:?]
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) 
~[?:?]
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) 
~[?:?]
   [junit4]   2>        at java.lang.Thread.run(Thread.java:830) [?:?]
   [junit4]   2> 1067096 ERROR (coreZkRegister-3784-thread-1) [    
x:collection1 ] o.a.s.c.ZkContainer :java.lang.NullPointerException
   [junit4]   2>        at 
org.apache.solr.core.ZkContainer.lambda$registerInZk$1(ZkContainer.java:184)
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
   [junit4]   2>        at 
java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
   [junit4]   2>        at 
java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
   [junit4]   2>        at java.base/java.lang.Thread.run(Thread.java:830)
   [junit4]   2> 
   [junit4]   2> 1067097 INFO  
(searcherExecutor-3793-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1067097 INFO  
(searcherExecutor-3793-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1067098 INFO  
(searcherExecutor-3793-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1067100 INFO  
(searcherExecutor-3793-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@5bfe93ef[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1067509 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestHighlightDedupGrouping_BB9B3BC38E7156BE-001/tempDir-001/shard0/cores/collection1
   [junit4]   2> 1067511 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 1067511 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 1067511 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: 
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 13.0.2+8
   [junit4]   2> 1067512 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1067512 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1067512 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1067517 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@4bce2bf4{/yo/gu,null,AVAILABLE}
   [junit4]   2> 1067518 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@41bf79a5{HTTP/1.1, (http/1.1, 
h2c)}{127.0.0.1:53916}
   [junit4]   2> 1067519 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.s.Server Started @1067587ms
   [junit4]   2> 1067519 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/yo/gu, 
hostPort=53916, 
coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestHighlightDedupGrouping_BB9B3BC38E7156BE-001/tempDir-001/shard0/cores}
   [junit4]   2> 1067519 ERROR 
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1067519 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1067519 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
9.0.0
   [junit4]   2> 1067519 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 1067519 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr
   [junit4]   2> 1067519 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2020-04-10T06:06:15.494714Z
   [junit4]   2> 1067519 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestHighlightDedupGrouping_BB9B3BC38E7156BE-001/tempDir-001/shard0/solr.xml
   [junit4]   2> 1067524 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6c15675, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1067608 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 1067615 WARN  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@4b50627[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1067615 WARN  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@4b50627[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1067621 WARN  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@7fb624be[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1067621 WARN  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@7fb624be[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1067623 WARN  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
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> 1067650 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1067650 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history 
in memory.
   [junit4]   2> 1067693 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6c15675
   [junit4]   2> 1067717 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6c15675
   [junit4]   2> 1067717 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6c15675
   [junit4]   2> 1067718 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestHighlightDedupGrouping_BB9B3BC38E7156BE-001/tempDir-001/shard0/cores
   [junit4]   2> 1067719 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1067738 INFO  (coreLoadExecutor-3806-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
   [junit4]   2> 1067760 INFO  (coreLoadExecutor-3806-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 1067865 INFO  (coreLoadExecutor-3806-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field 
id
   [junit4]   2> 1067878 INFO  (coreLoadExecutor-3806-thread-1) [    
x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 1067878 INFO  (coreLoadExecutor-3806-thread-1) [    
x:collection1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6c15675
   [junit4]   2> 1067878 INFO  (coreLoadExecutor-3806-thread-1) [    
x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestHighlightDedupGrouping_BB9B3BC38E7156BE-001/tempDir-001/shard0/cores/collection1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestHighlightDedupGrouping_BB9B3BC38E7156BE-001/tempDir-001/shard0/cores/collection1/data/]
   [junit4]   2> 1067880 INFO  (coreLoadExecutor-3806-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=15, maxMergeAtOnceExplicit=18, maxMergedSegmentMB=22.765625, 
floorSegmentMB=1.15625, forceMergeDeletesPctAllowed=7.971810532833699, 
segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.5917722645522187, deletesPctAllowed=47.34581742595319
   [junit4]   2> 1067957 INFO  (coreLoadExecutor-3806-thread-1) [    
x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1067957 INFO  (coreLoadExecutor-3806-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 1067960 INFO  (coreLoadExecutor-3806-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1067960 INFO  (coreLoadExecutor-3806-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1067961 INFO  (coreLoadExecutor-3806-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=17, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.4657402078219245]
   [junit4]   2> 1067961 INFO  (coreLoadExecutor-3806-thread-1) [    
x:collection1 ] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@5b4de690[collection1] main]
   [junit4]   2> 1067963 INFO  (coreLoadExecutor-3806-thread-1) [    
x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1067990 INFO  (coreLoadExecutor-3806-thread-1) [    
x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct, 
classname=DirectSolrSpellChecker, field=lowerfilt, minQueryLength=3}
   [junit4]   2> 1068094 INFO  (coreLoadExecutor-3806-thread-1) [    
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1068094 INFO  (coreLoadExecutor-3806-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1663564540615327744
   [junit4]   2> 1068095 INFO  
(searcherExecutor-3807-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1068096 INFO  
(searcherExecutor-3807-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1068096 INFO  
(searcherExecutor-3807-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1068096 INFO  
(searcherExecutor-3807-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 1068096 INFO  
(searcherExecutor-3807-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1068097 INFO  
(searcherExecutor-3807-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1068097 ERROR (coreZkRegister-3798-thread-1) [    
x:collection1 ] o.a.s.c.ZkContainer 
   [junit4]   2>           => java.lang.NullPointerException
   [junit4]   2>        at 
org.apache.solr.core.ZkContainer.lambda$registerInZk$1(ZkContainer.java:196)
   [junit4]   2> java.lang.NullPointerException: null
   [junit4]   2>        at 
org.apache.solr.core.ZkContainer.lambda$registerInZk$1(ZkContainer.java:196) 
~[java/:?]
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
 ~[java/:?]
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) 
~[?:?]
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) 
~[?:?]
   [junit4]   2>        at java.lang.Thread.run(Thread.java:830) [?:?]
   [junit4]   2> 1068098 ERROR (coreZkRegister-3798-thread-1) [    
x:collection1 ] o.a.s.c.ZkContainer :java.lang.NullPointerException
   [junit4]   2>        at 
org.apache.solr.core.ZkContainer.lambda$registerInZk$1(ZkContainer.java:184)
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
   [junit4]   2>        at 
java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
   [junit4]   2>        at 
java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
   [junit4]   2>        at java.base/java.lang.Thread.run(Thread.java:830)
   [junit4]   2> 
   [junit4]   2> 1068099 INFO  
(searcherExecutor-3807-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1068099 INFO  
(searcherExecutor-3807-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1068100 INFO  
(searcherExecutor-3807-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1068101 INFO  
(searcherExecutor-3807-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@5b4de690[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1068674 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestHighlightDedupGrouping_BB9B3BC38E7156BE-001/tempDir-001/shard1/cores/collection1
   [junit4]   2> 1068676 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 1068676 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 1068676 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: 
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 13.0.2+8
   [junit4]   2> 1068685 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1068685 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1068685 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 1068687 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@45e14444{/yo/gu,null,AVAILABLE}
   [junit4]   2> 1068689 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@18d5d7fd{HTTP/1.1, (http/1.1, 
h2c)}{127.0.0.1:53928}
   [junit4]   2> 1068689 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.s.Server Started @1068758ms
   [junit4]   2> 1068689 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/yo/gu, 
hostPort=53928, 
coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestHighlightDedupGrouping_BB9B3BC38E7156BE-001/tempDir-001/shard1/cores}
   [junit4]   2> 1068690 ERROR 
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1068690 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1068690 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
9.0.0
   [junit4]   2> 1068690 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 1068690 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr
   [junit4]   2> 1068690 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2020-04-10T06:06:16.665814Z
   [junit4]   2> 1068690 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestHighlightDedupGrouping_BB9B3BC38E7156BE-001/tempDir-001/shard1/solr.xml
   [junit4]   2> 1068695 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6c15675, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1068893 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 1068896 WARN  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@32b38783[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1068896 WARN  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@32b38783[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1068900 WARN  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@4ae68a70[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1068900 WARN  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@4ae68a70[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1068902 WARN  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
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> 1068930 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1068930 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history 
in memory.
   [junit4]   2> 1068952 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6c15675
   [junit4]   2> 1068963 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6c15675
   [junit4]   2> 1068963 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6c15675
   [junit4]   2> 1068966 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestHighlightDedupGrouping_BB9B3BC38E7156BE-001/tempDir-001/shard1/cores
   [junit4]   2> 1068966 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1068973 INFO  (coreLoadExecutor-3820-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
   [junit4]   2> 1069000 INFO  (coreLoadExecutor-3820-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 1069116 INFO  (coreLoadExecutor-3820-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field 
id
   [junit4]   2> 1069150 INFO  (coreLoadExecutor-3820-thread-1) [    
x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 1069150 INFO  (coreLoadExecutor-3820-thread-1) [    
x:collection1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6c15675
   [junit4]   2> 1069151 INFO  (coreLoadExecutor-3820-thread-1) [    
x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestHighlightDedupGrouping_BB9B3BC38E7156BE-001/tempDir-001/shard1/cores/collection1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestHighlightDedupGrouping_BB9B3BC38E7156BE-001/tempDir-001/shard1/cores/collection1/data/]
   [junit4]   2> 1069153 INFO  (coreLoadExecutor-3820-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=15, maxMergeAtOnceExplicit=18, maxMergedSegmentMB=22.765625, 
floorSegmentMB=1.15625, forceMergeDeletesPctAllowed=7.971810532833699, 
segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.5917722645522187, deletesPctAllowed=47.34581742595319
   [junit4]   2> 1069251 INFO  (coreLoadExecutor-3820-thread-1) [    
x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1069251 INFO  (coreLoadExecutor-3820-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 1069255 INFO  (coreLoadExecutor-3820-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1069255 INFO  (coreLoadExecutor-3820-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1069256 INFO  (coreLoadExecutor-3820-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=17, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.4657402078219245]
   [junit4]   2> 1069256 INFO  (coreLoadExecutor-3820-thread-1) [    
x:collection1 ] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@2d917acc[collection1] main]
   [junit4]   2> 1069257 INFO  (coreLoadExecutor-3820-thread-1) [    
x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1069287 INFO  (coreLoadExecutor-3820-thread-1) [    
x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct, 
classname=DirectSolrSpellChecker, field=lowerfilt, minQueryLength=3}
   [junit4]   2> 1069400 INFO  (coreLoadExecutor-3820-thread-1) [    
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1069400 INFO  (coreLoadExecutor-3820-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1663564541984768000
   [junit4]   2> 1069400 INFO  
(searcherExecutor-3821-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1069400 INFO  
(searcherExecutor-3821-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1069400 INFO  
(searcherExecutor-3821-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1069400 INFO  
(searcherExecutor-3821-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 1069404 ERROR (coreZkRegister-3812-thread-1) [    
x:collection1 ] o.a.s.c.ZkContainer 
   [junit4]   2>           => java.lang.NullPointerException
   [junit4]   2>        at 
org.apache.solr.core.ZkContainer.lambda$registerInZk$1(ZkContainer.java:196)
   [junit4]   2> java.lang.NullPointerException: null
   [junit4]   2>        at 
org.apache.solr.core.ZkContainer.lambda$registerInZk$1(ZkContainer.java:196) 
~[java/:?]
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
 ~[java/:?]
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) 
~[?:?]
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) 
~[?:?]
   [junit4]   2>        at java.lang.Thread.run(Thread.java:830) [?:?]
   [junit4]   2> 1069404 ERROR (coreZkRegister-3812-thread-1) [    
x:collection1 ] o.a.s.c.ZkContainer :java.lang.NullPointerException
   [junit4]   2>        at 
org.apache.solr.core.ZkContainer.lambda$registerInZk$1(ZkContainer.java:184)
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
   [junit4]   2>        at 
java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
   [junit4]   2>        at 
java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
   [junit4]   2>        at java.base/java.lang.Thread.run(Thread.java:830)
   [junit4]   2> 
   [junit4]   2> 1069404 INFO  
(searcherExecutor-3821-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1069405 INFO  
(searcherExecutor-3821-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1069405 INFO  
(searcherExecutor-3821-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1069406 INFO  
(searcherExecutor-3821-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1069406 INFO  
(searcherExecutor-3821-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1069408 INFO  
(searcherExecutor-3821-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@2d917acc[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1069902 INFO  
(TEST-TestHighlightDedupGrouping.test-seed#[BB9B3BC38E7156BE]) [     ] 
o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 1069908 INFO  (qtp1134758117-12387) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1663564542515347456)} 0 2
   [junit4]   2> 1069914 INFO  (qtp853811132-12409) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1663564542520590336)} 0 3
   [junit4]   2> 1069921 INFO  (qtp1149526298-12431) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1663564542527930368)} 0 2
   [junit4]   2> 1069922 INFO  (qtp1134758117-12388) [    x:collection1 ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1663564542532124672,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1069922 INFO  (qtp1134758117-12388) [    x:collection1 ] 
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 1069923 INFO  (qtp1134758117-12388) [    x:collection1 ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1069923 INFO  (qtp1134758117-12388) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 1
   [junit4]   2> 1069924 INFO  (qtp853811132-12410) [    x:collection1 ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1663564542534221824,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1069924 INFO  (qtp853811132-12410) [    x:collection1 ] 
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 1069925 INFO  (qtp853811132-12410) [    x:collection1 ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1069925 INFO  (qtp853811132-12410) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 1
   [junit4]   2> 1069926 INFO  (qtp1149526298-12432) [    x:collection1 ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1663564542536318976,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1069926 INFO  (qtp1149526298-12432) [    x:collection1 ] 
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 1069927 INFO  (qtp1149526298-12432) [    x:collection1 ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1069927 INFO  (qtp1149526298-12432) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 1
   [junit4]   2> 1069930 INFO  (qtp853811132-12411) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[1 (1663564542538416128)]} 0 2
   [junit4]   2> 1069931 INFO  (qtp853811132-12408) [    x:collection1 ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1663564542541561856,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1069932 INFO  (qtp853811132-12408) [    x:collection1 ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@3df67ac1 
commitCommandVersion:1663564542541561856
   [junit4]   2> 1069939 INFO  (qtp853811132-12408) [    x:collection1 ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@73b0a908[collection1] main]
   [junit4]   2> 1069939 INFO  (qtp853811132-12408) [    x:collection1 ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1069951 INFO  
(searcherExecutor-3807-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@73b0a908[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):c1:[diagnostics={source=flush,
 os.arch=x86_64, java.runtime.version=13.0.2+8, os.version=10.14.6, os=Mac OS 
X, java.vendor=AdoptOpenJDK, timestamp=1586498777910, java.version=13.0.2, 
java.vm.version=13.0.2+8, 
lucene.version=9.0.0}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
   [junit4]   2> 1069951 INFO  (qtp853811132-12408) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 19
   [junit4]   2> 1069954 INFO  (qtp1149526298-12433) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[1 (1663564542563581952)]} 0 1
   [junit4]   2> 1069955 INFO  (qtp1149526298-12430) [    x:collection1 ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1663564542566727680,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1069955 INFO  (qtp1149526298-12430) [    x:collection1 ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@3dc4ba30 
commitCommandVersion:1663564542566727680
   [junit4]   2> 1069964 INFO  (qtp1149526298-12430) [    x:collection1 ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@631b461c[collection1] main]
   [junit4]   2> 1069964 INFO  (qtp1149526298-12430) [    x:collection1 ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1069966 INFO  
(searcherExecutor-3821-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@631b461c[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):c1:[diagnostics={source=flush,
 os.arch=x86_64, java.runtime.version=13.0.2+8, os.version=10.14.6, os=Mac OS 
X, java.vendor=AdoptOpenJDK, timestamp=1586498777933, java.version=13.0.2, 
java.vm.version=13.0.2+8, 
lucene.version=9.0.0}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
   [junit4]   2> 1069967 INFO  (qtp1149526298-12430) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 12
   [junit4]   2> 1069974 INFO  (qtp853811132-12408) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/yo/gu path=/select 
params={df=text&group.distributed.first=true&distrib=false&hl=false&group.limit=2&fl=id,score&shards.purpose=2048&start=0&shard.url=http://127.0.0.1:53916/yo/gu/collection1&rows=10&version=2&q=id_s1:1&omitHeader=false&NOW=1586498777943&isShard=true&hl.fl=id_s1&wt=javabin&group.field=id_s1&group=true}
 status=0 QTime=0
   [junit4]   2> 1069974 INFO  (qtp1149526298-12433) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/yo/gu path=/select 
params={df=text&group.distributed.first=true&distrib=false&hl=false&group.limit=2&fl=id,score&shards.purpose=2048&start=0&shard.url=http://127.0.0.1:53928/yo/gu/collection1&rows=10&version=2&q=id_s1:1&omitHeader=false&NOW=1586498777943&isShard=true&hl.fl=id_s1&wt=javabin&group.field=id_s1&group=true}
 status=0 QTime=0
   [junit4]   2> 1069977 INFO  (qtp853811132-12410) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/yo/gu path=/select 
params={group.topgroups.id_s1=1&df=text&distrib=false&hl=false&group.limit=2&fl=id,score&shards.purpose=4&start=0&shard.url=http://127.0.0.1:53916/yo/gu/collection1&rows=10&version=2&group.distributed.second=true&q=id_s1:1&omitHeader=false&NOW=1586498777943&isShard=true&hl.fl=id_s1&wt=javabin&group.field=id_s1&group=true}
 status=0 QTime=0
   [junit4]   2> 1069977 INFO  (qtp1149526298-12430) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/yo/gu path=/select 
params={group.topgroups.id_s1=1&df=text&distrib=false&hl=false&group.limit=2&fl=id,score&shards.purpose=4&start=0&shard.url=http://127.0.0.1:53928/yo/gu/collection1&rows=10&version=2&group.distributed.second=true&q=id_s1:1&omitHeader=false&NOW=1586498777943&isShard=true&hl.fl=id_s1&wt=javabin&group.field=id_s1&group=true}
 status=0 QTime=0
   [junit4]   2> 1069981 INFO  (qtp1149526298-12431) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/yo/gu path=/select 
params={df=text&distrib=false&hl=true&group.limit=2&shards.purpose=192&shard.url=http://127.0.0.1:53928/yo/gu/collection1&version=2&q=id_s1:1&omitHeader=false&NOW=1586498777943&ids=1&isShard=true&hl.fl=id_s1&wt=javabin&group.field=id_s1}
 status=0 QTime=1
   [junit4]   2> 1069981 INFO  (qtp853811132-12411) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/yo/gu path=/select 
params={df=text&distrib=false&hl=true&group.limit=2&shards.purpose=192&shard.url=http://127.0.0.1:53916/yo/gu/collection1&version=2&q=id_s1:1&omitHeader=false&NOW=1586498777943&ids=1&isShard=true&hl.fl=id_s1&wt=javabin&group.field=id_s1}
 status=0 QTime=1
   [junit4]   2> 1069982 INFO  (qtp853811132-12409) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/yo/gu path=/select 
params={q=id_s1:1&shards=http://127.0.0.1:53916/yo/gu/collection1,http://127.0.0.1:53928/yo/gu/collection1&hl=true&group.limit=2&hl.fl=id_s1&wt=javabin&version=2&group.field=id_s1&group=true}
 status=0 QTime=13
   [junit4]   2> 1069984 INFO  (qtp1134758117-12389) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1663564542596087808)} 0 1
   [junit4]   2> 1069986 INFO  (qtp853811132-12408) [    x:collection1 ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@56fa75ac[collection1] realtime]
   [junit4]   2> 1069986 INFO  (qtp853811132-12408) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1663564542598184960)} 0 1
   [junit4]   2> 1069989 INFO  (qtp1149526298-12432) [    x:collection1 ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@278f3f8d[collection1] realtime]
   [junit4]   2> 1069989 INFO  (qtp1149526298-12432) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1663564542600282112)} 0 2
   [junit4]   2> 1069992 INFO  (qtp1134758117-12386) [    x:collection1 ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1663564542605524992,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1069993 INFO  (qtp1134758117-12386) [    x:collection1 ] 
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 1069993 INFO  (qtp1134758117-12386) [    x:collection1 ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1069993 INFO  (qtp1134758117-12386) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 1
   [junit4]   2> 1069995 INFO  (qtp853811132-12410) [    x:collection1 ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1663564542608670720,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1069996 INFO  (qtp853811132-12410) [    x:collection1 ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@3df67ac1 
commitCommandVersion:1663564542608670720
   [junit4]   2> 1069996 INFO  (qtp853811132-12410) [    x:collection1 ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@53249c69[collection1] main]
   [junit4]   2> 1069997 INFO  (qtp853811132-12410) [    x:collection1 ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1070000 INFO  
(searcherExecutor-3807-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@53249c69[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1070001 INFO  (qtp853811132-12410) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 5
   [junit4]   2> 1070002 INFO  (qtp1149526298-12433) [    x:collection1 ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1663564542614962176,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1070002 INFO  (qtp1149526298-12433) [    x:collection1 ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@3dc4ba30 
commitCommandVersion:1663564542614962176
   [junit4]   2> 1070002 INFO  (qtp1149526298-12433) [    x:collection1 ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@74fd8f18[collection1] main]
   [junit4]   2> 1070002 INFO  (qtp1149526298-12433) [    x:collection1 ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1070004 INFO  
(searcherExecutor-3821-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@74fd8f18[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1070005 INFO  (qtp1149526298-12433) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 3
   [junit4]   2> 1070008 INFO  (qtp1149526298-12430) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[0 (1663564542620205056)]} 0 1
   [junit4]   2> 1070008 INFO  (qtp853811132-12411) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[1 (1663564542622302208)]} 0 0
   [junit4]   2> 1070008 INFO  (qtp1149526298-12431) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[1 (1663564542622302208)]} 0 0
   [junit4]   2> 1070008 INFO  (qtp853811132-12409) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[2 (1663564542622302209)]} 0 0
   [junit4]   2> 1070013 INFO  (qtp1149526298-12432) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[3 (1663564542627545088)]} 0 0
   [junit4]   2> 1070013 INFO  (qtp1149526298-12433) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[4 (1663564542627545089)]} 0 0
   [junit4]   2> 1070015 INFO  (qtp853811132-12408) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[5 (1663564542629642240)]} 0 0
   [junit4]   2> 1070016 INFO  (qtp1149526298-12430) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[5 (1663564542630690816)]} 0 0
   [junit4]   2> 1070016 INFO  (qtp853811132-12410) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[6 (1663564542630690816)]} 0 0
   [junit4]   2> 1070017 INFO  (qtp1149526298-12431) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[6 (1663564542631739392)]} 0 0
   [junit4]   2> 1070018 INFO  (qtp853811132-12411) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[7 (1663564542632787968)]} 0 0
   [junit4]   2> 1070019 INFO  (qtp1149526298-12432) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[8 (1663564542633836544)]} 0 0
   [junit4]   2> 1070020 INFO  (qtp853811132-12409) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[9 (1663564542634885120)]} 0 0
   [junit4]   2> 1070020 INFO  (qtp853811132-12408) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[10 (1663564542634885121)]} 0 0
   [junit4]   2> 1070022 INFO  (qtp853811132-12410) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[11 (1663564542636982272)]} 0 0
   [junit4]   2> 1070022 INFO  (qtp1149526298-12433) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[11 (1663564542636982272)]} 0 0
   [junit4]   2> 1070023 INFO  (qtp853811132-12411) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[12 (1663564542638030848)]} 0 0
   [junit4]   2> 1070024 INFO  (qtp853811132-12409) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[13 (1663564542638030849)]} 0 0
   [junit4]   2> 1070024 INFO  (qtp1149526298-12430) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[14 (1663564542639079424)]} 0 0
   [junit4]   2> 1070025 INFO  (qtp1149526298-12431) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[15 (1663564542640128000)]} 0 0
   [junit4]   2> 1070026 INFO  (qtp1149526298-12432) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[16 (1663564542641176576)]} 0 0
   [junit4]   2> 1070026 INFO  (qtp1149526298-12433) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[17 (1663564542641176577)]} 0 0
   [junit4]   2> 1070027 INFO  (qtp1149526298-12430) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[18 (1663564542642225152)]} 0 0
   [junit4]   2> 1070028 INFO  (qtp853811132-12408) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[19 (1663564542643273728)]} 0 0
   [junit4]   2> 1070029 INFO  (qtp1149526298-12431) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[19 (1663564542644322304)]} 0 0
   [junit4]   2> 1070029 INFO  (qtp1149526298-12432) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[20 (1663564542644322305)]} 0 0
   [junit4]   2> 1070030 INFO  (qtp1149526298-12433) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[21 (1663564542645370880)]} 0 0
   [junit4]   2> 1070031 INFO  (qtp1149526298-12430) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[22 (1663564542646419456)]} 0 0
   [junit4]   2> 1070031 INFO  (qtp1149526298-12431) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[23 (1663564542646419457)]} 0 0
   [junit4]   2> 1070032 INFO  (qtp1149526298-12432) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[24 (1663564542647468032)]} 0 0
   [junit4]   2> 1070033 INFO  (qtp1149526298-12433) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[25 (1663564542647468033)]} 0 0
   [junit4]   2> 1070033 INFO  (qtp1149526298-12430) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[26 (1663564542648516608)]} 0 0
   [junit4]   2> 1070034 INFO  (qtp853811132-12410) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[27 (1663564542649565184)]} 0 0
   [junit4]   2> 1070034 INFO  (qtp1149526298-12431) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[28 (1663564542649565184)]} 0 0
   [junit4]   2> 1070035 INFO  (qtp1149526298-12432) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[29 (1663564542650613760)]} 0 0
   [junit4]   2> 1070036 INFO  (qtp853811132-12411) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[30 (1663564542651662336)]} 0 0
   [junit4]   2> 1070037 INFO  (qtp853811132-12409) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[31 (1663564542652710912)]} 0 0
   [junit4]   2> 1070037 INFO  (qtp853811132-12408) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[32 (1663564542652710913)]} 0 0
   [junit4]   2> 1070038 INFO  (qtp853811132-12410) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[33 (1663564542653759488)]} 0 0
   [junit4]   2> 1070039 INFO  (qtp853811132-12411) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[34 (1663564542654808064)]} 0 0
   [junit4]   2> 1070039 INFO  (qtp853811132-12409) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[35 (1663564542654808065)]} 0 0
   [junit4]   2> 1070040 INFO  (qtp1149526298-12433) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[35 (1663564542655856640)]} 0 0
   [junit4]   2> 1070041 INFO  (qtp1149526298-12430) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[36 (1663564542656905216)]} 0 0
   [junit4]   2> 1070041 INFO  (qtp1149526298-12431) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[37 (1663564542656905217)]} 0 0
   [junit4]   2> 1070042 INFO  (qtp1149526298-12432) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[38 (1663564542657953792)]} 0 0
   [junit4]   2> 1070043 INFO  (qtp1149526298-12433) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[39 (1663564542657953793)]} 0 0
   [junit4]   2> 1070043 INFO  (qtp1149526298-12430) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[40 (1663564542659002368)]} 0 0
   [junit4]   2> 1070044 INFO  (qtp1149526298-12431) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[41 (1663564542660050944)]} 0 0
   [junit4]   2> 1070044 INFO  (qtp853811132-12408) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[42 (1663564542660050944)]} 0 0
   [junit4]   2> 1070045 INFO  (qtp1149526298-12432) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[42 (1663564542661099520)]} 0 0
   [junit4]   2> 1070045 INFO  (qtp1149526298-12433) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[43 (1663564542661099521)]} 0 0
   [junit4]   2> 1070047 INFO  (qtp853811132-12410) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[44 (1663564542663196672)]} 0 0
   [junit4]   2> 1070047 INFO  (qtp1149526298-12430) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[44 (1663564542663196672)]} 0 0
   [junit4]   2> 1070048 INFO  (qtp1149526298-12431) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[45 (1663564542664245248)]} 0 0
   [junit4]   2> 1070049 INFO  (qtp853811132-12411) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[46 (1663564542665293824)]} 0 0
   [junit4]   2> 1070049 INFO  (qtp853811132-12409) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[47 (1663564542665293825)]} 0 0
   [junit4]   2> 1070050 INFO  (qtp853811132-12408) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[48 (1663564542666342400)]} 0 0
   [junit4]   2> 1070051 INFO  (qtp1149526298-12432) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[48 (1663564542667390976)]} 0 0
   [junit4]   2> 1070051 INFO  (qtp1149526298-12433) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[49 (1663564542667390977)]} 0 0
   [junit4]   2> 1070052 INFO  (qtp1149526298-12430) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[50 (1663564542668439552)]} 0 0
   [junit4]   2> 1070052 INFO  (qtp1149526298-12431) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[51 (1663564542668439553)]} 0 0
   [junit4]   2> 1070053 INFO  (qtp1149526298-12432) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[52 (1663564542669488128)]} 0 0
   [junit4]   2> 1070054 INFO  (qtp1149526298-12433) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[53 (1663564542670536704)]} 0 0
   [junit4]   2> 1070054 INFO  (qtp1149526298-12430) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[54 (1663564542670536705)]} 0 0
   [junit4]   2> 1070055 INFO  (qtp853811132-12410) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[55 (1663564542671585280)]} 0 0
   [junit4]   2> 1070056 INFO  (qtp853811132-12411) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[56 (1663564542672633856)]} 0 0
   [junit4]   2> 1070057 INFO  (qtp853811132-12409) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[57 (1663564542673682432)]} 0 0
   [junit4]   2> 1070057 INFO  (qtp853811132-12408) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[58 (1663564542673682433)]} 0 0
   [junit4]   2> 1070058 INFO  (qtp853811132-12410) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[59 (1663564542674731008)]} 0 0
   [junit4]   2> 1070059 INFO  (qtp1149526298-12431) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[60 (1663564542674731008)]} 0 0
   [junit4]   2> 1070059 INFO  (qtp1149526298-12432) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[61 (1663564542675779584)]} 0 0
   [junit4]   2> 1070060 INFO  (qtp853811132-12411) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[62 (1663564542675779584)]} 0 0
   [junit4]   2> 1070060 INFO  (qtp1149526298-12433) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[63 (1663564542676828160)]} 0 0
   [junit4]   2> 1070061 INFO  (qtp853811132-12409) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[64 (1663564542677876736)]} 0 0
   [junit4]   2> 1070061 INFO  (qtp853811132-12408) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[65 (1663564542677876737)]} 0 0
   [junit4]   2> 1070062 INFO  (qtp1149526298-12430) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[66 (1663564542678925312)]} 0 0
   [junit4]   2> 1070062 INFO  (qtp1149526298-12431) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[67 (1663564542678925313)]} 0 0
   [junit4]   2> 1070063 INFO  (qtp853811132-12410) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[68 (1663564542679973888)]} 0 0
   [junit4]   2> 1070064 INFO  (qtp1149526298-12432) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[69 (1663564542679973888)]} 0 0
   [junit4]   2> 1070064 INFO  (qtp1149526298-12433) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[70 (1663564542681022464)]} 0 0
   [junit4]   2> 1070065 INFO  (qtp853811132-12411) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[71 (1663564542681022464)]} 0 0
   [junit4]   2> 1070065 INFO  (qtp853811132-12409) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[72 (1663564542682071040)]} 0 0
   [junit4]   2> 1070066 INFO  (qtp853811132-12408) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[73 (1663564542683119616)]} 0 0
   [junit4]   2> 1070067 INFO  (qtp853811132-12410) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[74 (1663564542683119617)]} 0 0
   [junit4]   2> 1070067 INFO  (qtp1149526298-12430) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[75 (1663564542684168192)]} 0 0
   [junit4]   2> 1070068 INFO  (qtp853811132-12411) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[76 (1663564542685216768)]} 0 0
   [junit4]   2> 1070068 INFO  (qtp1149526298-12431) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[76 (1663564542685216768)]} 0 0
   [junit4]   2> 1070069 INFO  (qtp853811132-12409) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[77 (1663564542686265344)]} 0 0
   [junit4]   2> 1070070 INFO  (qtp853811132-12408) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[78 (1663564542687313920)]} 0 0
   [junit4]   2> 1070071 INFO  (qtp1149526298-12432) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[79 (1663564542688362496)]} 0 0
   [junit4]   2> 1070072 INFO  (qtp853811132-12410) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[80 (1663564542689411072)]} 0 0
   [junit4]   2> 1070073 INFO  (qtp1149526298-12433) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[81 (1663564542690459648)]} 0 0
   [junit4]   2> 1070074 INFO  (qtp1149526298-12430) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[82 (1663564542690459649)]} 0 0
   [junit4]   2> 1070075 INFO  (qtp853811132-12411) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[83 (1663564542692556800)]} 0 0
   [junit4]   2> 1070076 INFO  (qtp853811132-12409) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[84 (1663564542692556801)]} 0 0
   [junit4]   2> 1070076 INFO  (qtp1149526298-12431) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[85 (1663564542693605376)]} 0 0
   [junit4]   2> 1070077 INFO  (qtp853811132-12408) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[86 (1663564542694653952)]} 0 0
   [junit4]   2> 1070078 INFO  (qtp1149526298-12432) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[86 (1663564542695702528)]} 0 0
   [junit4]   2> 1070081 INFO  (qtp1149526298-12433) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[87 (1663564542698848256)]} 0 0
   [junit4]   2> 1070082 INFO  (qtp1149526298-12430) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[88 (1663564542699896832)]} 0 0
   [junit4]   2> 1070083 INFO  (qtp853811132-12410) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[89 (1663564542699896832)]} 0 0
   [junit4]   2> 1070084 INFO  (qtp853811132-12411) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[90 (1663564542701993984)]} 0 0
   [junit4]   2> 1070085 INFO  (qtp853811132-12409) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[91 (1663564542703042560)]} 0 0
   [junit4]   2> 1070086 INFO  (qtp853811132-12408) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[92 (1663564542704091136)]} 0 0
   [junit4]   2> 1070087 INFO  (qtp1149526298-12431) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[93 (1663564542705139712)]} 0 0
   [junit4]   2> 1070088 INFO  (qtp1149526298-12432) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[94 (1663564542706188288)]} 0 0
   [junit4]   2> 1070088 INFO  (qtp853811132-12410) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[95 (1663564542706188288)]} 0 0
   [junit4]   2> 1070088 INFO  (qtp1149526298-12433) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[96 (1663564542706188289)]} 0 0
   [junit4]   2> 1070088 INFO  (qtp1149526298-12430) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[97 (1663564542706188290)]} 0 0
   [junit4]   2> 1070093 INFO  (qtp853811132-12411) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[98 (1663564542710382592)]} 0 4
   [junit4]   2> 1070093 INFO  (qtp1149526298-12430) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[99 (1663564542711431168)]} 0 0
   [junit4]   2> 1070095 INFO  (qtp853811132-12409) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[100 (1663564542713528320)]} 0 0
   [junit4]   2> 1070096 INFO  (qtp1149526298-12431) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[100 (1663564542714576896)]} 0 0
   [junit4]   2> 1070097 INFO  (qtp1149526298-12432) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[101 (1663564542715625472)]} 0 0
   [junit4]   2> 1070098 INFO  (qtp853811132-12408) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[102 (1663564542716674048)]} 0 0
   [junit4]   2> 1070099 INFO  (qtp1149526298-12433) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[103 (1663564542717722624)]} 0 0
   [junit4]   2> 1070100 INFO  (qtp1149526298-12430) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[104 (1663564542718771200)]} 0 0
   [junit4]   2> 1070100 INFO  (qtp1149526298-12431) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[105 (1663564542718771201)]} 0 0
   [junit4]   2> 1070101 INFO  (qtp853811132-12410) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[106 (1663564542719819776)]} 0 0
   [junit4]   2> 1070102 INFO  (qtp1149526298-12432) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[107 (1663564542720868352)]} 0 0
   [junit4]   2> 1070103 INFO  (qtp1149526298-12433) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[108 (1663564542721916928)]} 0 0
   [junit4]   2> 1070104 INFO  (qtp1149526298-12430) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[109 (1663564542722965504)]} 0 0
   [junit4]   2> 1070105 INFO  (qtp1149526298-12431) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[110 (1663564542722965505)]} 0 0
   [junit4]   2> 1070105 INFO  (qtp853811132-12411) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[111 (1663564542724014080)]} 0 0
   [junit4]   2> 1070106 INFO  (qtp853811132-12409) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[112 (1663564542725062656)]} 0 0
   [junit4]   2> 1070107 INFO  (qtp1149526298-12432) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[113 (1663564542726111232)]} 0 0
   [junit4]   2> 1070107 INFO  (qtp853811132-12408) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[114 (1663564542726111232)]} 0 0
   [junit4]   2> 1070108 INFO  (qtp1149526298-12433) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[114 (1663564542727159808)]} 0 0
   [junit4]   2> 1070109 INFO  (qtp853811132-12410) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[115 (1663564542728208384)]} 0 0
   [junit4]   2> 1070110 INFO  (qtp1149526298-12430) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[116 (1663564542728208384)]} 0 0
   [junit4]   2> 1070110 INFO  (qtp853811132-12411) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[117 (1663564542729256960)]} 0 0
   [junit4]   2> 1070111 INFO  (qtp1149526298-12431) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[118 (1663564542730305536)]} 0 0
   [junit4]   2> 1070112 INFO  (qtp1149526298-12432) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[119 (1663564542731354112)]} 0 0
   [junit4]   2> 1070114 INFO  (qtp1149526298-12433) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[120 (1663564542733451264)]} 0 0
   [junit4]   2> 1070116 INFO  (qtp1149526298-12430) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[121 (1663564542734499840)]} 0 0
   [junit4]   2> 1070117 INFO  (qtp853811132-12409) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[122 (1663564542736596992)]} 0 0
   [junit4]   2> 1070119 INFO  (qtp1149526298-12431) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[122 (1663564542737645568)]} 0 0
   [junit4]   2> 1070120 INFO  (qtp1149526298-12432) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/yo/gu path=/update 
params={wt=javabin&version=2}{add=[123 (1663564542739742720)]} 0 0
   [junit4]   2> 1070125 INFO  (qtp853811132-12408) [    x:collection1 ] 
o.a.s.u.p.LogUpdatePr

[...truncated too long message...]

urce)
   [junit4]   2>        at 
[email protected]/java.lang.Thread.run(Thread.java:830)
   [junit4]   2> 
   [junit4]   2> ^^==============================================
   [junit4]   2> 
   [junit4]   2> ???????? 10, 2020 7:06:14 ?.?. 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> ???????? 10, 2020 7:06:24 ?.?. 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> SEVERE: 1 thread leaked from SUITE scope at 
org.apache.solr.TestHighlightDedupGrouping: 
   [junit4]   2>    1) Thread[id=12381, 
name=SUITE-TestHighlightDedupGrouping-seed#[BB9B3BC38E7156BE]-worker, 
state=WAITING, group=TGRP-TestHighlightDedupGrouping]
   [junit4]   2>         at [email protected]/java.lang.Object.wait(Native 
Method)
   [junit4]   2>         at 
[email protected]/java.lang.Thread.join(Thread.java:1303)
   [junit4]   2>         at 
[email protected]/java.lang.Thread.join(Thread.java:1371)
   [junit4]   2>         at 
app//org.apache.solr.TestHighlightDedupGrouping.afterClass(TestHighlightDedupGrouping.java:42)
   [junit4]   2>         at 
[email protected]/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native 
Method)
   [junit4]   2>         at 
[email protected]/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]   2>         at 
[email protected]/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2>         at 
[email protected]/java.lang.reflect.Method.invoke(Method.java:567)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:905)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2>         at 
app//org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>         at 
app//org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>         at 
app//org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
   [junit4]   2>         at 
app//org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2>         at 
app//org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2>         at 
app//org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.ThreadLeakControl$$Lambda$142/0x0000000119cbd4b0.run(Unknown
 Source)
   [junit4]   2>         at 
[email protected]/java.lang.Thread.run(Thread.java:830)
   [junit4]   2> ???????? 10, 2020 7:06:24 ?.?. 
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
   [junit4]   2> INFO: Starting to interrupt leaked threads:
   [junit4]   2>    1) Thread[id=12381, 
name=SUITE-TestHighlightDedupGrouping-seed#[BB9B3BC38E7156BE]-worker, 
state=WAITING, group=TGRP-TestHighlightDedupGrouping]
   [junit4]   2> 8276179 INFO  
(SUITE-TestHighlightDedupGrouping-seed#[BB9B3BC38E7156BE]-worker) [     ] 
o.a.s.SolrTestCaseJ4 ------------------------------------------------------- 
Done waiting for tracked resources to be released
   [junit4]   2> Apr 10, 2020 8:06:24 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
   [junit4]   2> INFO: All leaked threads terminated.
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene84): 
{id_s1=BlockTreeOrds(blocksize=128), 
multiDefault=PostingsFormat(name=LuceneVarGapFixedInterval), 
_root_=BlockTreeOrds(blocksize=128), id=PostingsFormat(name=Asserting)}, 
docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene80), 
_version_=DocValuesFormat(name=Asserting), 
range_facet_i_dv=DocValuesFormat(name=Asserting), 
intDvoDefault=DocValuesFormat(name=Lucene80), 
timestamp=DocValuesFormat(name=Asserting)}, maxPointsInLeafNode=800, 
maxMBSortInHeap=5.36351006502757, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@295a4365),
 locale=si, timezone=Asia/Sakhalin
   [junit4]   2> NOTE: Mac OS X 10.14.6 x86_64/AdoptOpenJDK 13.0.2 
(64-bit)/cpus=6,threads=1,free=161619496,total=339742720
   [junit4]   2> NOTE: All tests run in this JVM: [TestCustomStream, 
UpdateParamsTest, TestWaitForStateWithJettyShutdowns, 
CloudExitableDirectoryReaderTest, TestNamedUpdateProcessors, 
IndexSizeEstimatorTest, TestSolrQueryParser, CloudMLTQParserTest, 
DistributedQueryComponentOptimizationTest, TestPrepRecovery, 
SharedFSAutoReplicaFailoverTest, SolrLogPostToolTest, SpellCheckCollatorTest, 
CircularListTest, ResponseBuilderTest, TestSnapshotCloudManager, 
TestSimNodeLostTrigger, MetricsHandlerTest, 
CloneFieldUpdateProcessorFactoryTest, TestImplicitCoreProperties, 
SolrMetricReporterTest, TestSolrIndexConfig, ZkNodePropsTest, 
MigrateRouteKeyTest, TestSegmentSorting, AnalysisAfterCoreReloadTest, 
SearchHandlerTest, FacetPivotSmallTest, Tagger2Test, TestTlogReplayVsRecovery, 
TestManagedSynonymFilterFactory, TestTrieFacet, SpatialFilterTest, 
SplitShardTest, ForceLeaderWithTlogReplicasTest, TestExtendedDismaxParser, 
TestCSVResponseWriter, ConcurrentDeleteAndCreateCollectionTest, TestQueryUtils, 
TestLogWatcher, SortByFunctionTest, TestLeaderElectionZkExpiry, 
TestBulkSchemaAPI, TestSystemIdResolver, CollectionReloadTest, 
TestJsonFacetRefinement, CollectionStateFormat2Test, TestRealTimeGet, 
TestComplexPhraseQParserPlugin, TestManagedSchemaAPI, 
CreateCollectionCleanupTest, CacheHeaderTest, SolrSlf4jReporterTest, 
TestShardHandlerFactory, SplitByPrefixTest, TestHdfsBackupRestoreCore, 
TestMergePolicyConfig, TokenizerChainTest, TestCharFilters, 
TestCloudConsistency, SolrInfoBeanTest, ShowFileRequestHandlerTest, 
TestSolrTestCaseJ4, TestMaxScoreQueryParser, TestStressThreadBackup, 
TestFieldCache, AtomicUpdatesTest, CoreAdminOperationTest, RangeFacetCloudTest, 
FieldMutatingUpdateProcessorTest, TestSolrQueryResponse, 
DistributedFacetPivotSmallAdvancedTest, TestRandomFlRTGCloud, 
OverseerSolrResponseUnsafeSerializationTest, TestTrackingShardHandlerFactory, 
PeerSyncReplicationTest, TestCloudPseudoReturnFields, TestSearchPerf, 
HdfsTlogReplayBufferedWhileIndexingTest, NumberUtilsTest, 
IndexSizeTriggerSizeEstimationTest, TestFieldCacheWithThreads, 
ChangedSchemaMergeTest, TestNonDefinedSimilarityFactory, 
WordBreakSolrSpellCheckerTest, MultiSolrCloudTestCaseTest, RulesTest, 
AssignBackwardCompatibilityTest, TestMacroExpander, TestIndexingPerformance, 
EchoParamsTest, MinimalSchemaTest, OutputWriterTest, SampleTest, 
TestDistributedMissingSort, TestDocumentBuilder, TestGroupingSearch, 
TestHighlightDedupGrouping]
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestHighlightDedupGrouping -Dtests.seed=BB9B3BC38E7156BE 
-Dtests.slow=true -Dtests.locale=si -Dtests.timezone=Asia/Sakhalin 
-Dtests.asserts=true -Dtests.file.encoding=US-ASCII
   [junit4] ERROR   0.00s J0 | TestHighlightDedupGrouping (suite) <<<
   [junit4]    > Throwable #1: java.lang.Exception: Suite timeout exceeded (>= 
7200000 msec).
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([BB9B3BC38E7156BE]:0)
   [junit4] Completed [907/907 (1!)] on J0 in 7211.10s, 1 test, 1 error <<< 
FAILURES!

[...truncated 52557 lines...]
[repro] Jenkins log URL: 
https://jenkins.thetaphi.de/job/Lucene-Solr-master-MacOSX/5872/consoleText

[repro] Revision: ffdd29e6fb924bbded6d768a9b2f2ecc5c392f18

[repro] Ant options: "-Dargs=-XX:-UseCompressedOops -XX:+UseSerialGC"
[repro] Repro line:  ant test  -Dtestcase=TestHighlightDedupGrouping 
-Dtests.seed=BB9B3BC38E7156BE -Dtests.slow=true -Dtests.locale=si 
-Dtests.timezone=Asia/Sakhalin -Dtests.asserts=true 
-Dtests.file.encoding=US-ASCII

[repro] JUnit rest result XML files will be moved to: ./repro-reports
[repro] ant clean

[...truncated 6 lines...]
[repro] Test suites by module:
[repro]    solr/core
[repro]       TestHighlightDedupGrouping
[repro] ant compile-test

[...truncated 3187 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 
-Dtests.class="*.TestHighlightDedupGrouping" -Dtests.showOutput=onerror 
"-Dargs=-XX:-UseCompressedOops -XX:+UseSerialGC" -Dtests.seed=BB9B3BC38E7156BE 
-Dtests.slow=true -Dtests.locale=si -Dtests.timezone=Asia/Sakhalin 
-Dtests.asserts=true -Dtests.file.encoding=US-ASCII

[...truncated 81 lines...]
[repro] Failures w/original seeds:
[repro]   0/5 failed: org.apache.solr.TestHighlightDedupGrouping
[repro] Exiting with code 0

[...truncated 73 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to