Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.0-Linux/252/ Java: 64bit/jdk-12-ea+shipilev-fastdebug -XX:+UseCompressedOops -XX:+UseParallelGC
2 tests failed. FAILED: org.apache.solr.client.solrj.TestLBHttp2SolrClient.testTwoServers Error Message: Timeout occured while waiting response from server at: http://127.0.0.1:43267/solr/collection1/select?q=*%3A*&wt=javabin&version=2 Stack Trace: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:43267/solr/collection1/select?q=*%3A*&wt=javabin&version=2 at __randomizedtesting.SeedInfo.seed([2E4C4718E24A8AE4:8EA6E9953901A4C4]:0) at org.apache.solr.client.solrj.impl.Http2SolrClient.request(Http2SolrClient.java:399) at org.apache.solr.client.solrj.impl.Http2SolrClient.request(Http2SolrClient.java:731) at org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:605) at org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:581) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:207) at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:987) at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1002) at org.apache.solr.client.solrj.TestLBHttp2SolrClient.testTwoServers(TestLBHttp2SolrClient.java:186) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:567) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.base/java.lang.Thread.run(Thread.java:835) Caused by: java.util.concurrent.TimeoutException at org.eclipse.jetty.client.util.InputStreamResponseListener.get(InputStreamResponseListener.java:216) at org.apache.solr.client.solrj.impl.Http2SolrClient.request(Http2SolrClient.java:390) ... 45 more FAILED: org.apache.solr.security.TestPKIAuthenticationPlugin.test Error Message: Stack Trace: java.lang.AssertionError at __randomizedtesting.SeedInfo.seed([CAD557123110C108:428168C89FECACF0]:0) at org.junit.Assert.fail(Assert.java:86) at org.junit.Assert.assertTrue(Assert.java:41) at org.junit.Assert.assertNotNull(Assert.java:712) at org.junit.Assert.assertNotNull(Assert.java:722) at org.apache.solr.security.TestPKIAuthenticationPlugin.test(TestPKIAuthenticationPlugin.java:99) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:567) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.base/java.lang.Thread.run(Thread.java:835) Build Log: [...truncated 13083 lines...] [junit4] Suite: org.apache.solr.security.TestPKIAuthenticationPlugin [junit4] 2> 456893 INFO (SUITE-TestPKIAuthenticationPlugin-seed#[CAD557123110C108]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-core/test/J2/temp/solr.security.TestPKIAuthenticationPlugin_CAD557123110C108-001/init-core-data-001 [junit4] 2> 456894 INFO (SUITE-TestPKIAuthenticationPlugin-seed#[CAD557123110C108]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false [junit4] 2> 456894 INFO (SUITE-TestPKIAuthenticationPlugin-seed#[CAD557123110C108]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, clientAuth=0.0/0.0) [junit4] 2> 456897 INFO (TEST-TestPKIAuthenticationPlugin.test-seed#[CAD557123110C108]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test [junit4] 2> 476297 ERROR (TEST-TestPKIAuthenticationPlugin.test-seed#[CAD557123110C108]) [ ] o.a.s.s.PKIAuthenticationPlugin Invalid key request timestamp: 1552147100421 , received timestamp: 1552147119178 , TTL: 15000 [junit4] 2> 476298 INFO (TEST-TestPKIAuthenticationPlugin.test-seed#[CAD557123110C108]) [ ] o.a.s.SolrTestCaseJ4 ###Ending test [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestPKIAuthenticationPlugin -Dtests.method=test -Dtests.seed=CAD557123110C108 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=om-KE -Dtests.timezone=Indian/Mayotte -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] FAILURE 19.4s J2 | TestPKIAuthenticationPlugin.test <<< [junit4] > Throwable #1: java.lang.AssertionError [junit4] > at __randomizedtesting.SeedInfo.seed([CAD557123110C108:428168C89FECACF0]:0) [junit4] > at org.apache.solr.security.TestPKIAuthenticationPlugin.test(TestPKIAuthenticationPlugin.java:99) [junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] > at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] > at java.base/java.lang.reflect.Method.invoke(Method.java:567) [junit4] > at java.base/java.lang.Thread.run(Thread.java:835) [junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-core/test/J2/temp/solr.security.TestPKIAuthenticationPlugin_CAD557123110C108-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene80), sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@46e93233), locale=om-KE, timezone=Indian/Mayotte [junit4] 2> NOTE: Linux 4.18.0-15-generic amd64/Aleksey Shipilev 12-testing (64-bit)/cpus=8,threads=1,free=112413856,total=519569408 [junit4] 2> NOTE: All tests run in this JVM: [DistributedQueryComponentOptimizationTest, BigEndianAscendingWordDeserializerTest, ChaosMonkeyNothingIsSafeWithPullReplicasTest, Tagger2Test, CustomTermsComponentTest, TestJavabinTupleStreamParser, TestLuceneIndexBackCompat, DistributedSuggestComponentTest, PrimitiveFieldTypeTest, UtilsToolTest, ConvertedLegacyTest, SimpleFacetsTest, TestTestInjection, StatsReloadRaceTest, TestDefaultStatsCache, HdfsSyncSliceTest, JvmMetricsTest, TestConfigReload, TestFaceting, SolrTestCaseJ4Test, GraphQueryTest, SignatureUpdateProcessorFactoryTest, TestReloadAndDeleteDocs, TestCloudSearcherWarming, DistributedIntervalFacetingTest, TestManagedResource, TermVectorComponentDistributedTest, TestManagedSchemaAPI, ByteBuffersDirectoryFactoryTest, SolrIndexSplitterTest, IndexSchemaRuntimeFieldTest, CopyFieldTest, SmileWriterTest, HdfsLockFactoryTest, HLLUtilTest, TestManagedSynonymFilterFactory, TestCoreDiscovery, NotRequiredUniqueKeyTest, TestSimTriggerIntegration, DocValuesNotIndexedTest, TestDistributedGrouping, TestSolrCloudWithKerberosAlt, TestDirectoryFactory, TestPKIAuthenticationPlugin] [junit4] Completed [113/839 (1!)] on J2 in 19.54s, 1 test, 1 failure <<< FAILURES! [...truncated 3041 lines...] [junit4] Suite: org.apache.solr.client.solrj.TestLBHttp2SolrClient [junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/init-core-data-001 [junit4] 2> 10122 INFO (SUITE-TestLBHttp2SolrClient-seed#[2E4C4718E24A8AE4]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true [junit4] 2> 10294 INFO (SUITE-TestLBHttp2SolrClient-seed#[2E4C4718E24A8AE4]-worker) [ ] o.e.j.u.log Logging initialized @10513ms to org.eclipse.jetty.util.log.Slf4jLog [junit4] 2> 10345 INFO (SUITE-TestLBHttp2SolrClient-seed#[2E4C4718E24A8AE4]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, clientAuth=0.0/0.0) [junit4] 2> 10420 INFO (SUITE-TestLBHttp2SolrClient-seed#[2E4C4718E24A8AE4]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> 10434 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testTwoServers [junit4] 2> 12059 WARN (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@3a723624[provider=null,keyStore=null,trustStore=null] [junit4] 2> 12331 WARN (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 12643 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 12653 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 12669 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 12-testing+0-builds.shipilev.net-openjdk-jdk12-b109-20190215-jdk-1229 [junit4] 2> 12703 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 12703 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 12708 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 12768 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5a62d53f{/solr,null,AVAILABLE} [junit4] 2> 12821 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@60310156{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:41953} [junit4] 2> 12822 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.Server Started @13051ms [junit4] 2> 12822 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, solrconfig=bad_solrconfig.xml, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-0-001/collection1/data, hostPort=41953} [junit4] 2> 12953 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.u.c.SSLCredentialProviderFactory Processing SSL Credential Provider chain: env;sysprop [junit4] 2> 13067 ERROR (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 13067 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 13068 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.0.0 [junit4] 2> 13069 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 13070 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 13070 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-03-09T16:40:51.755806Z [junit4] 2> 13277 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 13291 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-0-001/solr.xml [junit4] 2> 13774 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@3c1a29ec, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 14897 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 14902 WARN (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@7a0f4f31[provider=null,keyStore=null,trustStore=null] [junit4] 2> 15549 WARN (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@1fab906e[provider=null,keyStore=null,trustStore=null] [junit4] 2> 16656 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 16659 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 17044 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3c1a29ec [junit4] 2> 17049 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3c1a29ec [junit4] 2> 17050 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3c1a29ec [junit4] 2> 17298 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-0-001/. [junit4] 2> 17325 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 17493 INFO (coreLoadExecutor-9-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 17778 INFO (coreLoadExecutor-9-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 18029 INFO (coreLoadExecutor-9-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id [junit4] 2> 18031 INFO (coreLoadExecutor-9-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-0-001/./collection1, trusted=true [junit4] 2> 18241 INFO (coreLoadExecutor-9-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@3c1a29ec [junit4] 2> 18283 INFO (coreLoadExecutor-9-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-0-001/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-0-001/./collection1/data/] [junit4] 2> 21483 INFO (coreLoadExecutor-9-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 21483 INFO (coreLoadExecutor-9-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 21571 INFO (coreLoadExecutor-9-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@271b50b7[collection1] main] [junit4] 2> 21635 INFO (coreLoadExecutor-9-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-0-001/collection1/conf [junit4] 2> 21785 INFO (coreLoadExecutor-9-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 21847 INFO (searcherExecutor-10-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@271b50b7[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 24755 INFO (qtp1284383135-30) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[0, 1, 2, 3, 4, 5, 6, 7, 8, 9]} 0 828 [junit4] 2> 25035 INFO (qtp1284383135-31) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 25035 INFO (qtp1284383135-31) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@64c2a261 commitCommandVersion:0 [junit4] 2> 25995 INFO (qtp1284383135-31) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@51840cc2[collection1] main] [junit4] 2> 26035 INFO (qtp1284383135-31) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 26056 INFO (searcherExecutor-10-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@51840cc2[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):c10:[diagnostics={os=Linux, java.vendor=Aleksey Shipilev, java.version=12-testing, java.vm.version=12-testing+0-builds.shipilev.net-openjdk-jdk12-b109-20190215-jdk-1229, lucene.version=8.0.0, os.arch=amd64, java.runtime.version=12-testing+0-builds.shipilev.net-openjdk-jdk12-b109-20190215-jdk-1229, source=flush, os.version=4.18.0-15-generic, timestamp=1552149664293}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))} [junit4] 2> 26125 INFO (qtp1284383135-31) [ 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 1094 [junit4] 2> 26137 WARN (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 26138 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 26138 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 26139 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 12-testing+0-builds.shipilev.net-openjdk-jdk12-b109-20190215-jdk-1229 [junit4] 2> 26212 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 26213 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 26213 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 26219 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5845d0de{/solr,null,AVAILABLE} [junit4] 2> 26237 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@75c349c3{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:43267} [junit4] 2> 26237 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.Server Started @26466ms [junit4] 2> 26237 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, solrconfig=bad_solrconfig.xml, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-1-001/collection1/data, hostPort=43267} [junit4] 2> 26238 ERROR (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 26239 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 26239 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.0.0 [junit4] 2> 26239 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 26240 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 26240 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-03-09T16:41:04.925521Z [junit4] 2> 26241 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-1-001/solr.xml [junit4] 2> 26330 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@3c1a29ec, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 26606 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 26628 WARN (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@af7c5dc[provider=null,keyStore=null,trustStore=null] [junit4] 2> 26669 WARN (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@372a50ef[provider=null,keyStore=null,trustStore=null] [junit4] 2> 26746 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 26747 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 26801 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3c1a29ec [junit4] 2> 26869 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3c1a29ec [junit4] 2> 26869 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3c1a29ec [junit4] 2> 26892 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-1-001/. [junit4] 2> 26892 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 27008 INFO (coreLoadExecutor-22-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 27114 INFO (coreLoadExecutor-22-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 27129 INFO (coreLoadExecutor-22-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id [junit4] 2> 27130 INFO (coreLoadExecutor-22-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-1-001/./collection1, trusted=true [junit4] 2> 27158 INFO (coreLoadExecutor-22-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@3c1a29ec [junit4] 2> 27158 INFO (coreLoadExecutor-22-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-1-001/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-1-001/./collection1/data/] [junit4] 2> 27483 INFO (coreLoadExecutor-22-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 27483 INFO (coreLoadExecutor-22-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 27488 INFO (coreLoadExecutor-22-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@62919e3[collection1] main] [junit4] 2> 27489 INFO (coreLoadExecutor-22-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-1-001/collection1/conf [junit4] 2> 27491 INFO (coreLoadExecutor-22-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 27496 INFO (searcherExecutor-23-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@62919e3[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 28012 INFO (qtp321680511-52) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[0, 1, 2, 3, 4, 5, 6, 7, 8, 9]} 0 5 [junit4] 2> 28015 INFO (qtp321680511-53) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 28016 INFO (qtp321680511-53) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5c152055 commitCommandVersion:0 [junit4] 2> 28237 INFO (qtp321680511-53) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6904c266[collection1] main] [junit4] 2> 28254 INFO (searcherExecutor-23-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6904c266[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):c10:[diagnostics={os=Linux, java.vendor=Aleksey Shipilev, java.version=12-testing, java.vm.version=12-testing+0-builds.shipilev.net-openjdk-jdk12-b109-20190215-jdk-1229, lucene.version=8.0.0, os.arch=amd64, java.runtime.version=12-testing+0-builds.shipilev.net-openjdk-jdk12-b109-20190215-jdk-1229, source=flush, os.version=4.18.0-15-generic, timestamp=1552149666707}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))} [junit4] 2> 28270 INFO (qtp321680511-53) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 28270 INFO (qtp321680511-53) [ 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 255 [junit4] 2> 28277 WARN (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 28283 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 28283 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 28283 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 12-testing+0-builds.shipilev.net-openjdk-jdk12-b109-20190215-jdk-1229 [junit4] 2> 28350 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 28350 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 28350 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 28378 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@153351d1{/solr,null,AVAILABLE} [junit4] 2> 28394 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@3e45b5fd{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:46547} [junit4] 2> 28394 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.Server Started @28623ms [junit4] 2> 28394 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, solrconfig=bad_solrconfig.xml, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-2-001/collection1/data, hostPort=46547} [junit4] 2> 28395 ERROR (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 28395 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 28396 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.0.0 [junit4] 2> 28396 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 28396 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 28397 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-03-09T16:41:07.082016Z [junit4] 2> 28397 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-2-001/solr.xml [junit4] 2> 28417 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@3c1a29ec, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 28655 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 28690 WARN (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@1234cbd1[provider=null,keyStore=null,trustStore=null] [junit4] 2> 28763 WARN (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@37276970[provider=null,keyStore=null,trustStore=null] [junit4] 2> 28818 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 28819 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 28896 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3c1a29ec [junit4] 2> 28964 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3c1a29ec [junit4] 2> 28965 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3c1a29ec [junit4] 2> 28972 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-2-001/. [junit4] 2> 28972 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 28999 INFO (coreLoadExecutor-35-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 29162 INFO (coreLoadExecutor-35-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 29236 INFO (coreLoadExecutor-35-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id [junit4] 2> 29236 INFO (coreLoadExecutor-35-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-2-001/./collection1, trusted=true [junit4] 2> 29237 INFO (coreLoadExecutor-35-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@3c1a29ec [junit4] 2> 29250 INFO (coreLoadExecutor-35-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-2-001/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-2-001/./collection1/data/] [junit4] 2> 29658 INFO (coreLoadExecutor-35-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 29658 INFO (coreLoadExecutor-35-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 29663 INFO (coreLoadExecutor-35-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@2267ea2a[collection1] main] [junit4] 2> 29663 INFO (coreLoadExecutor-35-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-2-001/collection1/conf [junit4] 2> 29665 INFO (coreLoadExecutor-35-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 29668 INFO (searcherExecutor-36-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2267ea2a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 30217 INFO (qtp1383975552-74) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[0, 1, 2, 3, 4, 5, 6, 7, 8, 9]} 0 8 [junit4] 2> 30220 INFO (qtp1383975552-74) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 30221 INFO (qtp1383975552-74) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4596c22b commitCommandVersion:0 [junit4] 2> 30501 INFO (qtp1383975552-74) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@66af732f[collection1] main] [junit4] 2> 30512 INFO (searcherExecutor-36-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@66af732f[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):c10:[diagnostics={os=Linux, java.vendor=Aleksey Shipilev, java.version=12-testing, java.vm.version=12-testing+0-builds.shipilev.net-openjdk-jdk12-b109-20190215-jdk-1229, lucene.version=8.0.0, os.arch=amd64, java.runtime.version=12-testing+0-builds.shipilev.net-openjdk-jdk12-b109-20190215-jdk-1229, source=flush, os.version=4.18.0-15-generic, timestamp=1552149668927}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))} [junit4] 2> 30514 INFO (qtp1383975552-74) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 30528 INFO (qtp1383975552-74) [ 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 308 [junit4] 2> 30547 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=430404807 [junit4] 2> 30565 INFO (coreCloseExecutor-40-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@170d3b66 [junit4] 2> 30565 INFO (coreCloseExecutor-40-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=170d3b66 [junit4] 2> 30600 INFO (coreCloseExecutor-40-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@793346ca: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@2d9cfef7 [junit4] 2> 31156 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 31157 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@643f2e49: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@22946bbd [junit4] 2> 31200 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 31201 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@121886ff: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@546c2dde [junit4] 2> 31208 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 31208 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@60c22519: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@765a8ff3 [junit4] 2> 31495 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@60310156{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0} [junit4] 2> 31535 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@5a62d53f{/solr,null,UNAVAILABLE} [junit4] 2> 31536 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.session node0 Stopped scavenging [junit4] 2> 34080 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=323656370 [junit4] 2> 34114 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 34114 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5f87130f: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@bef66c8 [junit4] 2> 34125 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 34125 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5a83091d: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@546c2dde [junit4] 2> 34212 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 34212 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3dfda176: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@765a8ff3 [junit4] 2> 34235 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@75c349c3{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0} [junit4] 2> 34235 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@5845d0de{/solr,null,UNAVAILABLE} [junit4] 2> 34236 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.session node0 Stopped scavenging [junit4] 2> 34463 INFO (qtp321680511-52) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=10 status=0 QTime=687 [junit4] 2> 34797 INFO (qtp321680511-52) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@56598688 [junit4] 2> 34797 INFO (qtp321680511-52) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=56598688 [junit4] 2> 34797 INFO (qtp321680511-52) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3cce348f: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@7ae73642 [junit4] 2> 34900 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=866439371 [junit4] 2> 34916 INFO (coreCloseExecutor-44-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@48643566 [junit4] 2> 34917 INFO (coreCloseExecutor-44-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=48643566 [junit4] 2> 34917 INFO (coreCloseExecutor-44-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@51bc4067: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@763b08e1 [junit4] 2> 35123 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 35124 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5f39dd66: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@2dc6ba7f [junit4] 2> 35146 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 35146 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4fe362b7: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@546c2dde [junit4] 2> 35172 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 35176 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@771c21da: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@765a8ff3 [junit4] 2> 35191 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@3e45b5fd{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0} [junit4] 2> 35191 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@153351d1{/solr,null,UNAVAILABLE} [junit4] 2> 35192 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.session node0 Stopped scavenging [junit4] 2> 35220 INFO (TEST-TestLBHttp2SolrClient.testTwoServers-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testTwoServers [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestLBHttp2SolrClient -Dtests.method=testTwoServers -Dtests.seed=2E4C4718E24A8AE4 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=sr-Cyrl-BA -Dtests.timezone=Asia/Novokuznetsk -Dtests.asserts=true -Dtests.file.encoding=US-ASCII [junit4] ERROR 24.9s J1 | TestLBHttp2SolrClient.testTwoServers <<< [junit4] > Throwable #1: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:43267/solr/collection1/select?q=*%3A*&wt=javabin&version=2 [junit4] > at __randomizedtesting.SeedInfo.seed([2E4C4718E24A8AE4:8EA6E9953901A4C4]:0) [junit4] > at org.apache.solr.client.solrj.impl.Http2SolrClient.request(Http2SolrClient.java:399) [junit4] > at org.apache.solr.client.solrj.impl.Http2SolrClient.request(Http2SolrClient.java:731) [junit4] > at org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:605) [junit4] > at org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:581) [junit4] > at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:207) [junit4] > at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:987) [junit4] > at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1002) [junit4] > at org.apache.solr.client.solrj.TestLBHttp2SolrClient.testTwoServers(TestLBHttp2SolrClient.java:186) [junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] > at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] > at java.base/java.lang.reflect.Method.invoke(Method.java:567) [junit4] > at java.base/java.lang.Thread.run(Thread.java:835) [junit4] > Caused by: java.util.concurrent.TimeoutException [junit4] > at org.eclipse.jetty.client.util.InputStreamResponseListener.get(InputStreamResponseListener.java:216) [junit4] > at org.apache.solr.client.solrj.impl.Http2SolrClient.request(Http2SolrClient.java:390) [junit4] > ... 45 more [junit4] 2> 35298 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testSimple [junit4] 2> 35330 WARN (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@5a6f80dd[provider=null,keyStore=null,trustStore=null] [junit4] 2> 35338 WARN (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 35354 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 35355 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 35355 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 12-testing+0-builds.shipilev.net-openjdk-jdk12-b109-20190215-jdk-1229 [junit4] 2> 35421 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 35421 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 35422 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 35424 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3d72e795{/solr,null,AVAILABLE} [junit4] 2> 35459 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@2a0000e9{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:37903} [junit4] 2> 35459 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.Server Started @35688ms [junit4] 2> 35459 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, solrconfig=bad_solrconfig.xml, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-0-001/collection1/data, hostPort=37903} [junit4] 2> 35460 ERROR (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 35461 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 35461 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.0.0 [junit4] 2> 35461 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 35461 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 35462 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-03-09T16:41:14.146987Z [junit4] 2> 35462 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-0-001/solr.xml [junit4] 2> 35489 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@3c1a29ec, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 35753 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 35781 WARN (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@69e2a986[provider=null,keyStore=null,trustStore=null] [junit4] 2> 35851 WARN (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@75d14e69[provider=null,keyStore=null,trustStore=null] [junit4] 2> 35934 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 35934 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 36044 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3c1a29ec [junit4] 2> 36120 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3c1a29ec [junit4] 2> 36121 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3c1a29ec [junit4] 2> 36162 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-0-001/. [junit4] 2> 36163 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 36211 INFO (coreLoadExecutor-54-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 36232 INFO (coreLoadExecutor-54-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 36237 INFO (coreLoadExecutor-54-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id [junit4] 2> 36237 INFO (coreLoadExecutor-54-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-0-001/./collection1, trusted=true [junit4] 2> 36242 INFO (coreLoadExecutor-54-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@3c1a29ec [junit4] 2> 36242 INFO (coreLoadExecutor-54-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-0-001/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-0-001/./collection1/data/] [junit4] 2> 36596 INFO (coreLoadExecutor-54-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 36596 INFO (coreLoadExecutor-54-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 36601 INFO (coreLoadExecutor-54-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6719f083[collection1] main] [junit4] 2> 36602 INFO (coreLoadExecutor-54-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-0-001/collection1/conf [junit4] 2> 36603 INFO (coreLoadExecutor-54-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 36605 INFO (searcherExecutor-55-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6719f083[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 36638 INFO (qtp1460211798-120) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[0, 1, 2, 3, 4, 5, 6, 7, 8, 9]} 0 9 [junit4] 2> 36642 INFO (qtp1460211798-120) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 36642 INFO (qtp1460211798-120) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@447b8f72 commitCommandVersion:0 [junit4] 2> 36736 INFO (qtp1460211798-120) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@db0df38[collection1] main] [junit4] 2> 36738 INFO (qtp1460211798-120) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 36745 INFO (searcherExecutor-55-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@db0df38[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):c10:[diagnostics={os=Linux, java.vendor=Aleksey Shipilev, java.version=12-testing, java.vm.version=12-testing+0-builds.shipilev.net-openjdk-jdk12-b109-20190215-jdk-1229, lucene.version=8.0.0, os.arch=amd64, java.runtime.version=12-testing+0-builds.shipilev.net-openjdk-jdk12-b109-20190215-jdk-1229, source=flush, os.version=4.18.0-15-generic, timestamp=1552149675342}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))} [junit4] 2> 36745 INFO (qtp1460211798-120) [ 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 104 [junit4] 2> 36750 WARN (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 36751 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 36751 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 36752 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 12-testing+0-builds.shipilev.net-openjdk-jdk12-b109-20190215-jdk-1229 [junit4] 2> 36870 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 36870 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 36870 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 36875 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2c039e88{/solr,null,AVAILABLE} [junit4] 2> 36881 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@46714437{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:46759} [junit4] 2> 36881 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.Server Started @37110ms [junit4] 2> 36881 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, solrconfig=bad_solrconfig.xml, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-1-001/collection1/data, hostPort=46759} [junit4] 2> 36882 ERROR (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 36882 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 36883 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.0.0 [junit4] 2> 36883 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 36883 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 36883 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-03-09T16:41:15.568686Z [junit4] 2> 36884 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-1-001/solr.xml [junit4] 2> 36915 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@3c1a29ec, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 37586 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 37607 WARN (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@6b67aa7[provider=null,keyStore=null,trustStore=null] [junit4] 2> 37647 WARN (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@39499ff8[provider=null,keyStore=null,trustStore=null] [junit4] 2> 37688 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 37689 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 37853 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3c1a29ec [junit4] 2> 38049 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3c1a29ec [junit4] 2> 38050 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3c1a29ec [junit4] 2> 38071 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-1-001/. [junit4] 2> 38072 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 38151 INFO (coreLoadExecutor-67-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 38221 INFO (coreLoadExecutor-67-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 38246 INFO (coreLoadExecutor-67-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id [junit4] 2> 38246 INFO (coreLoadExecutor-67-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-1-001/./collection1, trusted=true [junit4] 2> 38260 INFO (coreLoadExecutor-67-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@3c1a29ec [junit4] 2> 38261 INFO (coreLoadExecutor-67-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-1-001/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-1-001/./collection1/data/] [junit4] 2> 38565 INFO (coreLoadExecutor-67-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 38565 INFO (coreLoadExecutor-67-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 38569 INFO (coreLoadExecutor-67-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@7beedcfd[collection1] main] [junit4] 2> 38570 INFO (coreLoadExecutor-67-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-1-001/collection1/conf [junit4] 2> 38572 INFO (coreLoadExecutor-67-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 38575 INFO (searcherExecutor-68-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7beedcfd[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 39112 INFO (qtp304611549-143) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[0, 1, 2, 3, 4, 5, 6, 7, 8, 9]} 0 12 [junit4] 2> 39115 INFO (qtp304611549-141) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 39115 INFO (qtp304611549-141) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@7e8bf7c1 commitCommandVersion:0 [junit4] 2> 39299 INFO (qtp304611549-141) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@25fa4225[collection1] main] [junit4] 2> 39300 INFO (qtp304611549-141) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 39303 INFO (searcherExecutor-68-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@25fa4225[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):c10:[diagnostics={os=Linux, java.vendor=Aleksey Shipilev, java.version=12-testing, java.vm.version=12-testing+0-builds.shipilev.net-openjdk-jdk12-b109-20190215-jdk-1229, lucene.version=8.0.0, os.arch=amd64, java.runtime.version=12-testing+0-builds.shipilev.net-openjdk-jdk12-b109-20190215-jdk-1229, source=flush, os.version=4.18.0-15-generic, timestamp=1552149677813}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))} [junit4] 2> 39303 INFO (qtp304611549-141) [ 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 189 [junit4] 2> 39324 WARN (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 39325 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 39325 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 39325 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 12-testing+0-builds.shipilev.net-openjdk-jdk12-b109-20190215-jdk-1229 [junit4] 2> 39390 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 39390 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 39390 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 39394 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@42f98ad9{/solr,null,AVAILABLE} [junit4] 2> 39406 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@2b646c66{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:36455} [junit4] 2> 39407 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.Server Started @39636ms [junit4] 2> 39407 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, solrconfig=bad_solrconfig.xml, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-2-001/collection1/data, hostPort=36455} [junit4] 2> 39408 ERROR (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 39408 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 39408 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.0.0 [junit4] 2> 39408 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 39408 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 39409 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-03-09T16:41:18.093973Z [junit4] 2> 39409 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-2-001/solr.xml [junit4] 2> 39436 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@3c1a29ec, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 39494 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 39511 WARN (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@1fe39d7e[provider=null,keyStore=null,trustStore=null] [junit4] 2> 39539 WARN (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@193fe6ca[provider=null,keyStore=null,trustStore=null] [junit4] 2> 39584 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 39584 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 39630 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3c1a29ec [junit4] 2> 39670 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3c1a29ec [junit4] 2> 39671 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3c1a29ec [junit4] 2> 39675 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-2-001/. [junit4] 2> 39676 INFO (TEST-TestLBHttp2SolrClient.testSimple-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 39734 INFO (coreLoadExecutor-80-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 39808 INFO (coreLoadExecutor-80-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 39813 INFO (coreLoadExecutor-80-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id [junit4] 2> 39813 INFO (coreLoadExecutor-80-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-2-001/./collection1, trusted=true [junit4] 2> 39814 INFO (coreLoadExecutor-80-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@3c1a29ec [junit4] 2> 39814 INFO (coreLoadExecutor-80-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-2-001/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001/instance-2-001/./collection1/data/] [junit4] 2> 40120 INFO (coreLoadExecutor-80-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 40120 INFO (coreLoadExecutor-80-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 40125 INFO (coreLoadExecutor-80-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@3fc4899b[collect [...truncated too long message...] TEST-TestLBHttp2SolrClient.testReliability-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4d5267d7: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@765a8ff3 [junit4] 2> 53768 INFO (TEST-TestLBHttp2SolrClient.testReliability-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@179eecf1{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0} [junit4] 2> 53769 INFO (TEST-TestLBHttp2SolrClient.testReliability-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@23315563{/solr,null,UNAVAILABLE} [junit4] 2> 53769 INFO (TEST-TestLBHttp2SolrClient.testReliability-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.session node0 Stopped scavenging [junit4] 2> 53774 INFO (TEST-TestLBHttp2SolrClient.testReliability-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=703228655 [junit4] 2> 53782 INFO (coreCloseExecutor-162-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@2f1b2241 [junit4] 2> 53782 INFO (coreCloseExecutor-162-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=2f1b2241 [junit4] 2> 53786 INFO (coreCloseExecutor-162-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@29fda13c: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@6c7faf69 [junit4] 2> 53958 INFO (TEST-TestLBHttp2SolrClient.testReliability-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 53958 INFO (TEST-TestLBHttp2SolrClient.testReliability-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@37edde7b: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@6cb72633 [junit4] 2> 53981 INFO (TEST-TestLBHttp2SolrClient.testReliability-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 53981 INFO (TEST-TestLBHttp2SolrClient.testReliability-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6aca94f: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@546c2dde [junit4] 2> 53999 INFO (TEST-TestLBHttp2SolrClient.testReliability-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 53999 INFO (TEST-TestLBHttp2SolrClient.testReliability-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@665b6331: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@765a8ff3 [junit4] 2> 54062 INFO (TEST-TestLBHttp2SolrClient.testReliability-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@5aca257d{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:33419} [junit4] 2> 54062 INFO (TEST-TestLBHttp2SolrClient.testReliability-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@cfbc63f{/solr,null,UNAVAILABLE} [junit4] 2> 54063 INFO (TEST-TestLBHttp2SolrClient.testReliability-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.session node0 Stopped scavenging [junit4] 2> 54066 INFO (TEST-TestLBHttp2SolrClient.testReliability-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=893117317 [junit4] 2> 54082 INFO (coreCloseExecutor-164-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@263c4e0a [junit4] 2> 54082 INFO (coreCloseExecutor-164-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=263c4e0a [junit4] 2> 54082 INFO (coreCloseExecutor-164-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@12a41539: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@79868fc5 [junit4] 2> 54129 INFO (TEST-TestLBHttp2SolrClient.testReliability-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 54129 INFO (TEST-TestLBHttp2SolrClient.testReliability-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@398859dc: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@2cdef187 [junit4] 2> 54132 INFO (TEST-TestLBHttp2SolrClient.testReliability-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 54132 INFO (TEST-TestLBHttp2SolrClient.testReliability-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@25078ccc: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@546c2dde [junit4] 2> 54133 INFO (TEST-TestLBHttp2SolrClient.testReliability-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 54133 INFO (TEST-TestLBHttp2SolrClient.testReliability-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@23e15001: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@765a8ff3 [junit4] 2> 54178 INFO (TEST-TestLBHttp2SolrClient.testReliability-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@63074744{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0} [junit4] 2> 54178 INFO (TEST-TestLBHttp2SolrClient.testReliability-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@30cc46c2{/solr,null,UNAVAILABLE} [junit4] 2> 54178 INFO (TEST-TestLBHttp2SolrClient.testReliability-seed#[2E4C4718E24A8AE4]) [ ] o.e.j.s.session node0 Stopped scavenging [junit4] 2> 54186 INFO (TEST-TestLBHttp2SolrClient.testReliability-seed#[2E4C4718E24A8AE4]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testReliability [junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-8.0-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestLBHttp2SolrClient_2E4C4718E24A8AE4-001 [junit4] 2> NOTE: test params are: codec=CheapBastard, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@4491b8bb), locale=sr-Cyrl-BA, timezone=Asia/Novokuznetsk [junit4] 2> NOTE: Linux 4.18.0-15-generic amd64/Aleksey Shipilev 12-testing (64-bit)/cpus=8,threads=1,free=362545712,total=519045120 [junit4] 2> NOTE: All tests run in this JVM: [TestDocumentObjectBinder, ArcCosineEvaluatorTest, UuidEvaluatorTest, TestLBHttp2SolrClient] [junit4] Completed [5/185 (1!)] on J1 in 44.80s, 3 tests, 1 error <<< FAILURES! [...truncated 41944 lines...] [repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-8.0-Linux/252/consoleText [repro] Revision: dcd3e98db10c4d43aec00c66b16ab07fea8c350d [repro] Ant options: "-Dargs=-XX:+UseCompressedOops -XX:+UseParallelGC" [repro] Repro line: ant test -Dtestcase=TestPKIAuthenticationPlugin -Dtests.method=test -Dtests.seed=CAD557123110C108 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=om-KE -Dtests.timezone=Indian/Mayotte -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [repro] Repro line: ant test -Dtestcase=TestLBHttp2SolrClient -Dtests.method=testTwoServers -Dtests.seed=2E4C4718E24A8AE4 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=sr-Cyrl-BA -Dtests.timezone=Asia/Novokuznetsk -Dtests.asserts=true -Dtests.file.encoding=US-ASCII [repro] ant clean [...truncated 6 lines...] [repro] Test suites by module: [repro] solr/solrj [repro] TestLBHttp2SolrClient [repro] solr/core [repro] TestPKIAuthenticationPlugin [repro] ant compile-test [...truncated 2713 lines...] [repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.TestLBHttp2SolrClient" -Dtests.showOutput=onerror "-Dargs=-XX:+UseCompressedOops -XX:+UseParallelGC" -Dtests.seed=2E4C4718E24A8AE4 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=sr-Cyrl-BA -Dtests.timezone=Asia/Novokuznetsk -Dtests.asserts=true -Dtests.file.encoding=US-ASCII [...truncated 85 lines...] [repro] ant compile-test [...truncated 1357 lines...] [repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.TestPKIAuthenticationPlugin" -Dtests.showOutput=onerror "-Dargs=-XX:+UseCompressedOops -XX:+UseParallelGC" -Dtests.seed=CAD557123110C108 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=om-KE -Dtests.timezone=Indian/Mayotte -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [...truncated 75 lines...] [repro] Failures: [repro] 0/5 failed: org.apache.solr.client.solrj.TestLBHttp2SolrClient [repro] 0/5 failed: org.apache.solr.security.TestPKIAuthenticationPlugin [repro] Exiting with code 0 [...truncated 43 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org
