You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2020/07/14 21:40:23 UTC
[JENKINS] Lucene-Solr-Tests-8.x - Build # 1776 - Unstable
Build: https://builds.apache.org/job/Lucene-Solr-Tests-8.x/1776/
1 tests failed.
FAILED: org.apache.solr.client.solrj.impl.Http2SolrClientTest.testUpdate
Error Message:
Captured an uncaught exception in thread: Thread[id=3542, name=h2sc-2269-thread-11, state=RUNNABLE, group=TGRP-Http2SolrClientTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=3542, name=h2sc-2269-thread-11, state=RUNNABLE, group=TGRP-Http2SolrClientTest]
at __randomizedtesting.SeedInfo.seed([CB686202BF07063B:7D7E2708D9C3EEED]:0)
Caused by: java.util.concurrent.RejectedExecutionException: Task java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask@5a993267 rejected from java.util.concurrent.ScheduledThreadPoolExecutor@545ed744[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 0]
at __randomizedtesting.SeedInfo.seed([CB686202BF07063B]:0)
at java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2063)
at java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:830)
at java.util.concurrent.ScheduledThreadPoolExecutor.delayedExecute(ScheduledThreadPoolExecutor.java:326)
at java.util.concurrent.ScheduledThreadPoolExecutor.schedule(ScheduledThreadPoolExecutor.java:533)
at org.eclipse.jetty.util.thread.ScheduledExecutorScheduler.schedule(ScheduledExecutorScheduler.java:122)
at org.eclipse.jetty.util.SocketAddressResolver$Async.lambda$resolve$1(SocketAddressResolver.java:157)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:212)
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 17129 lines...]
[junit4] Suite: org.apache.solr.client.solrj.impl.Http2SolrClientTest
[junit4] 2> 205695 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/server/solr/configsets/_default/conf'
[junit4] 2> 205696 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.Http2SolrClientTest_CB686202BF07063B-001/data-dir-24-001
[junit4] 2> 205696 WARN (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=3 numCloses=3
[junit4] 2> 205696 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 205697 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 205698 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 205721 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 205721 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 205721 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.Http2SolrClientTest_CB686202BF07063B-001/tempDir-002/cores/core
[junit4] 2> 205723 WARN (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 205723 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 205723 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 205723 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 1.8.0_252-b09
[junit4] 2> 205725 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 205725 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 205725 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 205725 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3c83afe6{/solr,null,AVAILABLE}
[junit4] 2> 205726 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.e.j.s.AbstractConnector Started ServerConnector@2655fb29{SSL, (ssl, http/1.1)}{127.0.0.1:44133}
[junit4] 2> 205726 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.e.j.s.Server Started @205753ms
[junit4] 2> 205726 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=44133, configSetBaseDir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.Http2SolrClientTest_CB686202BF07063B-001/tempDir-001, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.Http2SolrClientTest_CB686202BF07063B-001/tempDir-002/cores}
[junit4] 2> 205726 ERROR (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 205726 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 205726 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.7.0
[junit4] 2> 205726 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 205726 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr
[junit4] 2> 205726 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-07-14T21:26:00.250Z
[junit4] 2> 205726 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.Http2SolrClientTest_CB686202BF07063B-001/tempDir-001/solr.xml
[junit4] 2> 205730 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@74a669d0, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 206105 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 206106 WARN (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-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> 206108 WARN (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@4b7d22a1[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 206108 WARN (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@4b7d22a1[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 206110 WARN (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-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> 206111 WARN (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@4cfb3b48[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 206111 WARN (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@4cfb3b48[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 206112 WARN (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 206127 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 206127 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 206160 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@74a669d0
[junit4] 2> 206172 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@74a669d0
[junit4] 2> 206172 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@74a669d0
[junit4] 2> 206179 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.Http2SolrClientTest_CB686202BF07063B-001/tempDir-001
[junit4] 2> 206179 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 206188 WARN (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/contrib/extraction/lib filtered by .*\.jar to classpath: java.nio.file.NoSuchFileException: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/contrib/extraction/lib
[junit4] 2> 206189 WARN (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/dist filtered by solr-cell-\d.*\.jar to classpath: java.nio.file.NoSuchFileException: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/dist
[junit4] 2> 206189 WARN (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/contrib/clustering/lib filtered by .*\.jar to classpath: java.nio.file.NoSuchFileException: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/contrib/clustering/lib
[junit4] 2> 206189 WARN (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/dist filtered by solr-clustering-\d.*\.jar to classpath: java.nio.file.NoSuchFileException: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/dist
[junit4] 2> 206189 WARN (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/contrib/langid/lib filtered by .*\.jar to classpath: java.nio.file.NoSuchFileException: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/contrib/langid/lib
[junit4] 2> 206189 WARN (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/dist filtered by solr-langid-\d.*\.jar to classpath: java.nio.file.NoSuchFileException: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/dist
[junit4] 2> 206189 WARN (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/dist filtered by solr-ltr-\d.*\.jar to classpath: java.nio.file.NoSuchFileException: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/dist
[junit4] 2> 206189 WARN (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/contrib/velocity/lib filtered by .*\.jar to classpath: java.nio.file.NoSuchFileException: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/contrib/velocity/lib
[junit4] 2> 206189 WARN (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/dist filtered by solr-velocity-\d.*\.jar to classpath: java.nio.file.NoSuchFileException: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/dist
[junit4] 2> 206189 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.7.0
[junit4] 2> 206196 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.SolrIndexConfig IndexWriter infoStream solr logging is enabled
[junit4] 2> 206234 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=example
[junit4] 2> 206377 INFO (coreLoadExecutor-2256-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> 206377 INFO (coreLoadExecutor-2256-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> 206377 INFO (coreLoadExecutor-2256-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> 206377 INFO (coreLoadExecutor-2256-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> 206379 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid field id
[junit4] 2> 206379 INFO (coreLoadExecutor-2256-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> 206379 INFO (coreLoadExecutor-2256-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> 206379 INFO (coreLoadExecutor-2256-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> 206379 INFO (coreLoadExecutor-2256-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> 206392 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.Http2SolrClientTest_CB686202BF07063B-001/tempDir-001/collection1, trusted=true
[junit4] 2> 206393 INFO (coreLoadExecutor-2256-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@74a669d0
[junit4] 2> 206393 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.Http2SolrClientTest_CB686202BF07063B-001/tempDir-001/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.Http2SolrClientTest_CB686202BF07063B-001/tempDir-001/collection1/data/]
[junit4] 2> 206394 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-2256-thread-1]: initDynamicDefaults spins=false maxThreadCount=1 maxMergeCount=6
[junit4] 2> 206394 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-2256-thread-1]: init: current segments file is "segments"; deletionPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper@2bf9cee9
[junit4] 2> 206394 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-2256-thread-1]: now checkpoint "" [0 segments ; isCommit = false]
[junit4] 2> 206394 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-2256-thread-1]: 0 msec to checkpoint
[junit4] 2> 206394 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: init: create=true reader=null
[junit4] 2> 206394 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]:
[junit4] 2> dir=MockDirectoryWrapper(RAMDirectory@5c20632d lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@34a10362)
[junit4] 2> index=
[junit4] 2> version=8.7.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=6, ioThrottle=true
[junit4] 2> codec=Lucene86
[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> 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> maxCommitMergeWaitMillis=0
[junit4] 2> writer=org.apache.solr.update.SolrIndexWriter@1f8fcd72
[junit4] 2>
[junit4] 2> 206394 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: MMapDirectory.UNMAP_SUPPORTED=true
[junit4] 2> 206394 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: now flush at close
[junit4] 2> 206394 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: start flush: applyAllDeletes=true
[junit4] 2> 206394 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: index before flush
[junit4] 2> 206394 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-2256-thread-1]: startFullFlush
[junit4] 2> 206394 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-2256-thread-1]: coreLoadExecutor-2256-thread-1 finishFullFlush success=true
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: now apply all deletes for all segments buffered updates bytesUsed=0 reader pool bytesUsed=0
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-2256-thread-1]: waitApply: no deletes to apply
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-2256-thread-1]: updateMergeThreads ioThrottle=true targetMBPerSec=10240.0 MB/sec
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-2256-thread-1]: now merge
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-2256-thread-1]: index(source):
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-2256-thread-1]: no more merges pending; now return
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: waitForMerges
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: waitForMerges done
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: commit: start
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: commit: enter lock
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: commit: now prepare
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: prepareCommit: flush
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: index before flush
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-2256-thread-1]: startFullFlush
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: now apply all deletes for all segments buffered updates bytesUsed=0 reader pool bytesUsed=0
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-2256-thread-1]: waitApply: no deletes to apply
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-2256-thread-1]: coreLoadExecutor-2256-thread-1 finishFullFlush success=true
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: startCommit(): start
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: startCommit index= changeCount=2
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: startCommit: wrote pending segments file "pending_segments_1"
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: done all syncs: []
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: commit: pendingCommit != null
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: commit: done writing segments file "segments_1"
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-2256-thread-1]: now checkpoint "" [0 segments ; isCommit = true]
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-2256-thread-1]: 0 msec to checkpoint
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: commit: took 0.2 msec
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: commit: done
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: rollback
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: all running merges have aborted
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: rollback: done finish merges
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-2256-thread-1]: abort
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-2256-thread-1]: done abort success=true
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: rollback: infos=
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-2256-thread-1]: now checkpoint "" [0 segments ; isCommit = false]
[junit4] 2> 206395 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-2256-thread-1]: 0 msec to checkpoint
[junit4] 2> 206396 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5
[junit4] 2> 206435 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 206435 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 206436 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: if uncommitted for 15000ms;
[junit4] 2> 206436 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 206437 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-2256-thread-1]: initDynamicDefaults spins=false maxThreadCount=1 maxMergeCount=6
[junit4] 2> 206437 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-2256-thread-1]: init: current segments file is "segments_1"; deletionPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper@2bf9cee9
[junit4] 2> 206437 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-2256-thread-1]: init: load commit "segments_1"
[junit4] 2> 206437 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-2256-thread-1]: now checkpoint "" [0 segments ; isCommit = false]
[junit4] 2> 206437 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-2256-thread-1]: 0 msec to checkpoint
[junit4] 2> 206437 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: init: create=false reader=null
[junit4] 2> 206437 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]:
[junit4] 2> dir=MockDirectoryWrapper(RAMDirectory@5c20632d lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@34a10362)
[junit4] 2> index=
[junit4] 2> version=8.7.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=6, ioThrottle=true
[junit4] 2> codec=Lucene86
[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> 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> maxCommitMergeWaitMillis=0
[junit4] 2> writer=org.apache.solr.update.SolrIndexWriter@31d8544e
[junit4] 2>
[junit4] 2> 206437 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: MMapDirectory.UNMAP_SUPPORTED=true
[junit4] 2> 206437 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: flush at getReader
[junit4] 2> 206437 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-2256-thread-1]: startFullFlush
[junit4] 2> 206437 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: now apply all deletes for all segments buffered updates bytesUsed=0 reader pool bytesUsed=0
[junit4] 2> 206437 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-2256-thread-1]: waitApply: no deletes to apply
[junit4] 2> 206437 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: incRefDeleter for NRT reader version=2 segments=
[junit4] 2> 206437 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: return reader version=2 reader=StandardDirectoryReader(segments_1:2:nrt)
[junit4] 2> 206437 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-2256-thread-1]: coreLoadExecutor-2256-thread-1 finishFullFlush success=true
[junit4] 2> 206437 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-2256-thread-1]: getReader took 0 msec
[junit4] 2> 206438 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.Http2SolrClientTest_CB686202BF07063B-001/tempDir-001/collection1/conf
[junit4] 2> 206438 INFO (coreLoadExecutor-2256-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-Tests-8.x/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.Http2SolrClientTest_CB686202BF07063B-001/tempDir-001/collection1/conf
[junit4] 2> 206438 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.r.ManagedResource Loaded initArgs {} for /rest/managed
[junit4] 2> 206438 INFO (coreLoadExecutor-2256-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-Tests-8.x/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.Http2SolrClientTest_CB686202BF07063B-001/tempDir-001/collection1/conf
[junit4] 2> 206438 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.r.ManagedResource Loaded initArgs {ignoreCase=true} for /schema/analysis/stopwords/english
[junit4] 2> 206438 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.r.s.a.ManagedWordSetResource Loaded 35 words for /schema/analysis/stopwords/english
[junit4] 2> 206438 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.r.ManagedResource Notified 2 observers of /schema/analysis/stopwords/english
[junit4] 2> 206438 INFO (coreLoadExecutor-2256-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-Tests-8.x/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.Http2SolrClientTest_CB686202BF07063B-001/tempDir-001/collection1/conf
[junit4] 2> 206438 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.r.ManagedResource Loaded initArgs {ignoreCase=true,format=solr} for /schema/analysis/synonyms/english
[junit4] 2> 206439 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.r.s.a.ManagedSynonymGraphFilterFactory Loaded 3 synonym mappings for /schema/analysis/synonyms/english
[junit4] 2> 206439 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.r.ManagedResource Notified 2 observers of /schema/analysis/synonyms/english
[junit4] 2> 206439 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 206439 INFO (coreLoadExecutor-2256-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> 206439 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.h.c.SuggestComponent Initializing SuggestComponent
[junit4] 2> 206439 INFO (coreLoadExecutor-2256-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> 206440 INFO (coreLoadExecutor-2256-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> 206440 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.h.c.QueryElevationComponent Loading QueryElevation from: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.Http2SolrClientTest_CB686202BF07063B-001/tempDir-001/collection1/conf/elevate.xml
[junit4] 2> 206443 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 206443 INFO (coreLoadExecutor-2256-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1672229117982932992
[junit4] 2> 206444 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.SolrJettyTestBase Jetty Assigned Port#44133
[junit4] 2> 206445 INFO (searcherExecutor-2258-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> 206445 INFO (searcherExecutor-2258-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 206445 INFO (searcherExecutor-2258-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 206445 INFO (searcherExecutor-2258-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 206448 INFO (searcherExecutor-2258-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 206449 INFO (TEST-Http2SolrClientTest.testGetDefaultSslContextFactory-seed#[CB686202BF07063B]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testGetDefaultSslContextFactory
[junit4] 2> 206449 INFO (TEST-Http2SolrClientTest.testGetDefaultSslContextFactory-seed#[CB686202BF07063B]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testGetDefaultSslContextFactory
[junit4] 2> 206453 INFO (TEST-Http2SolrClientTest.testCollectionParameters-seed#[CB686202BF07063B]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testCollectionParameters
[junit4] 2> 206453 WARN (TEST-Http2SolrClientTest.testCollectionParameters-seed#[CB686202BF07063B]) [ ] 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> 206454 WARN (TEST-Http2SolrClientTest.testCollectionParameters-seed#[CB686202BF07063B]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@180c9881[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 206454 WARN (TEST-Http2SolrClientTest.testCollectionParameters-seed#[CB686202BF07063B]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@180c9881[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 206503 INFO (qtp1026369452-3426) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[collection (1672229118043750400)]} 0 1
[junit4] 2> 206505 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][qtp1026369452-3428]: commit: start
[junit4] 2> 206505 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][qtp1026369452-3428]: commit: enter lock
[junit4] 2> 206505 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][qtp1026369452-3428]: commit: now prepare
[junit4] 2> 206505 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][qtp1026369452-3428]: prepareCommit: flush
[junit4] 2> 206505 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][qtp1026369452-3428]: index before flush
[junit4] 2> 206505 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [DW][qtp1026369452-3428]: startFullFlush
[junit4] 2> 206505 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [DW][qtp1026369452-3428]: anyChanges? numDocsInRam=1 deletes=true hasTickets:false pendingChangesInFullFlush: false
[junit4] 2> 206505 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [BD][qtp1026369452-3428]: compressed 182 to 1040 bytes (571.43%) for deletes/updates; private segment null
[junit4] 2> 206505 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [DWPT][qtp1026369452-3428]: flush postings as segment _0 numDocs=1
[junit4] 2> 206505 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][qtp1026369452-3428]: 0 msec to write norms
[junit4] 2> 206505 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][qtp1026369452-3428]: 0 msec to write docValues
[junit4] 2> 206505 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][qtp1026369452-3428]: 0 msec to write points
[junit4] 2> 206505 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][qtp1026369452-3428]: 0 msec to finish stored fields
[junit4] 2> 206506 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][qtp1026369452-3428]: 0 msec to write postings and finish vectors
[junit4] 2> 206506 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][qtp1026369452-3428]: 0 msec to write fieldInfos
[junit4] 2> 206506 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [DWPT][qtp1026369452-3428]: new segment has 0 deleted docs
[junit4] 2> 206506 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [DWPT][qtp1026369452-3428]: new segment has 0 soft-deleted docs
[junit4] 2> 206506 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [DWPT][qtp1026369452-3428]: new segment has no vectors; no norms; docValues; no prox; freqs
[junit4] 2> 206506 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [DWPT][qtp1026369452-3428]: flushedFiles=[_0_Lucene80_0.dvd, _0.fdm, _0_Lucene84_0.doc, _0_Lucene84_0.tim, _0_Lucene84_0.tip, _0_Lucene84_0.tmd, _0.fdx, _0.fdt, _0_Lucene80_0.dvm, _0.fnm]
[junit4] 2> 206506 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [DWPT][qtp1026369452-3428]: flushed codec=Lucene86
[junit4] 2> 206506 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [DWPT][qtp1026369452-3428]: flushed: segment=_0 ramUsed=0.087 MB newFlushedSize=0.001 MB docs/MB=755.458
[junit4] 2> 206506 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [DWPT][qtp1026369452-3428]: flush time 0.916226 msec
[junit4] 2> 206506 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][qtp1026369452-3428]: publishFlushedSegment seg-private updates=null
[junit4] 2> 206506 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][qtp1026369452-3428]: publishFlushedSegment _0(8.7.0):C1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_252, java.vm.version=25.252-b09, lucene.version=8.7.0, os.arch=amd64, java.runtime.version=1.8.0_252-b09, source=flush, os.version=4.15.0-108-generic, timestamp=1594761961030}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}] :id=cm1veg2rvqpa5r8380sqikq8v
[junit4] 2> 206506 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [BD][qtp1026369452-3428]: push new packet (delGen=1 numDeleteTerms=1 bytesUsed=1040), packetCount=1, bytesUsed=0.001 MB
[junit4] 2> 206506 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [BD][qtp1026369452-3428]: finished packet delGen=2 now completedDelGen=0
[junit4] 2> 206506 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][qtp1026369452-3428]: publish sets newSegment delGen=2 seg=_0(8.7.0):C1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_252, java.vm.version=25.252-b09, lucene.version=8.7.0, os.arch=amd64, java.runtime.version=1.8.0_252-b09, source=flush, os.version=4.15.0-108-generic, timestamp=1594761961030}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}] :id=cm1veg2rvqpa5r8380sqikq8v
[junit4] 2> 206506 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IFD][qtp1026369452-3428]: now checkpoint "_0(8.7.0):C1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_252, java.vm.version=25.252-b09, lucene.version=8.7.0, os.arch=amd64, java.runtime.version=1.8.0_252-b09, source=flush, os.version=4.15.0-108-generic, timestamp=1594761961030}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}] :id=cm1veg2rvqpa5r8380sqikq8w" [1 segments ; isCommit = false]
[junit4] 2> 206506 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IFD][qtp1026369452-3428]: 0 msec to checkpoint
[junit4] 2> 206506 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [BD][qtp1026369452-3428]: packet matches no segments
[junit4] 2> 206506 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [BD][qtp1026369452-3428]: finished packet delGen=1 now completedDelGen=2
[junit4] 2> 206506 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [BD][qtp1026369452-3428]: done apply del packet (org.apache.solr.update.SolrIndexWriter@31d8544e) to 0 segments; 0 new deletes/updates; took 0.000 sec; 0 packets remain
[junit4] 2> 206506 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][qtp1026369452-3428]: now apply all deletes for all segments buffered updates bytesUsed=0 reader pool bytesUsed=0
[junit4] 2> 206506 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [BD][qtp1026369452-3428]: waitApply: no deletes to apply
[junit4] 2> 206506 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [DW][qtp1026369452-3428]: qtp1026369452-3428 finishFullFlush success=true
[junit4] 2> 206506 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][qtp1026369452-3428]: startCommit(): start
[junit4] 2> 206506 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][qtp1026369452-3428]: startCommit index=_0(8.7.0):C1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_252, java.vm.version=25.252-b09, lucene.version=8.7.0, os.arch=amd64, java.runtime.version=1.8.0_252-b09, source=flush, os.version=4.15.0-108-generic, timestamp=1594761961030}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}] :id=cm1veg2rvqpa5r8380sqikq8w changeCount=4
[junit4] 2> 206506 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][qtp1026369452-3428]: startCommit: wrote pending segments file "pending_segments_2"
[junit4] 2> 206506 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][qtp1026369452-3428]: done all syncs: [_0.si, _0_Lucene80_0.dvd, _0.fdm, _0_Lucene84_0.doc, _0_Lucene84_0.tim, _0_Lucene84_0.tip, _0_Lucene84_0.tmd, _0.fdx, _0.fdt, _0_Lucene80_0.dvm, _0.fnm]
[junit4] 2> 206506 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][qtp1026369452-3428]: commit: pendingCommit != null
[junit4] 2> 206506 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][qtp1026369452-3428]: commit: done writing segments file "segments_2"
[junit4] 2> 206506 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IFD][qtp1026369452-3428]: now checkpoint "_0(8.7.0):C1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_252, java.vm.version=25.252-b09, lucene.version=8.7.0, os.arch=amd64, java.runtime.version=1.8.0_252-b09, source=flush, os.version=4.15.0-108-generic, timestamp=1594761961030}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}] :id=cm1veg2rvqpa5r8380sqikq8w" [1 segments ; isCommit = true]
[junit4] 2> 206512 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IFD][qtp1026369452-3428]: deleteCommits: now decRef commit "segments_1"
[junit4] 2> 206512 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IFD][qtp1026369452-3428]: delete [segments_1]
[junit4] 2> 206512 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IFD][qtp1026369452-3428]: 5 msec to checkpoint
[junit4] 2> 206512 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][qtp1026369452-3428]: commit: took 6.8 msec
[junit4] 2> 206512 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][qtp1026369452-3428]: commit: done
[junit4] 2> 206512 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [MP][qtp1026369452-3428]: seg=_0(8.7.0):C1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_252, java.vm.version=25.252-b09, lucene.version=8.7.0, os.arch=amd64, java.runtime.version=1.8.0_252-b09, source=flush, os.version=4.15.0-108-generic, timestamp=1594761961030}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}] :id=cm1veg2rvqpa5r8380sqikq8w size=0.001 MB [floored]
[junit4] 2> 206512 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [MP][qtp1026369452-3428]: findMerges: 1 segments
[junit4] 2> 206512 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [MP][qtp1026369452-3428]: allowedSegmentCount=10 vs count=1 (eligible count=1)
[junit4] 2> 206512 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][qtp1026369452-3428]: nrtIsCurrent: infoVersion matches: false; DW changes: false; BD changes: false
[junit4] 2> 206512 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][qtp1026369452-3428]: flush at getReader
[junit4] 2> 206512 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [DW][qtp1026369452-3428]: startFullFlush
[junit4] 2> 206512 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][qtp1026369452-3428]: now apply all deletes for all segments buffered updates bytesUsed=0 reader pool bytesUsed=0
[junit4] 2> 206512 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [BD][qtp1026369452-3428]: waitApply: no deletes to apply
[junit4] 2> 206513 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][qtp1026369452-3428]: incRefDeleter for NRT reader version=6 segments=_0(8.7.0):C1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_252, java.vm.version=25.252-b09, lucene.version=8.7.0, os.arch=amd64, java.runtime.version=1.8.0_252-b09, source=flush, os.version=4.15.0-108-generic, timestamp=1594761961030}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}] :id=cm1veg2rvqpa5r8380sqikq8w
[junit4] 2> 206513 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][qtp1026369452-3428]: return reader version=6 reader=StandardDirectoryReader(segments_2:6:nrt _0(8.7.0):C1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_252, java.vm.version=25.252-b09, lucene.version=8.7.0, os.arch=amd64, java.runtime.version=1.8.0_252-b09, source=flush, os.version=4.15.0-108-generic, timestamp=1594761961030}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}] :id=cm1veg2rvqpa5r8380sqikq8w)
[junit4] 2> 206513 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [DW][qtp1026369452-3428]: qtp1026369452-3428 finishFullFlush success=true
[junit4] 2> 206513 INFO (qtp1026369452-3428) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][qtp1026369452-3428]: getReader took 1 msec
[junit4] 2> 206513 INFO (searcherExecutor-2258-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 206517 INFO (searcherExecutor-2258-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 206517 INFO (searcherExecutor-2258-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.u.LoggingInfoStream [IW][searcherExecutor-2258-thread-1-processing-x:collection1]: decRefDeleter for NRT reader version=2 segments=
[junit4] 2> 206517 INFO (qtp1026369452-3428) [ 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 12
[junit4] 2> 206519 INFO (qtp1026369452-3424) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=id:collection&wt=javabin&version=2} hits=1 status=0 QTime=0
[junit4] 2> 206524 WARN (TEST-Http2SolrClientTest.testCollectionParameters-seed#[CB686202BF07063B]) [ ] 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> 206526 WARN (TEST-Http2SolrClientTest.testCollectionParameters-seed#[CB686202BF07063B]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@30fccf1a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 206526 WARN (TEST-Http2SolrClientTest.testCollectionParameters-seed#[CB686202BF07063B]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@30fccf1a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 206576 INFO (qtp1026369452-3425) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=id:collection&wt=javabin&version=2} hits=1 status=0 QTime=0
[junit4] 2> 206584 INFO (TEST-Http2SolrClientTest.testCollectionParameters-seed#[CB686202BF07063B]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testCollectionParameters
[junit4] 2> 206589 INFO (TEST-Http2SolrClientTest.testQueryString-seed#[CB686202BF07063B]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testQueryString
[junit4] 2> 206592 WARN (TEST-Http2SolrClientTest.testQueryString-seed#[CB686202BF07063B]) [ ] 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> 206593 WARN (TEST-Http2SolrClientTest.testQueryString-seed#[CB686202BF07063B]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@6718d63e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 206593 WARN (TEST-Http2SolrClientTest.testQueryString-seed#[CB686202BF07063B]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@6718d63e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 206656 INFO (TEST-Http2SolrClientTest.testQueryString-seed#[CB686202BF07063B]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testQueryString
[junit4] 2> 206663 INFO (TEST-Http2SolrClientTest.testSolrExceptionCodeNotFromSolr-seed#[CB686202BF07063B]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testSolrExceptionCodeNotFromSolr
[junit4] 2> 206666 WARN (TEST-Http2SolrClientTest.testSolrExceptionCodeNotFromSolr-seed#[CB686202BF07063B]) [ ] 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> 206675 WARN (TEST-Http2SolrClientTest.testSolrExceptionCodeNotFromSolr-seed#[CB686202BF07063B]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@1c6b6ca1[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 206675 WARN (TEST-Http2SolrClientTest.testSolrExceptionCodeNotFromSolr-seed#[CB686202BF07063B]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@1c6b6ca1[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 206737 INFO (TEST-Http2SolrClientTest.testSolrExceptionCodeNotFromSolr-seed#[CB686202BF07063B]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testSolrExceptionCodeNotFromSolr
[junit4] 2> 206742 INFO (TEST-Http2SolrClientTest.test0IdleTimeout-seed#[CB686202BF07063B]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test0IdleTimeout
[junit4] 2> 206746 WARN (TEST-Http2SolrClientTest.test0IdleTimeout-seed#[CB686202BF07063B]) [ ] 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> 206749 WARN (TEST-Http2SolrClientTest.test0IdleTimeout-seed#[CB686202BF07063B]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@3cbc6f3a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 206749 WARN (TEST-Http2SolrClientTest.test0IdleTimeout-seed#[CB686202BF07063B]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@3cbc6f3a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 206802 INFO (TEST-Http2SolrClientTest.test0IdleTimeout-seed#[CB686202BF07063B]) [ ] o.a.s.SolrTestCaseJ4 ###Ending test0IdleTimeout
[junit4] 2> 206807 INFO (TEST-Http2SolrClientTest.testGetById-seed#[CB686202BF07063B]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testGetById
[junit4] 2> 206808 WARN (TEST-Http2SolrClientTest.testGetById-seed#[CB686202BF07063B]) [ ] 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> 206810 WARN (TEST-Http2SolrClientTest.testGetById-seed#[CB686202BF07063B]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@7a581dfe[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 206810 WARN (TEST-Http2SolrClientTest.testGetById-seed#[CB686202BF07063B]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@7a581dfe[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 206902 INFO (TEST-Http2SolrClientTest.testGetById-seed#[CB686202BF07063B]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testGetById
[junit4] 2> 206906 INFO (TEST-Http2SolrClientTest.testUpdate-seed#[CB686202BF07063B]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testUpdate
[junit4] 2> 206907 WARN (TEST-Http2SolrClientTest.testUpdate-seed#[CB686202BF07063B]) [ ] 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> 206912 WARN (TEST-Http2SolrClientTest.testUpdate-seed#[CB686202BF07063B]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@5662d4bc[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 206912 WARN (TEST-Http2SolrClientTest.testUpdate-seed#[CB686202BF07063B]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@5662d4bc[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 206970 ERROR (h2sc-2269-thread-11) [ ] o.a.s.c.u.ExecutorUtil Uncaught exception java.util.concurrent.RejectedExecutionException: Task java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask@5a993267 rejected from java.util.concurrent.ScheduledThreadPoolExecutor@545ed744[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 0] thrown by thread: h2sc-2269-thread-11
[junit4] 2> => java.lang.Exception: Submitter stack trace
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.execute(ExecutorUtil.java:185)
[junit4] 2> java.lang.Exception: Submitter stack trace
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.execute(ExecutorUtil.java:185) ~[java/:?]
[junit4] 2> at org.eclipse.jetty.util.SocketAddressResolver$Async.resolve(SocketAddressResolver.java:150) ~[jetty-util-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.client.HttpClient.newConnection(HttpClient.java:589) ~[jetty-client-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.client.HttpDestination.createConnection(HttpDestination.java:394) ~[jetty-client-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.client.HttpDestination.newConnection(HttpDestination.java:389) ~[jetty-client-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.client.AbstractConnectionPool.tryCreate(AbstractConnectionPool.java:133) ~[jetty-client-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.client.AbstractConnectionPool.acquire(AbstractConnectionPool.java:105) ~[jetty-client-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.client.HttpDestination.process(HttpDestination.java:320) ~[jetty-client-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.client.HttpDestination.send(HttpDestination.java:313) ~[jetty-client-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.client.HttpDestination.send(HttpDestination.java:288) ~[jetty-client-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.client.HttpDestination.send(HttpDestination.java:265) ~[jetty-client-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.client.HttpClient.send(HttpClient.java:583) ~[jetty-client-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.client.HttpRequest.send(HttpRequest.java:756) ~[jetty-client-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.client.HttpRequest.send(HttpRequest.java:748) ~[jetty-client-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.apache.solr.client.solrj.impl.Http2SolrClient.request(Http2SolrClient.java:428) ~[java/:?]
[junit4] 2> at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1290) ~[java/:?]
[junit4] 2> at org.apache.solr.client.solrj.impl.Http2SolrClientTest.testUpdate(Http2SolrClientTest.java:430) ~[test/:?]
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.8.0_252]
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:1.8.0_252]
[junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_252]
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_252]
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750) ~[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938) ~[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974) ~[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988) ~[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) ~[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) ~[java/:?]
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) ~[java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) ~[java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) ~[java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) ~[java/:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) ~[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) ~[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) ~[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) ~[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947) ~[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832) ~[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883) ~[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894) ~[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) ~[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) ~[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) ~[java/:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) ~[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) ~[java/:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) ~[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) ~[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) ~[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) ~[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) ~[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) ~[java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) ~[java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) ~[java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) ~[java/:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) ~[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) ~[randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at java.lang.Thread.run(Thread.java:748) [?:1.8.0_252]
[junit4] 2> Jul 15, 2020 12:26:01 AM com.carrotsearch.randomizedtesting.RandomizedRunner$QueueUncaughtExceptionsHandler uncaughtException
[junit4] 2> WARNING: Uncaught exception in thread: Thread[h2sc-2269-thread-11,5,TGRP-Http2SolrClientTest]
[junit4] 2> java.util.concurrent.RejectedExecutionException: Task java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask@5a993267 rejected from java.util.concurrent.ScheduledThreadPoolExecutor@545ed744[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 0]
[junit4] 2> at __randomizedtesting.SeedInfo.seed([CB686202BF07063B]:0)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2063)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:830)
[junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor.delayedExecute(ScheduledThreadPoolExecutor.java:326)
[junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor.schedule(ScheduledThreadPoolExecutor.java:533)
[junit4] 2> at org.eclipse.jetty.util.thread.ScheduledExecutorScheduler.schedule(ScheduledExecutorScheduler.java:122)
[junit4] 2> at org.eclipse.jetty.util.SocketAddressResolver$Async.lambda$resolve$1(SocketAddressResolver.java:157)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:212)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2>
[junit4] 2> 206985 WARN (h2sc-2269-thread-14) [ ] o.e.j.i.ManagedSelector java.lang.IllegalStateException: !STARTED: Client@5662d4bc[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 206986 INFO (TEST-Http2SolrClientTest.testUpdate-seed#[CB686202BF07063B]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testUpdate
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=Http2SolrClientTest -Dtests.method=testUpdate -Dtests.seed=CB686202BF07063B -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=ms-MY -Dtests.timezone=Asia/Riyadh -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.09s J2 | Http2SolrClientTest.testUpdate <<<
[junit4] > Throwable #1: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=3542, name=h2sc-2269-thread-11, state=RUNNABLE, group=TGRP-Http2SolrClientTest]
[junit4] > at __randomizedtesting.SeedInfo.seed([CB686202BF07063B:7D7E2708D9C3EEED]:0)
[junit4] > Caused by: java.util.concurrent.RejectedExecutionException: Task java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask@5a993267 rejected from java.util.concurrent.ScheduledThreadPoolExecutor@545ed744[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 0]
[junit4] > at __randomizedtesting.SeedInfo.seed([CB686202BF07063B]:0)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2063)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:830)
[junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor.delayedExecute(ScheduledThreadPoolExecutor.java:326)
[junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor.schedule(ScheduledThreadPoolExecutor.java:533)
[junit4] > at org.eclipse.jetty.util.thread.ScheduledExecutorScheduler.schedule(ScheduledExecutorScheduler.java:122)
[junit4] > at org.eclipse.jetty.util.SocketAddressResolver$Async.lambda$resolve$1(SocketAddressResolver.java:157)
[junit4] > at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:212)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 206993 INFO (TEST-Http2SolrClientTest.testQuery-seed#[CB686202BF07063B]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testQuery
[junit4] 2> 206994 WARN (TEST-Http2SolrClientTest.testQuery-seed#[CB686202BF07063B]) [ ] 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> 206996 WARN (TEST-Http2SolrClientTest.testQuery-seed#[CB686202BF07063B]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@1d6e9e2e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 206996 WARN (TEST-Http2SolrClientTest.testQuery-seed#[CB686202BF07063B]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@1d6e9e2e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 207076 INFO (TEST-Http2SolrClientTest.testQuery-seed#[CB686202BF07063B]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testQuery
[junit4] 2> 207080 INFO (TEST-Http2SolrClientTest.testRedirect-seed#[CB686202BF07063B]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testRedirect
[junit4] 2> 207080 WARN (TEST-Http2SolrClientTest.testRedirect-seed#[CB686202BF07063B]) [ ] 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> 207083 WARN (TEST-Http2SolrClientTest.testRedirect-seed#[CB686202BF07063B]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@480a2dd0[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 207084 WARN (TEST-Http2SolrClientTest.testRedirect-seed#[CB686202BF07063B]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@480a2dd0[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 207129 INFO (qtp1026369452-3426) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=1 status=0 QTime=0
[junit4] 2> 207146 INFO (TEST-Http2SolrClientTest.testRedirect-seed#[CB686202BF07063B]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testRedirect
[junit4] 2> 207150 INFO (TEST-Http2SolrClientTest.testDelete-seed#[CB686202BF07063B]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testDelete
[junit4] 2> 207151 WARN (TEST-Http2SolrClientTest.testDelete-seed#[CB686202BF07063B]) [ ] 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> 207151 WARN (TEST-Http2SolrClientTest.testDelete-seed#[CB686202BF07063B]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@cc4bb32[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 207151 WARN (TEST-Http2SolrClientTest.testDelete-seed#[CB686202BF07063B]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@cc4bb32[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 207213 WARN (h2sc-2272-thread-13) [ ] o.e.j.i.ManagedSelector java.lang.IllegalStateException: !STARTED: Client@cc4bb32[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 207215 INFO (TEST-Http2SolrClientTest.testDelete-seed#[CB686202BF07063B]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testDelete
[junit4] 2> 207219 INFO (TEST-Http2SolrClientTest.testTimeout-seed#[CB686202BF07063B]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testTimeout
[junit4] 2> 207219 WARN (TEST-Http2SolrClientTest.testTimeout-seed#[CB686202BF07063B]) [ ] 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> 207228 WARN (TEST-Http2SolrClientTest.testTimeout-seed#[CB686202BF07063B]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@5e8087ae[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 207228 WARN (TEST-Http2SolrClientTest.testTimeout-seed#[CB686202BF07063B]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@5e8087ae[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 209230 INFO (TEST-Http2SolrClientTest.testTimeout-seed#[CB686202BF07063B]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testTimeout
[junit4] 2> 209232 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=585428677
[junit4] 2> 209232 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@56823c5c
[junit4] 2> 209232 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1 tag=SolrCore@56823c5c
[junit4] 2> 209232 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@15eba852: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1/com.codahale.metrics.MetricRegistry@3ef77037
[junit4] 2> 209257 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() ... SKIPPED (unnecessary).
[junit4] 2> 209257 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-2276-thread-1]: now flush at close
[junit4] 2> 209257 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-2276-thread-1]: start flush: applyAllDeletes=true
[junit4] 2> 209257 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-2276-thread-1]: index before flush _0(8.7.0):C1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_252, java.vm.version=25.252-b09, lucene.version=8.7.0, os.arch=amd64, java.runtime.version=1.8.0_252-b09, source=flush, os.version=4.15.0-108-generic, timestamp=1594761961030}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}] :id=cm1veg2rvqpa5r8380sqikq8w
[junit4] 2> 209257 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-2276-thread-1]: startFullFlush
[junit4] 2> 209257 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-2276-thread-1]: coreCloseExecutor-2276-thread-1 finishFullFlush success=true
[junit4] 2> 209257 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-2276-thread-1]: now apply all deletes for all segments buffered updates bytesUsed=0 reader pool bytesUsed=0
[junit4] 2> 209257 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [BD][coreCloseExecutor-2276-thread-1]: waitApply: no deletes to apply
[junit4] 2> 209257 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-2276-thread-1]: updateMergeThreads ioThrottle=true targetMBPerSec=10240.0 MB/sec
[junit4] 2> 209257 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-2276-thread-1]: now merge
[junit4] 2> 209257 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-2276-thread-1]: index(source): _0(8.7.0):C1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_252, java.vm.version=25.252-b09, lucene.version=8.7.0, os.arch=amd64, java.runtime.version=1.8.0_252-b09, source=flush, os.version=4.15.0-108-generic, timestamp=1594761961030}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}] :id=cm1veg2rvqpa5r8380sqikq8w
[junit4] 2> 209257 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-2276-thread-1]: no more merges pending; now return
[junit4] 2> 209258 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-2276-thread-1]: waitForMerges
[junit4] 2> 209258 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-2276-thread-1]: waitForMerges done
[junit4] 2> 209258 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-2276-thread-1]: commit: start
[junit4] 2> 209258 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-2276-thread-1]: commit: enter lock
[junit4] 2> 209258 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-2276-thread-1]: commit: now prepare
[junit4] 2> 209258 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-2276-thread-1]: prepareCommit: flush
[junit4] 2> 209258 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-2276-thread-1]: index before flush _0(8.7.0):C1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_252, java.vm.version=25.252-b09, lucene.version=8.7.0, os.arch=amd64, java.runtime.version=1.8.0_252-b09, source=flush, os.version=4.15.0-108-generic, timestamp=1594761961030}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}] :id=cm1veg2rvqpa5r8380sqikq8w
[junit4] 2> 209258 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-2276-thread-1]: startFullFlush
[junit4] 2> 209258 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-2276-thread-1]: now apply all deletes for all segments buffered updates bytesUsed=0 reader pool bytesUsed=0
[junit4] 2> 209258 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [BD][coreCloseExecutor-2276-thread-1]: waitApply: no deletes to apply
[junit4] 2> 209258 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-2276-thread-1]: coreCloseExecutor-2276-thread-1 finishFullFlush success=true
[junit4] 2> 209258 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-2276-thread-1]: startCommit(): start
[junit4] 2> 209258 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-2276-thread-1]: skip startCommit(): no changes pending
[junit4] 2> 209258 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-2276-thread-1]: commit: pendingCommit == null; skip
[junit4] 2> 209258 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-2276-thread-1]: commit: took 0.1 msec
[junit4] 2> 209258 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-2276-thread-1]: commit: done
[junit4] 2> 209258 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-2276-thread-1]: rollback
[junit4] 2> 209258 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-2276-thread-1]: all running merges have aborted
[junit4] 2> 209258 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-2276-thread-1]: rollback: done finish merges
[junit4] 2> 209258 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-2276-thread-1]: abort
[junit4] 2> 209258 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-2276-thread-1]: done abort success=true
[junit4] 2> 209258 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-2276-thread-1]: rollback: infos=_0(8.7.0):C1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_252, java.vm.version=25.252-b09, lucene.version=8.7.0, os.arch=amd64, java.runtime.version=1.8.0_252-b09, source=flush, os.version=4.15.0-108-generic, timestamp=1594761961030}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}] :id=cm1veg2rvqpa5r8380sqikq8w
[junit4] 2> 209258 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-2276-thread-1]: now checkpoint "_0(8.7.0):C1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_252, java.vm.version=25.252-b09, lucene.version=8.7.0, os.arch=amd64, java.runtime.version=1.8.0_252-b09, source=flush, os.version=4.15.0-108-generic, timestamp=1594761961030}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}] :id=cm1veg2rvqpa5r8380sqikq8w" [1 segments ; isCommit = false]
[junit4] 2> 209258 INFO (coreCloseExecutor-2276-thread-1) [ ] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-2276-thread-1]: 0 msec to checkpoint
[junit4] 2> 209260 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
[junit4] 2> 209260 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@61ebe43e: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@591a258a
[junit4] 2> 209266 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
[junit4] 2> 209266 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3a503571: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@42b10d39
[junit4] 2> 209269 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
[junit4] 2> 209269 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5d16dcfc: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@13c9ad93
[junit4] 2> 209271 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@2655fb29{SSL, (ssl, http/1.1)}{127.0.0.1:0}
[junit4] 2> 209271 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@3c83afe6{/solr,null,UNAVAILABLE}
[junit4] 2> 209271 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 212292 INFO (SUITE-Http2SolrClientTest-seed#[CB686202BF07063B]-worker) [ ] o.a.s.SolrTestCaseJ4 ------------------------------------------------------- Done waiting for tracked resources to be released
[junit4] 2> NOTE: test params are: codec=DummyCompressingStoredFieldsData(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=DUMMY, chunkSize=8, maxDocsPerChunk=4, blockShift=13), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=DUMMY, chunkSize=8, blockSize=13)), sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=ms-MY, timezone=Asia/Riyadh
[junit4] 2> NOTE: Linux 4.15.0-108-generic amd64/Oracle Corporation 1.8.0_252 (64-bit)/cpus=4,threads=1,free=213607680,total=512229376
[junit4] 2> NOTE: All tests run in this JVM: [GraphTest, LargeVolumeJettyTest, CloudHttp2SolrClientRetryTest, NoOpResponseParserTest, TestHash, TestSuggesterResponse, TermsFacetMapTest, OrEvaluatorTest, SchemaTest, TestJSONParser, TestPolicy2, ConcurrentUpdateHttp2SolrClientMultiCollectionTest, CloudHttp2SolrClientBadInputTest, Http2SolrClientCompatibilityTest, RecursiveEvaluatorTest, TestNamedListCodec, JsonQueryRequestUnitTest, CeilingEvaluatorTest, TestSolrJsonWriter, TestXMLEscaping, TestLBHttpSolrClient, LengthEvaluatorTest, RequestReplicaListTransformerGeneratorTest, TestCloudSolrClientConnections, CloudAuthStreamTest, HttpSolrClientBadInputTest, AbsoluteValueEvaluatorTest, FloorEvaluatorTest, StreamExpressionParserTest, DirectJsonQueryRequestFacetingIntegrationTest, CorrelationEvaluatorTest, EqualToEvaluatorTest, RoundEvaluatorTest, SolrExampleJettyTest, ConcurrentUpdateHttp2SolrClientBadInputTest, ConcurrentUpdateSolrClientBuilderTest, ConcurrentUpdateSolrClientMultiCollectionTest, ConcurrentUpdateSolrClientTest, Http2SolrClientTest]
[junit4] Completed [135/209 (1!)] on J2 in 6.77s, 11 tests, 1 error <<< FAILURES!
[...truncated 51177 lines...]