[JENKINS] Lucene-Solr-BadApples-Tests-8.x - Build # 199 - Unstable

classic Classic list List threaded Threaded
1 message Options
Reply | Threaded
Open this post in threaded view
|

[JENKINS] Lucene-Solr-BadApples-Tests-8.x - Build # 199 - Unstable

Apache Jenkins Server-2
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: [hidden email]
For additional commands, e-mail: [hidden email]