Build: https://builds.apache.org/job/Lucene-Solr-BadApples-Tests-8.x/199/

1 tests failed.
FAILED:  
org.apache.solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest.testCollectionParameters

Error Message:
Captured an uncaught exception in thread: Thread[id=5232, 
name=h2sc-2087-thread-6, state=RUNNABLE, 
group=TGRP-ConcurrentUpdateHttp2SolrClientTest]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=5232, name=h2sc-2087-thread-6, state=RUNNABLE, 
group=TGRP-ConcurrentUpdateHttp2SolrClientTest]
        at 
__randomizedtesting.SeedInfo.seed([68236FDA71F417A9:5D074ABF00134EAB]:0)
Caused by: java.lang.ClassCastException: 
org.eclipse.jetty.io.WriteFlusher$IdleState cannot be cast to 
org.eclipse.jetty.io.WriteFlusher$FailedState
        at __randomizedtesting.SeedInfo.seed([68236FDA71F417A9]:0)
        at org.eclipse.jetty.io.WriteFlusher.fail(WriteFlusher.java:310)
        at 
org.eclipse.jetty.io.WriteFlusher.completeWrite(WriteFlusher.java:376)
        at 
org.eclipse.jetty.io.ssl.SslConnection$DecryptedEndPoint.lambda$fill$1(SslConnection.java:670)
        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
        at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 16983 lines...]
   [junit4] Suite: 
org.apache.solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest
   [junit4]   2> 250012 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 250013 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.a.s.SolrTestCaseJ4 Created dataDir: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/data-dir-28-001
   [junit4]   2> 250013 WARN  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2
   [junit4]   2> 250013 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 250015 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 250058 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 250058 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 250058 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/tempDir-002/cores/core
   [junit4]   2> 250063 WARN  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 250063 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 250063 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 250063 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: 
afcf563148970e98786327af5e07c261fda175d3; jvm 1.8.0_191-b12
   [junit4]   2> 250067 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 250067 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 250067 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 250067 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1d53b5a6{/solr,null,AVAILABLE}
   [junit4]   2> 250068 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.e.j.s.AbstractConnector Started ServerConnector@5116641f{SSL,[ssl, 
http/1.1]}{127.0.0.1:38435}
   [junit4]   2> 250068 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.e.j.s.Server Started @250131ms
   [junit4]   2> 250068 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=38435, 
configSetBaseDir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/tempDir-001,
 
coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/tempDir-002/cores}
   [junit4]   2> 250069 ERROR 
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 250069 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 250069 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.3.0
   [junit4]   2> 250069 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 250069 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 250069 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-08-29T04:58:47.335Z
   [junit4]   2> 250070 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/tempDir-001/solr.xml
   [junit4]   2> 250076 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@676144a0, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 250240 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 250241 WARN  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport 
since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 250242 WARN  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@23763c54[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 250242 WARN  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@23763c54[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 250245 WARN  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport 
since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 250246 WARN  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@14d39e0f[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 250246 WARN  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@14d39e0f[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 250277 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 250277 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics 
history in memory.
   [junit4]   2> 250301 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@676144a0
   [junit4]   2> 250315 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@676144a0
   [junit4]   2> 250316 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@676144a0
   [junit4]   2> 250342 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/tempDir-001
   [junit4]   2> 250342 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 250366 WARN  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/tempDir-001/collection1/../../../../contrib/extraction/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/tempDir-001/collection1/../../../../contrib/extraction/lib
   [junit4]   2> 250366 WARN  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/tempDir-001/collection1/../../../../dist
 filtered by solr-cell-\d.*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/tempDir-001/collection1/../../../../dist
   [junit4]   2> 250366 WARN  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/tempDir-001/collection1/../../../../contrib/clustering/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/tempDir-001/collection1/../../../../contrib/clustering/lib
   [junit4]   2> 250366 WARN  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/tempDir-001/collection1/../../../../dist
 filtered by solr-clustering-\d.*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/tempDir-001/collection1/../../../../dist
   [junit4]   2> 250366 WARN  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/tempDir-001/collection1/../../../../contrib/langid/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/tempDir-001/collection1/../../../../contrib/langid/lib
   [junit4]   2> 250366 WARN  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/tempDir-001/collection1/../../../../dist
 filtered by solr-langid-\d.*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/tempDir-001/collection1/../../../../dist
   [junit4]   2> 250367 WARN  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/tempDir-001/collection1/../../../../dist
 filtered by solr-ltr-\d.*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/tempDir-001/collection1/../../../../dist
   [junit4]   2> 250367 WARN  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/tempDir-001/collection1/../../../../contrib/velocity/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/tempDir-001/collection1/../../../../contrib/velocity/lib
   [junit4]   2> 250367 WARN  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/tempDir-001/collection1/../../../../dist
 filtered by solr-velocity-\d.*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/tempDir-001/collection1/../../../../dist
   [junit4]   2> 250367 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.3.0
   [junit4]   2> 250377 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.SolrIndexConfig IndexWriter infoStream solr logging is 
enabled
   [junit4]   2> 250436 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema [collection1] Schema name=example
   [junit4]   2> 250621 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.r.RestManager Registered ManagedResource impl 
org.apache.solr.rest.schema.analysis.ManagedWordSetResource for path 
/schema/analysis/stopwords/english
   [junit4]   2> 250621 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.r.RestManager Registered ManagedResource impl 
org.apache.solr.rest.schema.analysis.ManagedSynonymGraphFilterFactory$SynonymManager
 for path /schema/analysis/synonyms/english
   [junit4]   2> 250621 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.r.RestManager Added observer of type 
org.apache.solr.rest.schema.analysis.ManagedStopFilterFactory to existing 
ManagedResource /schema/analysis/stopwords/english
   [junit4]   2> 250621 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.r.RestManager Added observer of type 
org.apache.solr.rest.schema.analysis.ManagedSynonymGraphFilterFactory to 
existing ManagedResource /schema/analysis/synonyms/english
   [junit4]   2> 250623 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid 
field id
   [junit4]   2> 250623 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.r.RestManager Added observer of type 
org.apache.solr.rest.schema.analysis.ManagedStopFilterFactory to existing 
ManagedResource /schema/analysis/stopwords/english
   [junit4]   2> 250623 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.r.RestManager Added observer of type 
org.apache.solr.rest.schema.analysis.ManagedSynonymGraphFilterFactory to 
existing ManagedResource /schema/analysis/synonyms/english
   [junit4]   2> 250623 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.r.RestManager Added observer of type 
org.apache.solr.rest.schema.analysis.ManagedStopFilterFactory to existing 
ManagedResource /schema/analysis/stopwords/english
   [junit4]   2> 250623 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.r.RestManager Added observer of type 
org.apache.solr.rest.schema.analysis.ManagedSynonymGraphFilterFactory to 
existing ManagedResource /schema/analysis/synonyms/english
   [junit4]   2> 250643 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/tempDir-001/collection1,
 trusted=true
   [junit4]   2> 250643 INFO  (coreLoadExecutor-1097-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@676144a0
   [junit4]   2> 250643 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/tempDir-001/collection1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/tempDir-001/collection1/data/]
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream 
[IFD][coreLoadExecutor-1097-thread-1]: init: current segments file is 
"segments"; 
deletionPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper@6115c8e1
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream 
[IFD][coreLoadExecutor-1097-thread-1]: now checkpoint "" [0 segments ; isCommit 
= false]
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream 
[IFD][coreLoadExecutor-1097-thread-1]: 0 msec to checkpoint
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
init: create=true reader=null
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
   [junit4]   2> dir=MockDirectoryWrapper(RAMDirectory@11fa2c1a 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@33788b9d)
   [junit4]   2> index=
   [junit4]   2> version=8.3.0
   [junit4]   2> 
analyzer=org.apache.solr.update.SolrIndexConfig$DelayedSchemaAnalyzer
   [junit4]   2> ramBufferSizeMB=100.0
   [junit4]   2> maxBufferedDocs=-1
   [junit4]   2> mergedSegmentWarmer=null
   [junit4]   2> delPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper
   [junit4]   2> commit=null
   [junit4]   2> openMode=CREATE
   [junit4]   2> 
similarity=org.apache.solr.search.similarities.SchemaSimilarityFactory$SchemaSimilarity
   [junit4]   2> mergeScheduler=ConcurrentMergeScheduler: maxThreadCount=-1, 
maxMergeCount=-1, ioThrottle=true
   [junit4]   2> codec=Lucene80
   [junit4]   2> infoStream=org.apache.solr.update.LoggingInfoStream
   [junit4]   2> mergePolicy=[TieredMergePolicy: maxMergeAtOnce=10, 
maxMergeAtOnceExplicit=30, maxMergedSegmentMB=5120.0, floorSegmentMB=2.0, 
forceMergeDeletesPctAllowed=10.0, segmentsPerTier=10.0, 
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1, deletesPctAllowed=33.0
   [junit4]   2> 
indexerThreadPool=org.apache.lucene.index.DocumentsWriterPerThreadPool@1bc12661
   [junit4]   2> readerPooling=true
   [junit4]   2> perThreadHardLimitMB=1945
   [junit4]   2> useCompoundFile=false
   [junit4]   2> commitOnClose=true
   [junit4]   2> indexSort=null
   [junit4]   2> checkPendingFlushOnUpdate=true
   [junit4]   2> softDeletesField=null
   [junit4]   2> readerAttributes={}
   [junit4]   2> writer=org.apache.solr.update.SolrIndexWriter@545cb738
   [junit4]   2> 
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
MMapDirectory.UNMAP_SUPPORTED=true
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
now flush at close
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
  start flush: applyAllDeletes=true
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
  index before flush 
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-1097-thread-1]: 
startFullFlush
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-1097-thread-1]: 
coreLoadExecutor-1097-thread-1 finishFullFlush success=true
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
now apply all deletes for all segments buffered updates bytesUsed=0 reader pool 
bytesUsed=0
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-1097-thread-1]: 
waitApply: no deletes to apply
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-1097-thread-1]: 
initDynamicDefaults spins=true maxThreadCount=1 maxMergeCount=6
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-1097-thread-1]: 
updateMergeThreads ioThrottle=true targetMBPerSec=10240.0 MB/sec
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-1097-thread-1]: 
now merge
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-1097-thread-1]: 
  index: 
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-1097-thread-1]: 
  no more merges pending; now return
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
waitForMerges
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
waitForMerges done
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
commit: start
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
commit: enter lock
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
commit: now prepare
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
prepareCommit: flush
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
  index before flush 
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-1097-thread-1]: 
startFullFlush
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
now apply all deletes for all segments buffered updates bytesUsed=0 reader pool 
bytesUsed=0
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-1097-thread-1]: 
waitApply: no deletes to apply
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-1097-thread-1]: 
coreLoadExecutor-1097-thread-1 finishFullFlush success=true
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
startCommit(): start
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
startCommit index= changeCount=2
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
startCommit: wrote pending segments file "pending_segments_1"
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
done all syncs: []
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
commit: pendingCommit != null
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
commit: done writing segments file "segments_1"
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream 
[IFD][coreLoadExecutor-1097-thread-1]: now checkpoint "" [0 segments ; isCommit 
= true]
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream 
[IFD][coreLoadExecutor-1097-thread-1]: 0 msec to checkpoint
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
commit: took 0.3 msec
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
commit: done
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
rollback
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
all running merges have aborted
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
rollback: done finish merges
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-1097-thread-1]: 
abort
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-1097-thread-1]: 
done abort success=true
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
rollback: infos=
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream 
[IFD][coreLoadExecutor-1097-thread-1]: now checkpoint "" [0 segments ; isCommit 
= false]
   [junit4]   2> 250646 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream 
[IFD][coreLoadExecutor-1097-thread-1]: 0 msec to checkpoint
   [junit4]   2> 250647 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5
   [junit4]   2> 250709 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 250709 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 250710 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: if uncommitted for 
15000ms; 
   [junit4]   2> 250710 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 250712 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream 
[IFD][coreLoadExecutor-1097-thread-1]: init: current segments file is 
"segments_1"; 
deletionPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper@6115c8e1
   [junit4]   2> 250712 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream 
[IFD][coreLoadExecutor-1097-thread-1]: init: load commit "segments_1"
   [junit4]   2> 250712 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream 
[IFD][coreLoadExecutor-1097-thread-1]: now checkpoint "" [0 segments ; isCommit 
= false]
   [junit4]   2> 250712 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream 
[IFD][coreLoadExecutor-1097-thread-1]: 0 msec to checkpoint
   [junit4]   2> 250712 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
init: create=false reader=null
   [junit4]   2> 250712 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
   [junit4]   2> dir=MockDirectoryWrapper(RAMDirectory@11fa2c1a 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@33788b9d)
   [junit4]   2> index=
   [junit4]   2> version=8.3.0
   [junit4]   2> 
analyzer=org.apache.solr.update.SolrIndexConfig$DelayedSchemaAnalyzer
   [junit4]   2> ramBufferSizeMB=100.0
   [junit4]   2> maxBufferedDocs=-1
   [junit4]   2> mergedSegmentWarmer=null
   [junit4]   2> delPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper
   [junit4]   2> commit=null
   [junit4]   2> openMode=APPEND
   [junit4]   2> 
similarity=org.apache.solr.search.similarities.SchemaSimilarityFactory$SchemaSimilarity
   [junit4]   2> mergeScheduler=ConcurrentMergeScheduler: maxThreadCount=-1, 
maxMergeCount=-1, ioThrottle=true
   [junit4]   2> codec=Lucene80
   [junit4]   2> infoStream=org.apache.solr.update.LoggingInfoStream
   [junit4]   2> mergePolicy=[TieredMergePolicy: maxMergeAtOnce=10, 
maxMergeAtOnceExplicit=30, maxMergedSegmentMB=5120.0, floorSegmentMB=2.0, 
forceMergeDeletesPctAllowed=10.0, segmentsPerTier=10.0, 
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1, deletesPctAllowed=33.0
   [junit4]   2> 
indexerThreadPool=org.apache.lucene.index.DocumentsWriterPerThreadPool@4433203b
   [junit4]   2> readerPooling=true
   [junit4]   2> perThreadHardLimitMB=1945
   [junit4]   2> useCompoundFile=false
   [junit4]   2> commitOnClose=true
   [junit4]   2> indexSort=null
   [junit4]   2> checkPendingFlushOnUpdate=true
   [junit4]   2> softDeletesField=null
   [junit4]   2> readerAttributes={}
   [junit4]   2> writer=org.apache.solr.update.SolrIndexWriter@289f3d4b
   [junit4]   2> 
   [junit4]   2> 250712 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
MMapDirectory.UNMAP_SUPPORTED=true
   [junit4]   2> 250712 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
flush at getReader
   [junit4]   2> 250712 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-1097-thread-1]: 
startFullFlush
   [junit4]   2> 250712 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
now apply all deletes for all segments buffered updates bytesUsed=0 reader pool 
bytesUsed=0
   [junit4]   2> 250712 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-1097-thread-1]: 
waitApply: no deletes to apply
   [junit4]   2> 250712 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
incRefDeleter for NRT reader version=2 segments=
   [junit4]   2> 250712 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
return reader version=2 reader=StandardDirectoryReader(segments_1:2:nrt)
   [junit4]   2> 250712 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-1097-thread-1]: 
coreLoadExecutor-1097-thread-1 finishFullFlush success=true
   [junit4]   2> 250712 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-1097-thread-1]: 
getReader took 0 msec
   [junit4]   2> 250712 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@b73febb[collection1] main]
   [junit4]   2> 250713 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.r.ManagedResourceStorage File-based storage initialized 
to use dir: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/tempDir-001/collection1/conf
   [junit4]   2> 250713 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.r.ManagedResourceStorage Loaded LinkedHashMap at path 
_rest_managed.json using 
file:dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/tempDir-001/collection1/conf
   [junit4]   2> 250713 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.r.ManagedResource Loaded initArgs {} for /rest/managed
   [junit4]   2> 250714 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.r.ManagedResourceStorage Loaded LinkedHashMap at path 
_schema_analysis_stopwords_english.json using 
file:dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/tempDir-001/collection1/conf
   [junit4]   2> 250714 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.r.ManagedResource Loaded initArgs {ignoreCase=true} for 
/schema/analysis/stopwords/english
   [junit4]   2> 250714 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.r.s.a.ManagedWordSetResource Loaded 35 words for 
/schema/analysis/stopwords/english
   [junit4]   2> 250714 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.r.ManagedResource Notified 4 observers of 
/schema/analysis/stopwords/english
   [junit4]   2> 250714 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.r.ManagedResourceStorage Loaded LinkedHashMap at path 
_schema_analysis_synonyms_english.json using 
file:dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/tempDir-001/collection1/conf
   [junit4]   2> 250714 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.r.ManagedResource Loaded initArgs 
{ignoreCase=true,format=solr} for /schema/analysis/synonyms/english
   [junit4]   2> 250714 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.r.s.a.ManagedSynonymGraphFilterFactory Loaded 3 synonym 
mappings for /schema/analysis/synonyms/english
   [junit4]   2> 250715 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.r.ManagedResource Notified 4 observers of 
/schema/analysis/synonyms/english
   [junit4]   2> 250715 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 250715 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: 
{name=default,field=text,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4,maxQueryFrequency=0.01}
   [junit4]   2> 250716 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.h.c.SuggestComponent Initializing SuggestComponent
   [junit4]   2> 250716 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.s.s.SolrSuggester init: 
{name=mySuggester,lookupImpl=FuzzyLookupFactory,dictionaryImpl=DocumentDictionaryFactory,field=cat,weightField=price,suggestAnalyzerFieldType=string,buildOnStartup=false}
   [junit4]   2> 250716 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.s.s.SolrSuggester Dictionary loaded with params: 
{name=mySuggester,lookupImpl=FuzzyLookupFactory,dictionaryImpl=DocumentDictionaryFactory,field=cat,weightField=price,suggestAnalyzerFieldType=string,buildOnStartup=false}
   [junit4]   2> 250717 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.h.c.QueryElevationComponent Loading QueryElevation from: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_68236FDA71F417A9-001/tempDir-001/collection1/conf/elevate.xml
   [junit4]   2> 250722 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 250722 INFO  (coreLoadExecutor-1097-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1643175978454745088
   [junit4]   2> 250725 INFO  
(searcherExecutor-1098-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.QuerySenderListener QuerySenderListener sending requests to 
Searcher@b73febb[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 250725 INFO  
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[68236FDA71F417A9]-worker) [    
 ] o.a.s.SolrJettyTestBase Jetty Assigned Port#38435
   [junit4]   2> 250725 INFO  
(searcherExecutor-1098-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=static+firstSearcher+warming+in+solrconfig.xml&distrib=false&event=firstSearcher}
 hits=0 status=0 QTime=0
   [junit4]   2> 250725 INFO  
(searcherExecutor-1098-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.QuerySenderListener QuerySenderListener done.
   [junit4]   2> 250725 INFO  
(searcherExecutor-1098-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 250725 INFO  
(searcherExecutor-1098-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 250733 INFO  
(searcherExecutor-1098-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@b73febb[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 250747 INFO  
(TEST-ConcurrentUpdateHttp2SolrClientTest.testConcurrentCollectionUpdate-seed#[68236FDA71F417A9])
 [     ] o.a.s.SolrTestCaseJ4 ###Starting testConcurrentCollectionUpdate
   [junit4]   2> 250748 WARN  
(TEST-ConcurrentUpdateHttp2SolrClientTest.testConcurrentCollectionUpdate-seed#[68236FDA71F417A9])
 [     ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 
transport since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 250753 WARN  
(TEST-ConcurrentUpdateHttp2SolrClientTest.testConcurrentCollectionUpdate-seed#[68236FDA71F417A9])
 [     ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@49f1caae[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 250753 WARN  
(TEST-ConcurrentUpdateHttp2SolrClientTest.testConcurrentCollectionUpdate-seed#[68236FDA71F417A9])
 [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm 
configured for Client@49f1caae[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 250796 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DW][qtp1919480400-5144]: anyChanges? numDocsInRam=0 
deletes=true hasTickets:false pendingChangesInFullFlush: false
   [junit4]   2> 250796 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DW][qtp1919480400-5144]: anyChanges? numDocsInRam=0 
deletes=true hasTickets:false pendingChangesInFullFlush: false
   [junit4]   2> 250796 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: nrtIsCurrent: infoVersion 
matches: true; DW changes: true; BD changes: false
   [junit4]   2> 250796 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: flush at getReader
   [junit4]   2> 250796 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DW][qtp1919480400-5144]: startFullFlush
   [junit4]   2> 250797 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DW][qtp1919480400-5144]: anyChanges? numDocsInRam=0 
deletes=true hasTickets:false pendingChangesInFullFlush: false
   [junit4]   2> 250797 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DW][qtp1919480400-5144]: qtp1919480400-5144: flush 
naked frozen global deletes
   [junit4]   2> 250797 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [BD][qtp1919480400-5144]: compressed 76 to 48 bytes 
(63.16%) for deletes/updates; private segment null
   [junit4]   2> 250797 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [BD][qtp1919480400-5144]: push new packet (delGen=1 
numDeleteQueries=1 bytesUsed=48), packetCount=1, bytesUsed=0.000 MB
   [junit4]   2> 250797 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: flush: push buffered 
updates: delGen=1 numDeleteQueries=1 bytesUsed=48
   [junit4]   2> 250797 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [BD][qtp1919480400-5144]: packet matches no segments
   [junit4]   2> 250797 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [BD][qtp1919480400-5144]: finished packet delGen=1 
now completedDelGen=1
   [junit4]   2> 250797 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [BD][qtp1919480400-5144]: done apply del packet 
(delGen=1 numDeleteQueries=1 bytesUsed=48) to 0 segments; 0 new 
deletes/updates; took 0.000 sec; 0 packets remain
   [junit4]   2> 250797 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: now apply all deletes for 
all segments buffered updates bytesUsed=0 reader pool bytesUsed=0
   [junit4]   2> 250797 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [BD][qtp1919480400-5144]: waitApply: no deletes to 
apply
   [junit4]   2> 250797 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: incRefDeleter for NRT 
reader version=2 segments=
   [junit4]   2> 250798 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: return reader version=2 
reader=StandardDirectoryReader(segments_1:2:nrt)
   [junit4]   2> 250798 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DW][qtp1919480400-5144]: qtp1919480400-5144 
finishFullFlush success=true
   [junit4]   2> 250798 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: getReader took 2 msec
   [junit4]   2> 250798 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: decRefDeleter for NRT 
reader version=2 segments=
   [junit4]   2> 250801 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1643175978529193984)} 0 9
   [junit4]   2> 250858 INFO  (qtp1919480400-5145) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[0_0 (1643175978559602688), 1_0 
(1643175978561699840), 0_2 (1643175978561699841), 0_3 (1643175978561699842), 
0_4 (1643175978562748416), 0_5 (1643175978562748417), 0_6 
(1643175978562748418), 0_7 (1643175978562748419), 0_8 (1643175978563796992), 
0_9 (1643175978563796993), ... (107 adds)]} 0 36
   [junit4]   2> 250871 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[0_1 (1643175978575331329), 1_2 
(1643175978575331330), 1_4 (1643175978575331332), 1_5 (1643175978575331333), 
1_7 (1643175978576379905), 0_17 (1643175978576379906), 1_8 
(1643175978576379908), 1_9 (1643175978576379909), 1_10 (1643175978576379910), 
0_19 (1643175978576379912), ... (103 adds)]} 0 34
   [junit4]   2> 250931 INFO  (qtp1919480400-5141) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[3_64 (1643175978671800320), 4_83 
(1643175978671800322), 4_85 (1643175978671800324), 4_87 (1643175978672848896), 
4_89 (1643175978672848899), 4_91 (1643175978672848901), 4_93 
(1643175978672848903), 4_95 (1643175978672848905), 4_96 (1643175978672848907), 
4_97 (1643175978672848909), ... (12 adds)]} 0 1
   [junit4]   2> 250934 INFO  (qtp1919480400-5145) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[1_26 (1643175978605740034), 1_27 
(1643175978605740036), 1_28 (1643175978605740038), 1_29 (1643175978605740040), 
1_30 (1643175978605740042), 1_31 (1643175978605740044), 1_32 
(1643175978605740046), 1_33 (1643175978609934336), 1_34 (1643175978609934338), 
1_35 (1643175978609934340), ... (278 adds)]} 0 68
   [junit4]   2> 255824 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1643175983804579840,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 255824 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@289f3d4b 
commitCommandVersion:1643175983804579840
   [junit4]   2> 255824 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: commit: start
   [junit4]   2> 255824 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: commit: enter lock
   [junit4]   2> 255824 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: commit: now prepare
   [junit4]   2> 255824 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: prepareCommit: flush
   [junit4]   2> 255824 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]:   index before flush 
   [junit4]   2> 255824 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DW][qtp1919480400-5144]: startFullFlush
   [junit4]   2> 255824 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DW][qtp1919480400-5144]: anyChanges? 
numDocsInRam=500 deletes=true hasTickets:false pendingChangesInFullFlush: false
   [junit4]   2> 255824 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DWFC][qtp1919480400-5144]: addFlushableState 
DocumentsWriterPerThread [pendingDeletes=gen=0 471 deleted terms (unique 
count=471) bytesUsed=82847, segment=_0, aborted=false, numDocsInRAM=217, 
deleteQueue=DWDQ: [ generation: 2 ]]
   [junit4]   2> 255824 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DWFC][qtp1919480400-5144]: addFlushableState 
DocumentsWriterPerThread [pendingDeletes=gen=0 293 deleted terms (unique 
count=293) bytesUsed=51553, segment=_1, aborted=false, numDocsInRAM=283, 
deleteQueue=DWDQ: [ generation: 2 ]]
   [junit4]   2> 255825 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [BD][qtp1919480400-5144]: compressed 87950 to 2064 
bytes (2.35%) for deletes/updates; private segment null
   [junit4]   2> 255825 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DWPT][qtp1919480400-5144]: flush postings as segment 
_0 numDocs=217
   [junit4]   2> 255825 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: 0 msec to write norms
   [junit4]   2> 255829 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: 4 msec to write docValues
   [junit4]   2> 255829 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: 0 msec to write points
   [junit4]   2> 255830 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: 0 msec to finish stored 
fields
   [junit4]   2> 255831 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: 1 msec to write postings 
and finish vectors
   [junit4]   2> 255831 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: 0 msec to write fieldInfos
   [junit4]   2> 255832 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DWPT][qtp1919480400-5144]: new segment has 0 deleted 
docs
   [junit4]   2> 255832 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DWPT][qtp1919480400-5144]: new segment has 0 
soft-deleted docs
   [junit4]   2> 255832 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DWPT][qtp1919480400-5144]: new segment has no 
vectors; no norms; docValues; no prox; freqs
   [junit4]   2> 255832 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DWPT][qtp1919480400-5144]: 
flushedFiles=[_0_Lucene50_0.doc, _0_Lucene50_0.tim, _0_Lucene80_0.dvd, _0.fdx, 
_0_Lucene50_0.tip, _0.fdt, _0_Lucene80_0.dvm, _0.fnm]
   [junit4]   2> 255832 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DWPT][qtp1919480400-5144]: flushed codec=Lucene80
   [junit4]   2> 255832 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DWPT][qtp1919480400-5144]: flushed: segment=_0 
ramUsed=0.183 MB newFlushedSize=0.007 MB docs/MB=32,454.856
   [junit4]   2> 255832 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DWPT][qtp1919480400-5144]: flush time 6.782385 msec
   [junit4]   2> 255832 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DWPT][qtp1919480400-5144]: flush postings as segment 
_1 numDocs=283
   [junit4]   2> 255832 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: 0 msec to write norms
   [junit4]   2> 255832 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: 0 msec to write docValues
   [junit4]   2> 255832 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: 0 msec to write points
   [junit4]   2> 255832 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: 0 msec to finish stored 
fields
   [junit4]   2> 255833 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: 1 msec to write postings 
and finish vectors
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: 0 msec to write fieldInfos
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DWPT][qtp1919480400-5144]: new segment has 0 deleted 
docs
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DWPT][qtp1919480400-5144]: new segment has 0 
soft-deleted docs
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DWPT][qtp1919480400-5144]: new segment has no 
vectors; no norms; docValues; no prox; freqs
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DWPT][qtp1919480400-5144]: 
flushedFiles=[_1_Lucene50_0.doc, _1_Lucene50_0.tim, _1_Lucene80_0.dvd, _1.fdx, 
_1.fnm, _1_Lucene80_0.dvm, _1.fdt, _1_Lucene50_0.tip]
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DWPT][qtp1919480400-5144]: flushed codec=Lucene80
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DWPT][qtp1919480400-5144]: flushed: segment=_1 
ramUsed=0.155 MB newFlushedSize=0.007 MB docs/MB=40,204.174
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DWPT][qtp1919480400-5144]: flush time 1.967059 msec
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: publishFlushedSegment 
seg-private updates=null
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: publishFlushedSegment 
_0(8.3.0):C217:[diagnostics={os=Linux, java.vendor=Oracle Corporation, 
java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.3.0, 
os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, 
os.version=4.15.0-54-generic, 
timestamp=1567054733098}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [BD][qtp1919480400-5144]: push new packet (delGen=2 
numDeleteTerms=500 bytesUsed=2064), packetCount=1, bytesUsed=0.002 MB
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [BD][qtp1919480400-5144]: finished packet delGen=3 
now completedDelGen=1
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: publish sets newSegment 
delGen=3 seg=_0(8.3.0):C217:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12, 
lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_191-b12, 
source=flush, os.version=4.15.0-54-generic, 
timestamp=1567054733098}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IFD][qtp1919480400-5144]: now checkpoint 
"_0(8.3.0):C217:[diagnostics={os=Linux, java.vendor=Oracle Corporation, 
java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.3.0, 
os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, 
os.version=4.15.0-54-generic, 
timestamp=1567054733098}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]"
 [1 segments ; isCommit = false]
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IFD][qtp1919480400-5144]: 0 msec to checkpoint
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: publishFlushedSegment 
seg-private updates=null
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: publishFlushedSegment 
_1(8.3.0):C283:[diagnostics={os=Linux, java.vendor=Oracle Corporation, 
java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.3.0, 
os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, 
os.version=4.15.0-54-generic, 
timestamp=1567054733100}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [BD][qtp1919480400-5144]: finished packet delGen=4 
now completedDelGen=1
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: publish sets newSegment 
delGen=4 seg=_1(8.3.0):C283:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12, 
lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_191-b12, 
source=flush, os.version=4.15.0-54-generic, 
timestamp=1567054733100}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IFD][qtp1919480400-5144]: now checkpoint 
"_0(8.3.0):C217:[diagnostics={os=Linux, java.vendor=Oracle Corporation, 
java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.3.0, 
os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, 
os.version=4.15.0-54-generic, 
timestamp=1567054733098}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
 _1(8.3.0):C283:[diagnostics={os=Linux, java.vendor=Oracle Corporation, 
java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.3.0, 
os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, 
os.version=4.15.0-54-generic, 
timestamp=1567054733100}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]"
 [2 segments ; isCommit = false]
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IFD][qtp1919480400-5144]: 0 msec to checkpoint
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [BD][qtp1919480400-5144]: packet matches no segments
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [BD][qtp1919480400-5144]: finished packet delGen=2 
now completedDelGen=4
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [BD][qtp1919480400-5144]: done apply del packet 
(delGen=2 numDeleteTerms=500 bytesUsed=2064) to 0 segments; 0 new 
deletes/updates; took 0.000 sec; 0 packets remain
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: now apply all deletes for 
all segments buffered updates bytesUsed=0 reader pool bytesUsed=0
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [BD][qtp1919480400-5144]: waitApply: no deletes to 
apply
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DW][qtp1919480400-5144]: qtp1919480400-5144 
finishFullFlush success=true
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: startCommit(): start
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: startCommit 
index=_0(8.3.0):C217:[diagnostics={os=Linux, java.vendor=Oracle Corporation, 
java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.3.0, 
os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, 
os.version=4.15.0-54-generic, 
timestamp=1567054733098}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
 _1(8.3.0):C283:[diagnostics={os=Linux, java.vendor=Oracle Corporation, 
java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.3.0, 
os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, 
os.version=4.15.0-54-generic, 
timestamp=1567054733100}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
 changeCount=6
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: startCommit: wrote pending 
segments file "pending_segments_2"
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: done all syncs: [_0.si, 
_0_Lucene50_0.doc, _0_Lucene50_0.tim, _1.si, _1_Lucene80_0.dvd, _0.fdx, 
_0_Lucene50_0.tip, _1.fnm, _0.fdt, _0_Lucene80_0.dvm, _1_Lucene50_0.doc, 
_1_Lucene50_0.tim, _0_Lucene80_0.dvd, _1.fdx, _1_Lucene80_0.dvm, _0.fnm, 
_1.fdt, _1_Lucene50_0.tip]
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: commit: pendingCommit != 
null
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: commit: done writing 
segments file "segments_2"
   [junit4]   2> 255834 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IFD][qtp1919480400-5144]: now checkpoint 
"_0(8.3.0):C217:[diagnostics={os=Linux, java.vendor=Oracle Corporation, 
java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.3.0, 
os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, 
os.version=4.15.0-54-generic, 
timestamp=1567054733098}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
 _1(8.3.0):C283:[diagnostics={os=Linux, java.vendor=Oracle Corporation, 
java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.3.0, 
os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, 
os.version=4.15.0-54-generic, 
timestamp=1567054733100}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]"
 [2 segments ; isCommit = true]
   [junit4]   2> 255835 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IFD][qtp1919480400-5144]: deleteCommits: now decRef 
commit "segments_1"
   [junit4]   2> 255835 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IFD][qtp1919480400-5144]: delete [segments_1]
   [junit4]   2> 255835 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IFD][qtp1919480400-5144]: 0 msec to checkpoint
   [junit4]   2> 255835 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: commit: took 11.4 msec
   [junit4]   2> 255835 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: commit: done
   [junit4]   2> 255835 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [MP][qtp1919480400-5144]:   
seg=_1(8.3.0):C283:[diagnostics={os=Linux, java.vendor=Oracle Corporation, 
java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.3.0, 
os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, 
os.version=4.15.0-54-generic, 
timestamp=1567054733100}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
 size=0.007 MB [floored]
   [junit4]   2> 255835 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [MP][qtp1919480400-5144]:   
seg=_0(8.3.0):C217:[diagnostics={os=Linux, java.vendor=Oracle Corporation, 
java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.3.0, 
os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, 
os.version=4.15.0-54-generic, 
timestamp=1567054733098}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
 size=0.007 MB [floored]
   [junit4]   2> 255835 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [MP][qtp1919480400-5144]: findMerges: 2 segments
   [junit4]   2> 255835 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [MP][qtp1919480400-5144]:   allowedSegmentCount=10 vs 
count=2 (eligible count=2)
   [junit4]   2> 255836 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [MS][qtp1919480400-5144]: initDynamicDefaults 
spins=true maxThreadCount=1 maxMergeCount=6
   [junit4]   2> 255836 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [MS][qtp1919480400-5144]: now merge
   [junit4]   2> 255836 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [MS][qtp1919480400-5144]:   index: 
_0(8.3.0):C217:[diagnostics={os=Linux, java.vendor=Oracle Corporation, 
java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.3.0, 
os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, 
os.version=4.15.0-54-generic, 
timestamp=1567054733098}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
 _1(8.3.0):C283:[diagnostics={os=Linux, java.vendor=Oracle Corporation, 
java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.3.0, 
os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, 
os.version=4.15.0-54-generic, 
timestamp=1567054733100}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
   [junit4]   2> 255836 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [MS][qtp1919480400-5144]:   no more merges pending; 
now return
   [junit4]   2> 255836 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: nrtIsCurrent: infoVersion 
matches: false; DW changes: false; BD changes: false
   [junit4]   2> 255836 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: flush at getReader
   [junit4]   2> 255836 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DW][qtp1919480400-5144]: startFullFlush
   [junit4]   2> 255836 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: now apply all deletes for 
all segments buffered updates bytesUsed=0 reader pool bytesUsed=0
   [junit4]   2> 255836 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [BD][qtp1919480400-5144]: waitApply: no deletes to 
apply
   [junit4]   2> 255837 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: incRefDeleter for NRT 
reader version=8 segments=_0(8.3.0):C217:[diagnostics={os=Linux, 
java.vendor=Oracle Corporation, java.version=1.8.0_191, 
java.vm.version=25.191-b12, lucene.version=8.3.0, os.arch=amd64, 
java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.15.0-54-generic, 
timestamp=1567054733098}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
 _1(8.3.0):C283:[diagnostics={os=Linux, java.vendor=Oracle Corporation, 
java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.3.0, 
os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, 
os.version=4.15.0-54-generic, 
timestamp=1567054733100}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
   [junit4]   2> 255837 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: return reader version=8 
reader=StandardDirectoryReader(segments_2:8:nrt 
_0(8.3.0):C217:[diagnostics={os=Linux, java.vendor=Oracle Corporation, 
java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.3.0, 
os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, 
os.version=4.15.0-54-generic, 
timestamp=1567054733098}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
 _1(8.3.0):C283:[diagnostics={os=Linux, java.vendor=Oracle Corporation, 
java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.3.0, 
os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, 
os.version=4.15.0-54-generic, 
timestamp=1567054733100}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
   [junit4]   2> 255837 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DW][qtp1919480400-5144]: qtp1919480400-5144 
finishFullFlush success=true
   [junit4]   2> 255837 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5144]: getReader took 1 msec
   [junit4]   2> 255837 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@6de284d0[collection1] main]
   [junit4]   2> 255838 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 255838 INFO  
(searcherExecutor-1098-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.QuerySenderListener QuerySenderListener sending requests to 
Searcher@6de284d0[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.3.0):C217:[diagnostics={os=Linux,
 java.vendor=Oracle Corporation, java.version=1.8.0_191, 
java.vm.version=25.191-b12, lucene.version=8.3.0, os.arch=amd64, 
java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.15.0-54-generic, 
timestamp=1567054733098}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
 Uninverting(_1(8.3.0):C283:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12, 
lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_191-b12, 
source=flush, os.version=4.15.0-54-generic, 
timestamp=1567054733100}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
   [junit4]   2> 255838 INFO  
(searcherExecutor-1098-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.QuerySenderListener QuerySenderListener done.
   [junit4]   2> 255841 INFO  
(searcherExecutor-1098-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6de284d0[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.3.0):C217:[diagnostics={os=Linux,
 java.vendor=Oracle Corporation, java.version=1.8.0_191, 
java.vm.version=25.191-b12, lucene.version=8.3.0, os.arch=amd64, 
java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.15.0-54-generic, 
timestamp=1567054733098}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
 Uninverting(_1(8.3.0):C283:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12, 
lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_191-b12, 
source=flush, os.version=4.15.0-54-generic, 
timestamp=1567054733100}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
   [junit4]   2> 255841 INFO  
(searcherExecutor-1098-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream 
[IW][searcherExecutor-1098-thread-1-processing-x:collection1]: decRefDeleter 
for NRT reader version=2 segments=
   [junit4]   2> 255842 INFO  (qtp1919480400-5144) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 18
   [junit4]   2> 255844 INFO  (qtp1919480400-5142) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=500 status=0 QTime=0
   [junit4]   2> 255853 WARN  
(TEST-ConcurrentUpdateHttp2SolrClientTest.testConcurrentCollectionUpdate-seed#[68236FDA71F417A9])
 [     ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 
transport since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 255858 WARN  
(TEST-ConcurrentUpdateHttp2SolrClientTest.testConcurrentCollectionUpdate-seed#[68236FDA71F417A9])
 [     ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@7a9abfc4[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 255858 WARN  
(TEST-ConcurrentUpdateHttp2SolrClientTest.testConcurrentCollectionUpdate-seed#[68236FDA71F417A9])
 [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm 
configured for Client@7a9abfc4[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 255887 INFO  (qtp1919480400-5142) [    x:collection1 ] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=500 status=0 QTime=0
   [junit4]   2> 255900 INFO  
(TEST-ConcurrentUpdateHttp2SolrClientTest.testConcurrentCollectionUpdate-seed#[68236FDA71F417A9])
 [     ] o.a.s.SolrTestCaseJ4 ###Ending testConcurrentCollectionUpdate
   [junit4]   2> 255907 INFO  
(TEST-ConcurrentUpdateHttp2SolrClientTest.testCollectionParameters-seed#[68236FDA71F417A9])
 [     ] o.a.s.SolrTestCaseJ4 ###Starting testCollectionParameters
   [junit4]   2> 255908 WARN  
(TEST-ConcurrentUpdateHttp2SolrClientTest.testCollectionParameters-seed#[68236FDA71F417A9])
 [     ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 
transport since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 255910 WARN  
(TEST-ConcurrentUpdateHttp2SolrClientTest.testCollectionParameters-seed#[68236FDA71F417A9])
 [     ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@3a1ee76c[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 255910 WARN  
(TEST-ConcurrentUpdateHttp2SolrClientTest.testCollectionParameters-seed#[68236FDA71F417A9])
 [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm 
configured for Client@3a1ee76c[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 255941 INFO  (qtp1919480400-5145) [    x:collection1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[collection (1643175983923068928)]} 0 3
   [junit4]   2> 255950 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1643175983936700416,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 255950 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@289f3d4b 
commitCommandVersion:1643175983936700416
   [junit4]   2> 255950 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5143]: commit: start
   [junit4]   2> 255950 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5143]: commit: enter lock
   [junit4]   2> 255950 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5143]: commit: now prepare
   [junit4]   2> 255951 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5143]: prepareCommit: flush
   [junit4]   2> 255951 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5143]:   index before flush 
_0(8.3.0):C217:[diagnostics={os=Linux, java.vendor=Oracle Corporation, 
java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.3.0, 
os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, 
os.version=4.15.0-54-generic, 
timestamp=1567054733098}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
 _1(8.3.0):C283:[diagnostics={os=Linux, java.vendor=Oracle Corporation, 
java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.3.0, 
os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, 
os.version=4.15.0-54-generic, 
timestamp=1567054733100}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
   [junit4]   2> 255951 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DW][qtp1919480400-5143]: startFullFlush
   [junit4]   2> 255951 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DW][qtp1919480400-5143]: anyChanges? numDocsInRam=1 
deletes=true hasTickets:false pendingChangesInFullFlush: false
   [junit4]   2> 255951 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DWFC][qtp1919480400-5143]: addFlushableState 
DocumentsWriterPerThread [pendingDeletes=gen=0, segment=_2, aborted=false, 
numDocsInRAM=1, deleteQueue=DWDQ: [ generation: 4 ]]
   [junit4]   2> 255951 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [BD][qtp1919480400-5143]: compressed 182 to 1040 
bytes (571.43%) for deletes/updates; private segment null
   [junit4]   2> 255951 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DWPT][qtp1919480400-5143]: flush postings as segment 
_2 numDocs=1
   [junit4]   2> 255951 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5143]: 0 msec to write norms
   [junit4]   2> 255951 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5143]: 0 msec to write docValues
   [junit4]   2> 255951 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5143]: 0 msec to write points
   [junit4]   2> 255951 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5143]: 0 msec to finish stored 
fields
   [junit4]   2> 255952 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5143]: 0 msec to write postings 
and finish vectors
   [junit4]   2> 255952 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5143]: 0 msec to write fieldInfos
   [junit4]   2> 255952 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DWPT][qtp1919480400-5143]: new segment has 0 deleted 
docs
   [junit4]   2> 255952 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DWPT][qtp1919480400-5143]: new segment has 0 
soft-deleted docs
   [junit4]   2> 255952 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DWPT][qtp1919480400-5143]: new segment has no 
vectors; no norms; docValues; no prox; freqs
   [junit4]   2> 255952 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DWPT][qtp1919480400-5143]: 
flushedFiles=[_2_Lucene80_0.dvd, _2.fdt, _2_Lucene80_0.dvm, _2.fnm, _2.fdx, 
_2_Lucene50_0.doc, _2_Lucene50_0.tim, _2_Lucene50_0.tip]
   [junit4]   2> 255952 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DWPT][qtp1919480400-5143]: flushed codec=Lucene80
   [junit4]   2> 255952 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DWPT][qtp1919480400-5143]: flushed: segment=_2 
ramUsed=0.087 MB newFlushedSize=0.001 MB docs/MB=860.9
   [junit4]   2> 255952 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DWPT][qtp1919480400-5143]: flush time 1.384085 msec
   [junit4]   2> 255952 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5143]: publishFlushedSegment 
seg-private updates=null
   [junit4]   2> 255952 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5143]: publishFlushedSegment 
_2(8.3.0):C1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, 
java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.3.0, 
os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, 
os.version=4.15.0-54-generic, 
timestamp=1567054733218}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
   [junit4]   2> 255952 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [BD][qtp1919480400-5143]: push new packet (delGen=5 
numDeleteTerms=1 bytesUsed=1040), packetCount=1, bytesUsed=0.001 MB
   [junit4]   2> 255953 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [BD][qtp1919480400-5143]: finished packet delGen=6 
now completedDelGen=4
   [junit4]   2> 255953 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5143]: publish sets newSegment 
delGen=6 seg=_2(8.3.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12, 
lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_191-b12, 
source=flush, os.version=4.15.0-54-generic, 
timestamp=1567054733218}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
   [junit4]   2> 255953 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IFD][qtp1919480400-5143]: now checkpoint 
"_0(8.3.0):C217:[diagnostics={os=Linux, java.vendor=Oracle Corporation, 
java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.3.0, 
os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, 
os.version=4.15.0-54-generic, 
timestamp=1567054733098}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
 _1(8.3.0):C283:[diagnostics={os=Linux, java.vendor=Oracle Corporation, 
java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.3.0, 
os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, 
os.version=4.15.0-54-generic, 
timestamp=1567054733100}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
 _2(8.3.0):C1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, 
java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.3.0, 
os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, 
os.version=4.15.0-54-generic, 
timestamp=1567054733218}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]"
 [3 segments ; isCommit = false]
   [junit4]   2> 255953 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IFD][qtp1919480400-5143]: 0 msec to checkpoint
   [junit4]   2> 255953 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [BD][qtp1919480400-5143]: now apply del packet 
(delGen=5 numDeleteTerms=1 bytesUsed=1040) to 2 segments, mergeGen 0
   [junit4]   2> 255954 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [BD][qtp1919480400-5143]: applyTermDeletes took 0.13 
msec for 2 segments and 1 del terms; 0 new deletions
   [junit4]   2> 255954 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [BD][qtp1919480400-5143]: closeSegmentStates: 0 new 
deleted documents; pool 1 packets; bytesUsed=0
   [junit4]   2> 255954 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [BD][qtp1919480400-5143]: done inner apply del packet 
(delGen=5 numDeleteTerms=1 bytesUsed=1040) to 2 segments; 0 new 
deletes/updates; took 0.000 sec
   [junit4]   2> 255954 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [BD][qtp1919480400-5143]: finished packet delGen=5 
now completedDelGen=6
   [junit4]   2> 255954 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [BD][qtp1919480400-5143]: done apply del packet 
(delGen=5 numDeleteTerms=1 bytesUsed=1040) to 2 segments; 0 new 
deletes/updates; took 0.000 sec; 0 packets remain
   [junit4]   2> 255954 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5143]: now apply all deletes for 
all segments buffered updates bytesUsed=0 reader pool bytesUsed=0
   [junit4]   2> 255954 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [BD][qtp1919480400-5143]: waitApply: no deletes to 
apply
   [junit4]   2> 255954 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [DW][qtp1919480400-5143]: qtp1919480400-5143 
finishFullFlush success=true
   [junit4]   2> 255954 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5143]: startCommit(): start
   [junit4]   2> 255954 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5143]: startCommit 
index=_0(8.3.0):C217:[diagnostics={os=Linux, java.vendor=Oracle Corporation, 
java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.3.0, 
os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, 
os.version=4.15.0-54-generic, 
timestamp=1567054733098}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
 _1(8.3.0):C283:[diagnostics={os=Linux, java.vendor=Oracle Corporation, 
java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.3.0, 
os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, 
os.version=4.15.0-54-generic, 
timestamp=1567054733100}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
 _2(8.3.0):C1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, 
java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.3.0, 
os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, 
os.version=4.15.0-54-generic, 
timestamp=1567054733218}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
 changeCount=10
   [junit4]   2> 255954 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5143]: startCommit: wrote pending 
segments file "pending_segments_3"
   [junit4]   2> 255954 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5143]: done all syncs: 
[_0_Lucene50_0.doc, _1.si, _2.fdt, _2_Lucene80_0.dvm, _1.fnm, _2.fdx, 
_2_Lucene50_0.tim, _2_Lucene50_0.tip, _1_Lucene50_0.tim, _0_Lucene80_0.dvd, 
_2.fnm, _1.fdx, _1_Lucene80_0.dvm, _1.fdt, _1_Lucene50_0.tip, _0.si, 
_0_Lucene50_0.tim, _2.si, _1_Lucene80_0.dvd, _0.fdx, _0_Lucene50_0.tip, 
_2_Lucene50_0.doc, _0.fdt, _0_Lucene80_0.dvm, _1_Lucene50_0.doc, 
_2_Lucene80_0.dvd, _0.fnm]
   [junit4]   2> 255954 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5143]: commit: pendingCommit != 
null
   [junit4]   2> 255954 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IW][qtp1919480400-5143]: commit: done writing 
segments file "segments_3"
   [junit4]   2> 255954 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IFD][qtp1919480400-5143]: now checkpoint 
"_0(8.3.0):C217:[diagnostics={os=Linux, java.vendor=Oracle Corporation, 
java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.3.0, 
os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, 
os.version=4.15.0-54-generic, 
timestamp=1567054733098}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
 _1(8.3.0):C283:[diagnostics={os=Linux, java.vendor=Oracle Corporation, 
java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.3.0, 
os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, 
os.version=4.15.0-54-generic, 
timestamp=1567054733100}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
 _2(8.3.0):C1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, 
java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.3.0, 
os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, 
os.version=4.15.0-54-generic, 
timestamp=1567054733218}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]"
 [3 segments ; isCommit = true]
   [junit4]   2> 255954 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IFD][qtp1919480400-5143]: deleteCommits: now decRef 
commit "segments_2"
   [junit4]   2> 255954 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IFD][qtp1919480400-5143]: delete [segments_2]
   [junit4]   2> 255954 INFO  (qtp1919480400-5143) [    x:collection1 ] 
o.a.s.u.LoggingInfoStream [IFD][qtp1919480400-5143]: 0 msec to checkpoint
   [junit4]   2> 255954 INFO  (qtp1919480400-5143) [    x:collection1 ] o.a.s

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

o not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/lucene/top-level-ivy-settings.xml

resolve:

jar-checksums:
    [mkdir] Created dir: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/null1532565683
     [copy] Copying 249 files to 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/null1532565683
   [delete] Deleting directory 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/null1532565683

check-working-copy:
[ivy:cachepath] :: resolving dependencies :: #;working@lucene1-us-west
[ivy:cachepath]         confs: [default]
[ivy:cachepath]         found 
org.eclipse.jgit#org.eclipse.jgit;5.3.0.201903130848-r in public
[ivy:cachepath]         found com.jcraft#jsch;0.1.54 in public
[ivy:cachepath]         found com.jcraft#jzlib;1.1.1 in public
[ivy:cachepath]         found com.googlecode.javaewah#JavaEWAH;1.1.6 in public
[ivy:cachepath]         found org.slf4j#slf4j-api;1.7.2 in public
[ivy:cachepath]         found org.bouncycastle#bcpg-jdk15on;1.60 in public
[ivy:cachepath]         found org.bouncycastle#bcprov-jdk15on;1.60 in public
[ivy:cachepath]         found org.bouncycastle#bcpkix-jdk15on;1.60 in public
[ivy:cachepath]         found org.slf4j#slf4j-nop;1.7.2 in public
[ivy:cachepath] :: resolution report :: resolve 40ms :: artifacts dl 2ms
        ---------------------------------------------------------------------
        |                  |            modules            ||   artifacts   |
        |       conf       | number| search|dwnlded|evicted|| number|dwnlded|
        ---------------------------------------------------------------------
        |      default     |   9   |   0   |   0   |   0   ||   9   |   0   |
        ---------------------------------------------------------------------
[wc-checker] Initializing working copy...
[wc-checker] Checking working copy status...

-jenkins-base:

BUILD SUCCESSFUL
Total time: 119 minutes 57 seconds
Archiving artifacts
java.lang.InterruptedException: no matches found within 10000
        at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:2847)
        at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2726)
        at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2707)
        at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3086)
Also:   hudson.remoting.Channel$CallSiteStackTrace: Remote call to lucene
                at 
hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1741)
                at 
hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:357)
                at hudson.remoting.Channel.call(Channel.java:955)
                at hudson.FilePath.act(FilePath.java:1072)
                at hudson.FilePath.act(FilePath.java:1061)
                at hudson.FilePath.validateAntFileMask(FilePath.java:2705)
                at 
hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243)
                at 
hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:81)
                at 
hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
                at 
hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:744)
                at 
hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
                at hudson.model.Build$BuildExecution.post2(Build.java:186)
                at 
hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
                at hudson.model.Run.execute(Run.java:1835)
                at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
                at 
hudson.model.ResourceController.execute(ResourceController.java:97)
                at hudson.model.Executor.run(Executor.java:429)
Caused: hudson.FilePath$TunneledInterruptedException
        at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3088)
        at hudson.remoting.UserRequest.perform(UserRequest.java:212)
        at hudson.remoting.UserRequest.perform(UserRequest.java:54)
        at hudson.remoting.Request$2.run(Request.java:369)
        at 
hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:72)
        at java.util.concurrent.FutureTask.run(FutureTask.java:266)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
        at java.lang.Thread.run(Thread.java:744)
Caused: java.lang.InterruptedException: java.lang.InterruptedException: no 
matches found within 10000
        at hudson.FilePath.act(FilePath.java:1074)
        at hudson.FilePath.act(FilePath.java:1061)
        at hudson.FilePath.validateAntFileMask(FilePath.java:2705)
        at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243)
        at 
hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:81)
        at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
        at 
hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:744)
        at 
hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
        at hudson.model.Build$BuildExecution.post2(Build.java:186)
        at 
hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
        at hudson.model.Run.execute(Run.java:1835)
        at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
        at hudson.model.ResourceController.execute(ResourceController.java:97)
        at hudson.model.Executor.run(Executor.java:429)
No artifacts found that match the file pattern 
"**/*.events,heapdumps/**,**/hs_err_pid*". Configuration error?
Recording test results
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to