Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-8.1/26/
3 tests failed. FAILED: org.apache.solr.cloud.OverseerRolesTest.testDesignatedOverseerRestarts Error Message: Timed out waiting for overseer state change. The current overseer is: 127.0.0.1:37891_solr Stack Trace: java.lang.AssertionError: Timed out waiting for overseer state change. The current overseer is: 127.0.0.1:37891_solr at __randomizedtesting.SeedInfo.seed([462D0E631CD1476A:4E0C193C228F5560]:0) at org.junit.Assert.fail(Assert.java:88) at org.apache.solr.cloud.OverseerRolesTest.waitForNewOverseer(OverseerRolesTest.java:70) at org.apache.solr.cloud.OverseerRolesTest.waitForNewOverseer(OverseerRolesTest.java:75) at org.apache.solr.cloud.OverseerRolesTest.testDesignatedOverseerRestarts(OverseerRolesTest.java:189) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) 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 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.lang.Thread.run(Thread.java:748) FAILED: org.apache.solr.cloud.ReindexCollectionTest.testLossySchema Error Message: copied num docs expected:<200> but was:<168> Stack Trace: java.lang.AssertionError: copied num docs expected:<200> but was:<168> at __randomizedtesting.SeedInfo.seed([462D0E631CD1476A:609966D22567DB8E]:0) at org.junit.Assert.fail(Assert.java:88) at org.junit.Assert.failNotEquals(Assert.java:834) at org.junit.Assert.assertEquals(Assert.java:645) at org.apache.solr.cloud.ReindexCollectionTest.testLossySchema(ReindexCollectionTest.java:208) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) 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 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.lang.Thread.run(Thread.java:748) FAILED: org.apache.solr.handler.component.DistributedFacetPivotSmallTest.test Error Message: Captured an uncaught exception in thread: Thread[id=3280, name=Thread-442, state=RUNNABLE, group=TGRP-DistributedFacetPivotSmallTest] Stack Trace: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=3280, name=Thread-442, state=RUNNABLE, group=TGRP-DistributedFacetPivotSmallTest] at __randomizedtesting.SeedInfo.seed([462D0E631CD1476A:CE7931B9B22D2A92]:0) Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at https://127.0.0.1:43520/collection1: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: https://127.0.0.1:43520/collection1/select at __randomizedtesting.SeedInfo.seed([462D0E631CD1476A]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:649) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244) 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.BaseDistributedSearchTestCase$5.run(BaseDistributedSearchTestCase.java:693) Build Log: [...truncated 13889 lines...] [junit4] Suite: org.apache.solr.handler.component.DistributedFacetPivotSmallTest [junit4] 2> Creating dataDir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_462D0E631CD1476A-001/init-core-data-001 [junit4] 2> 388638 INFO (SUITE-DistributedFacetPivotSmallTest-seed#[462D0E631CD1476A]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> 388639 WARN (SUITE-DistributedFacetPivotSmallTest-seed#[462D0E631CD1476A]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1 [junit4] 2> 388639 INFO (SUITE-DistributedFacetPivotSmallTest-seed#[462D0E631CD1476A]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false [junit4] 2> 388641 INFO (SUITE-DistributedFacetPivotSmallTest-seed#[462D0E631CD1476A]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN) [junit4] 2> 388659 INFO (SUITE-DistributedFacetPivotSmallTest-seed#[462D0E631CD1476A]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: / [junit4] 2> 389607 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_462D0E631CD1476A-001/tempDir-001/control/cores/collection1 [junit4] 2> 389609 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 389623 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 389623 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 389623 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12 [junit4] 2> 389667 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 389667 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 389667 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 389683 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@11e1d5cb{/,null,AVAILABLE} [junit4] 2> 389684 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@75ea687f[provider=null,keyStore=null,trustStore=null] [junit4] 2> 389686 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@6ee1dcdb{SSL,[ssl, http/1.1]}{127.0.0.1:37447} [junit4] 2> 389686 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.Server Started @389847ms [junit4] 2> 389686 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=37447, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_462D0E631CD1476A-001/tempDir-001/control/cores} [junit4] 2> 389686 ERROR (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 389686 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 389686 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.1.0 [junit4] 2> 389686 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 389686 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 389686 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-05-05T07:11:32.251Z [junit4] 2> 389756 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_462D0E631CD1476A-001/tempDir-001/control/solr.xml [junit4] 2> 389809 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 389809 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 389845 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@6bf59cfe, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 390650 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false] [junit4] 2> 390651 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2 [junit4] 2> 390664 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@3d01dd0c[provider=null,keyStore=null,trustStore=null] [junit4] 2> 390667 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2 [junit4] 2> 390813 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@650d4a6b[provider=null,keyStore=null,trustStore=null] [junit4] 2> 390967 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 390967 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 391093 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6bf59cfe [junit4] 2> 391152 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6bf59cfe [junit4] 2> 391153 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6bf59cfe [junit4] 2> 391167 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_462D0E631CD1476A-001/tempDir-001/control/cores [junit4] 2> 391167 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 391231 INFO (coreLoadExecutor-953-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 391614 INFO (coreLoadExecutor-953-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0 [junit4] 2> 392071 INFO (coreLoadExecutor-953-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 392842 INFO (coreLoadExecutor-953-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 392944 INFO (coreLoadExecutor-953-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 392944 INFO (coreLoadExecutor-953-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@6bf59cfe [junit4] 2> 392993 INFO (coreLoadExecutor-953-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_462D0E631CD1476A-001/tempDir-001/control/cores/collection1/data/] [junit4] 2> 392994 INFO (coreLoadExecutor-953-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=31, maxMergeAtOnceExplicit=19, maxMergedSegmentMB=79.3369140625, floorSegmentMB=1.845703125, forceMergeDeletesPctAllowed=11.060407458886072, segmentsPerTier=26.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0, deletesPctAllowed=45.6997501101642 [junit4] 2> 393581 INFO (coreLoadExecutor-953-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 393581 INFO (coreLoadExecutor-953-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 393582 INFO (coreLoadExecutor-953-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 393582 INFO (coreLoadExecutor-953-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 393583 INFO (coreLoadExecutor-953-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@76567232 [junit4] 2> 393583 INFO (coreLoadExecutor-953-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@2890bd0d[collection1] main] [junit4] 2> 393584 INFO (coreLoadExecutor-953-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 393691 INFO (coreLoadExecutor-953-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 394162 INFO (coreLoadExecutor-953-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 394162 INFO (coreLoadExecutor-953-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1632675086180810752 [junit4] 2> 394172 INFO (searcherExecutor-954-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 394189 INFO (searcherExecutor-954-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 394189 INFO (searcherExecutor-954-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 394189 INFO (searcherExecutor-954-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 394189 INFO (searcherExecutor-954-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 394191 INFO (searcherExecutor-954-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 394208 INFO (searcherExecutor-954-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 394209 INFO (searcherExecutor-954-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 394209 INFO (searcherExecutor-954-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 394226 INFO (searcherExecutor-954-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2890bd0d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 395614 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_462D0E631CD1476A-001/tempDir-001/shard0/cores/collection1 [junit4] 2> 395650 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 395650 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 395650 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 395650 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12 [junit4] 2> 395728 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 395728 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 395728 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 395729 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@bc4afbc{/,null,AVAILABLE} [junit4] 2> 395729 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@3536723c[provider=null,keyStore=null,trustStore=null] [junit4] 2> 395730 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@3d3a3756{SSL,[ssl, http/1.1]}{127.0.0.1:34548} [junit4] 2> 395730 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.Server Started @395890ms [junit4] 2> 395730 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=34548, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_462D0E631CD1476A-001/tempDir-001/shard0/cores} [junit4] 2> 395730 ERROR (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 395730 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 395730 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.1.0 [junit4] 2> 395730 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 395730 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 395730 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-05-05T07:11:38.295Z [junit4] 2> 395731 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_462D0E631CD1476A-001/tempDir-001/shard0/solr.xml [junit4] 2> 395767 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 395767 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 395801 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@6bf59cfe, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 396217 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false] [junit4] 2> 396217 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2 [junit4] 2> 396252 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@210ed09f[provider=null,keyStore=null,trustStore=null] [junit4] 2> 396320 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2 [junit4] 2> 396348 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@46e67758[provider=null,keyStore=null,trustStore=null] [junit4] 2> 396415 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 396415 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 396489 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6bf59cfe [junit4] 2> 396592 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6bf59cfe [junit4] 2> 396592 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6bf59cfe [junit4] 2> 396594 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_462D0E631CD1476A-001/tempDir-001/shard0/cores [junit4] 2> 396594 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 396672 INFO (coreLoadExecutor-967-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 397075 INFO (coreLoadExecutor-967-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0 [junit4] 2> 397370 INFO (coreLoadExecutor-967-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 398062 INFO (coreLoadExecutor-967-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 398150 INFO (coreLoadExecutor-967-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 398150 INFO (coreLoadExecutor-967-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@6bf59cfe [junit4] 2> 398150 INFO (coreLoadExecutor-967-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_462D0E631CD1476A-001/tempDir-001/shard0/cores/collection1/data/] [junit4] 2> 398166 INFO (coreLoadExecutor-967-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=31, maxMergeAtOnceExplicit=19, maxMergedSegmentMB=79.3369140625, floorSegmentMB=1.845703125, forceMergeDeletesPctAllowed=11.060407458886072, segmentsPerTier=26.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0, deletesPctAllowed=45.6997501101642 [junit4] 2> 398401 INFO (coreLoadExecutor-967-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 398401 INFO (coreLoadExecutor-967-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 398419 INFO (coreLoadExecutor-967-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 398419 INFO (coreLoadExecutor-967-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 398420 INFO (coreLoadExecutor-967-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@18c40594 [junit4] 2> 398420 INFO (coreLoadExecutor-967-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1a55e454[collection1] main] [junit4] 2> 398421 INFO (coreLoadExecutor-967-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 398452 INFO (coreLoadExecutor-967-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 398821 INFO (coreLoadExecutor-967-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 398821 INFO (coreLoadExecutor-967-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1632675091066126336 [junit4] 2> 398823 INFO (searcherExecutor-968-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 398824 INFO (searcherExecutor-968-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 398824 INFO (searcherExecutor-968-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 398824 INFO (searcherExecutor-968-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 398824 INFO (searcherExecutor-968-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 398825 INFO (searcherExecutor-968-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 398825 INFO (searcherExecutor-968-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 398825 INFO (searcherExecutor-968-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 398825 INFO (searcherExecutor-968-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 398910 INFO (searcherExecutor-968-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1a55e454[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 399985 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_462D0E631CD1476A-001/tempDir-001/shard1/cores/collection1 [junit4] 2> 400003 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 400004 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 400004 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 400004 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12 [junit4] 2> 400014 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 400014 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 400014 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 400015 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4a8df58d{/,null,AVAILABLE} [junit4] 2> 400015 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@6da74726[provider=null,keyStore=null,trustStore=null] [junit4] 2> 400016 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@780077b2{SSL,[ssl, http/1.1]}{127.0.0.1:44607} [junit4] 2> 400016 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.Server Started @400177ms [junit4] 2> 400016 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=44607, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_462D0E631CD1476A-001/tempDir-001/shard1/cores} [junit4] 2> 400016 ERROR (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 400016 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 400016 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.1.0 [junit4] 2> 400016 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 400016 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 400016 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-05-05T07:11:42.581Z [junit4] 2> 400017 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_462D0E631CD1476A-001/tempDir-001/shard1/solr.xml [junit4] 2> 400041 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 400041 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 400042 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@6bf59cfe, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 400805 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false] [junit4] 2> 400806 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2 [junit4] 2> 401010 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@7a8663a2[provider=null,keyStore=null,trustStore=null] [junit4] 2> 401044 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2 [junit4] 2> 401046 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@4d873d75[provider=null,keyStore=null,trustStore=null] [junit4] 2> 401262 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 401262 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 401355 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6bf59cfe [junit4] 2> 401425 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6bf59cfe [junit4] 2> 401425 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6bf59cfe [junit4] 2> 401427 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_462D0E631CD1476A-001/tempDir-001/shard1/cores [junit4] 2> 401445 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 401579 INFO (coreLoadExecutor-981-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 401759 INFO (coreLoadExecutor-981-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0 [junit4] 2> 402049 INFO (coreLoadExecutor-981-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 402880 INFO (coreLoadExecutor-981-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 403066 INFO (coreLoadExecutor-981-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 403067 INFO (coreLoadExecutor-981-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@6bf59cfe [junit4] 2> 403067 INFO (coreLoadExecutor-981-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_462D0E631CD1476A-001/tempDir-001/shard1/cores/collection1/data/] [junit4] 2> 403070 INFO (coreLoadExecutor-981-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=31, maxMergeAtOnceExplicit=19, maxMergedSegmentMB=79.3369140625, floorSegmentMB=1.845703125, forceMergeDeletesPctAllowed=11.060407458886072, segmentsPerTier=26.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0, deletesPctAllowed=45.6997501101642 [junit4] 2> 403426 INFO (coreLoadExecutor-981-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 403426 INFO (coreLoadExecutor-981-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 403427 INFO (coreLoadExecutor-981-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 403427 INFO (coreLoadExecutor-981-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 403428 INFO (coreLoadExecutor-981-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@663033ca [junit4] 2> 403428 INFO (coreLoadExecutor-981-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@73d043f0[collection1] main] [junit4] 2> 403429 INFO (coreLoadExecutor-981-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 403518 INFO (coreLoadExecutor-981-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 403771 INFO (coreLoadExecutor-981-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 403771 INFO (coreLoadExecutor-981-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1632675096256577536 [junit4] 2> 403773 INFO (searcherExecutor-982-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 403774 INFO (searcherExecutor-982-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 403774 INFO (searcherExecutor-982-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 403774 INFO (searcherExecutor-982-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 403806 INFO (searcherExecutor-982-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 403807 INFO (searcherExecutor-982-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 403807 INFO (searcherExecutor-982-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 403808 INFO (searcherExecutor-982-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 403808 INFO (searcherExecutor-982-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 403819 INFO (searcherExecutor-982-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@73d043f0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 404992 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_462D0E631CD1476A-001/tempDir-001/shard2/cores/collection1 [junit4] 2> 405008 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 405008 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 405008 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 405009 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12 [junit4] 2> 405038 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 405038 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 405038 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 405038 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@39685f7{/,null,AVAILABLE} [junit4] 2> 405039 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@52204caa[provider=null,keyStore=null,trustStore=null] [junit4] 2> 405039 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@49b38b69{SSL,[ssl, http/1.1]}{127.0.0.1:43520} [junit4] 2> 405039 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.Server Started @405200ms [junit4] 2> 405039 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=43520, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_462D0E631CD1476A-001/tempDir-001/shard2/cores} [junit4] 2> 405040 ERROR (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 405040 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 405040 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.1.0 [junit4] 2> 405040 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 405040 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 405040 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-05-05T07:11:47.605Z [junit4] 2> 405040 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_462D0E631CD1476A-001/tempDir-001/shard2/solr.xml [junit4] 2> 405043 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 405043 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 405045 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@6bf59cfe, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 405948 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false] [junit4] 2> 405948 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2 [junit4] 2> 405970 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@52b38437[provider=null,keyStore=null,trustStore=null] [junit4] 2> 405987 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2 [junit4] 2> 405988 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@7d0a9fb8[provider=null,keyStore=null,trustStore=null] [junit4] 2> 406152 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 406152 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 406248 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6bf59cfe [junit4] 2> 406334 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6bf59cfe [junit4] 2> 406334 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6bf59cfe [junit4] 2> 406336 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_462D0E631CD1476A-001/tempDir-001/shard2/cores [junit4] 2> 406336 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 406453 INFO (coreLoadExecutor-995-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 406688 INFO (coreLoadExecutor-995-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0 [junit4] 2> 406900 INFO (coreLoadExecutor-995-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 407613 INFO (coreLoadExecutor-995-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 407774 INFO (coreLoadExecutor-995-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 407775 INFO (coreLoadExecutor-995-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@6bf59cfe [junit4] 2> 407775 INFO (coreLoadExecutor-995-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_462D0E631CD1476A-001/tempDir-001/shard2/cores/collection1/data/] [junit4] 2> 407793 INFO (coreLoadExecutor-995-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=31, maxMergeAtOnceExplicit=19, maxMergedSegmentMB=79.3369140625, floorSegmentMB=1.845703125, forceMergeDeletesPctAllowed=11.060407458886072, segmentsPerTier=26.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0, deletesPctAllowed=45.6997501101642 [junit4] 2> 408308 INFO (coreLoadExecutor-995-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 408308 INFO (coreLoadExecutor-995-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 408309 INFO (coreLoadExecutor-995-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 408309 INFO (coreLoadExecutor-995-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 408310 INFO (coreLoadExecutor-995-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@1a7827fd [junit4] 2> 408310 INFO (coreLoadExecutor-995-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@356c3fc8[collection1] main] [junit4] 2> 408311 INFO (coreLoadExecutor-995-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 408415 INFO (coreLoadExecutor-995-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 409049 INFO (coreLoadExecutor-995-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 409064 INFO (coreLoadExecutor-995-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1632675101806690304 [junit4] 2> 409072 INFO (searcherExecutor-996-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 409074 INFO (searcherExecutor-996-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 409074 INFO (searcherExecutor-996-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 409074 INFO (searcherExecutor-996-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 409074 INFO (searcherExecutor-996-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 409075 INFO (searcherExecutor-996-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 409075 INFO (searcherExecutor-996-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 409075 INFO (searcherExecutor-996-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 409076 INFO (searcherExecutor-996-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 409174 INFO (searcherExecutor-996-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@356c3fc8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 409658 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_462D0E631CD1476A-001/tempDir-001/shard3/cores/collection1 [junit4] 2> 409673 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 409673 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 409673 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 409673 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12 [junit4] 2> 409674 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 409674 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 409674 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 409674 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@d9014c3{/,null,AVAILABLE} [junit4] 2> 409675 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@65f692f6[provider=null,keyStore=null,trustStore=null] [junit4] 2> 409692 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@66d30406{SSL,[ssl, http/1.1]}{127.0.0.1:39943} [junit4] 2> 409692 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.s.Server Started @409853ms [junit4] 2> 409692 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=39943, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_462D0E631CD1476A-001/tempDir-001/shard3/cores} [junit4] 2> 409692 ERROR (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 409693 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 409693 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.1.0 [junit4] 2> 409693 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 409693 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 409693 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-05-05T07:11:52.258Z [junit4] 2> 409693 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_462D0E631CD1476A-001/tempDir-001/shard3/solr.xml [junit4] 2> 409928 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 409928 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 409929 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@6bf59cfe, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 410581 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false] [junit4] 2> 410581 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2 [junit4] 2> 410626 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@2f85e68[provider=null,keyStore=null,trustStore=null] [junit4] 2> 410657 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2 [junit4] 2> 410663 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@4c01f0ea[provider=null,keyStore=null,trustStore=null] [junit4] 2> 410770 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 410770 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 410896 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6bf59cfe [junit4] 2> 410971 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6bf59cfe [junit4] 2> 410971 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6bf59cfe [junit4] 2> 410985 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_462D0E631CD1476A-001/tempDir-001/shard3/cores [junit4] 2> 410985 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 411066 INFO (coreLoadExecutor-1009-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 411307 INFO (coreLoadExecutor-1009-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0 [junit4] 2> 411472 INFO (coreLoadExecutor-1009-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 412054 INFO (coreLoadExecutor-1009-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 412079 INFO (coreLoadExecutor-1009-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 412079 INFO (coreLoadExecutor-1009-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@6bf59cfe [junit4] 2> 412079 INFO (coreLoadExecutor-1009-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_462D0E631CD1476A-001/tempDir-001/shard3/cores/collection1/data/] [junit4] 2> 412081 INFO (coreLoadExecutor-1009-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=31, maxMergeAtOnceExplicit=19, maxMergedSegmentMB=79.3369140625, floorSegmentMB=1.845703125, forceMergeDeletesPctAllowed=11.060407458886072, segmentsPerTier=26.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0, deletesPctAllowed=45.6997501101642 [junit4] 2> 412421 INFO (coreLoadExecutor-1009-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 412421 INFO (coreLoadExecutor-1009-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 412422 INFO (coreLoadExecutor-1009-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 412422 INFO (coreLoadExecutor-1009-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 412435 INFO (coreLoadExecutor-1009-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@3de1d654 [junit4] 2> 412436 INFO (coreLoadExecutor-1009-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@17fc1bac[collection1] main] [junit4] 2> 412436 INFO (coreLoadExecutor-1009-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 412617 INFO (coreLoadExecutor-1009-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 412934 INFO (coreLoadExecutor-1009-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 412934 INFO (coreLoadExecutor-1009-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1632675105864679424 [junit4] 2> 412935 INFO (searcherExecutor-1010-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 412936 INFO (searcherExecutor-1010-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 412936 INFO (searcherExecutor-1010-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 412936 INFO (searcherExecutor-1010-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 412949 INFO (searcherExecutor-1010-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 412949 INFO (searcherExecutor-1010-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 412950 INFO (searcherExecutor-1010-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 412950 INFO (searcherExecutor-1010-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 412950 INFO (searcherExecutor-1010-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 412955 INFO (searcherExecutor-1010-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@17fc1bac[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 413450 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[462D0E631CD1476A]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test [junit4] 2> 413732 INFO (qtp1664333303-3041) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1632675106594488320)} 0 102 [junit4] 2> 413849 INFO (qtp854761869-3065) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1632675106808397824)} 0 15 [junit4] 2> 414042 INFO (qtp995758937-3088) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1632675107023355904)} 0 2 [junit4] 2> 414191 INFO (qtp1351256317-3110) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1632675107103047680)} 0 76 [junit4] 2> 414351 INFO (qtp1177304792-3130) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1632675107314860032)} 0 34 [junit4] 2> 414541 INFO (qtp1664333303-3042) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[19 (1632675107371483136)]} 0 170 [junit4] 2> 414555 INFO (qtp1351256317-3111) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[19 (1632675107563372544)]} 0 1 [junit4] 2> 414742 INFO (qtp1664333303-3038) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[20 (1632675107668230144)]} 0 164 [junit4] 2> 414750 INFO (qtp854761869-3061) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[20 (1632675107766796288)]} 0 1 [junit4] 2> 414781 INFO (qtp1664333303-3039) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[21 (1632675107800350720)]} 0 1 [junit4] 2> 414903 INFO (qtp995758937-3086) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[21 (1632675107927228416)]} 0 1 [junit4] 2> 414942 INFO (qtp1664333303-3040) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[22 (1632675107953442816)]} 0 16 [junit4] 2> 415076 INFO (qtp1351256317-3107) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[22 (1632675107971268608)]} 0 133 [junit4] 2> 415093 INFO (qtp1664333303-3041) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[23 (1632675108127506432)]} 0 1 [junit4] 2> 415129 INFO (qtp1177304792-3131) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[23 (1632675108165255168)]} 0 1 [junit4] 2> 415166 INFO (qtp1664333303-3042) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[24 (1632675108204052480)]} 0 0 [junit4] 2> 415250 INFO (qtp854761869-3062) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[24 (1632675108233412608)]} 0 57 [junit4] 2> 415287 INFO (qtp1664333303-3038) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[25 (1632675108330930176)]} 0 0 [junit4] 2> 415308 INFO (qtp995758937-3084) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[25 (1632675108352950272)]} 0 1 [junit4] 2> 415309 INFO (qtp1664333303-3039) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[26 (1632675108353998848)]} 0 0 [junit4] 2> 415311 INFO (qtp1351256317-3108) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[26 (1632675108356096000)]} 0 0 [junit4] 2> 415339 INFO (qtp1664333303-3040) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[27 (1632675108386504704)]} 0 0 [junit4] 2> 415428 INFO (qtp1177304792-3132) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[27 (1632675108424253440)]} 0 53 [junit4] 2> 415430 INFO (qtp1664333303-3041) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[28 (1632675108480876544)]} 0 0 [junit4] 2> 415432 INFO (qtp854761869-3063) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[28 (1632675108484022272)]} 0 0 [junit4] 2> 415433 INFO (qtp1664333303-3042) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1632675108485070848,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 415433 INFO (qtp1664333303-3042) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@34134be7 commitCommandVersion:1632675108485070848 [junit4] 2> 415642 INFO (qtp1664333303-3042) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@4caa06b8[collection1] main] [junit4] 2> 415643 INFO (qtp1664333303-3042) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 415644 INFO (searcherExecutor-954-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4caa06b8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.1.0):C10:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.4.0-112-generic, timestamp=1557040318170}])))} [junit4] 2> 415666 INFO (qtp1664333303-3042) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 233 [junit4] 2> 415675 INFO (qtp854761869-3064) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1632675108738826240,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 415675 INFO (qtp854761869-3064) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@682d1a40 commitCommandVersion:1632675108738826240 [junit4] 2> 415932 INFO (qtp854761869-3064) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@442b21d0[collection1] main] [junit4] 2> 415932 INFO (qtp854761869-3064) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 415934 INFO (searcherExecutor-968-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@442b21d0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.1.0):C3:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.4.0-112-generic, timestamp=1557040318242}])))} [junit4] 2> 415946 INFO (qtp854761869-3064) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 271 [junit4] 2> 415947 INFO (qtp995758937-3085) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1632675109024038912,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 415947 INFO (qtp995758937-3085) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@71defaa8 commitCommandVersion:1632675109024038912 [j [...truncated too long message...] fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml resolve: jar-checksums: [mkdir] Created dir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/null1627921298 [copy] Copying 239 files to /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/null1627921298 [delete] Deleting directory /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/null1627921298 check-working-copy: [ivy:cachepath] :: resolving dependencies :: #;work...@lucene2-us-west.apache.org [ivy:cachepath] confs: [default] [ivy:cachepath] found org.eclipse.jgit#org.eclipse.jgit;5.3.0.201903130848-r in public [ivy:cachepath] found com.jcraft#jsch;0.1.54 in public [ivy:cachepath] found com.jcraft#jzlib;1.1.1 in public [ivy:cachepath] found com.googlecode.javaewah#JavaEWAH;1.1.6 in public [ivy:cachepath] found org.slf4j#slf4j-api;1.7.2 in public [ivy:cachepath] found org.bouncycastle#bcpg-jdk15on;1.60 in public [ivy:cachepath] found org.bouncycastle#bcprov-jdk15on;1.60 in public [ivy:cachepath] found org.bouncycastle#bcpkix-jdk15on;1.60 in public [ivy:cachepath] found org.slf4j#slf4j-nop;1.7.2 in public [ivy:cachepath] :: resolution report :: resolve 65ms :: artifacts dl 13ms --------------------------------------------------------------------- | | modules || artifacts | | conf | number| search|dwnlded|evicted|| number|dwnlded| --------------------------------------------------------------------- | default | 9 | 0 | 0 | 0 || 9 | 0 | --------------------------------------------------------------------- [wc-checker] Initializing working copy... [wc-checker] Checking working copy status... -jenkins-base: BUILD SUCCESSFUL Total time: 587 minutes 35 seconds Archiving artifacts java.lang.InterruptedException: no matches found within 10000 at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:2847) at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2726) at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2707) at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3086) Also: hudson.remoting.Channel$CallSiteStackTrace: Remote call to lucene2 at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1741) at hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:357) at hudson.remoting.Channel.call(Channel.java:955) at hudson.FilePath.act(FilePath.java:1072) at hudson.FilePath.act(FilePath.java:1061) at hudson.FilePath.validateAntFileMask(FilePath.java:2705) at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243) at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:81) at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20) at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:744) at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690) at hudson.model.Build$BuildExecution.post2(Build.java:186) at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635) at hudson.model.Run.execute(Run.java:1835) at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43) at hudson.model.ResourceController.execute(ResourceController.java:97) at hudson.model.Executor.run(Executor.java:429) Caused: hudson.FilePath$TunneledInterruptedException at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3088) at hudson.remoting.UserRequest.perform(UserRequest.java:212) at hudson.remoting.UserRequest.perform(UserRequest.java:54) at hudson.remoting.Request$2.run(Request.java:369) at hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:72) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:748) Caused: java.lang.InterruptedException: java.lang.InterruptedException: no matches found within 10000 at hudson.FilePath.act(FilePath.java:1074) at hudson.FilePath.act(FilePath.java:1061) at hudson.FilePath.validateAntFileMask(FilePath.java:2705) at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243) at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:81) at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20) at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:744) at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690) at hudson.model.Build$BuildExecution.post2(Build.java:186) at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635) at hudson.model.Run.execute(Run.java:1835) at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43) at hudson.model.ResourceController.execute(ResourceController.java:97) at hudson.model.Executor.run(Executor.java:429) No artifacts found that match the file pattern "**/*.events,heapdumps/**,**/hs_err_pid*". Configuration error? Recording test results Build step 'Publish JUnit test result report' changed build result to UNSTABLE Email was triggered for: Unstable (Test Failures) Sending email for trigger: Unstable (Test Failures)
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org