Build: https://builds.apache.org/job/Lucene-Solr-Tests-8.1/45/
1 tests failed. FAILED: org.apache.solr.handler.component.DistributedFacetPivotSmallTest.test Error Message: Error from server at https://127.0.0.1:44657/ey/n/collection1: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: https://127.0.0.1:33823/ey/n/collection1/select Stack Trace: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at https://127.0.0.1:44657/ey/n/collection1: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: https://127.0.0.1:33823/ey/n/collection1/select at __randomizedtesting.SeedInfo.seed([2DBC4176144E107:8A8FFBCDCFB88CFF]: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.queryServer(BaseDistributedSearchTestCase.java:626) at org.apache.solr.handler.component.DistributedFacetPivotSmallTest.test(DistributedFacetPivotSmallTest.java:85) 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 org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1082) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1054) 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) Build Log: [...truncated 13111 lines...] [junit4] Suite: org.apache.solr.handler.component.DistributedFacetPivotSmallTest [junit4] 2> Creating dataDir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_2DBC4176144E107-001/init-core-data-001 [junit4] 2> 364845 WARN (SUITE-DistributedFacetPivotSmallTest-seed#[2DBC4176144E107]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=4 numCloses=4 [junit4] 2> 364861 INFO (SUITE-DistributedFacetPivotSmallTest-seed#[2DBC4176144E107]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=true [junit4] 2> 364863 INFO (SUITE-DistributedFacetPivotSmallTest-seed#[2DBC4176144E107]-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> 364864 INFO (SUITE-DistributedFacetPivotSmallTest-seed#[2DBC4176144E107]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> 364864 INFO (SUITE-DistributedFacetPivotSmallTest-seed#[2DBC4176144E107]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /ey/n [junit4] 2> 365882 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_2DBC4176144E107-001/tempDir-001/control/cores/collection1 [junit4] 2> 365916 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 365916 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 365917 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 365917 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] 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> 365935 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 365935 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 365935 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 365936 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1d7cbce0{/ey/n,null,AVAILABLE} [junit4] 2> 365938 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@3e32ac73[provider=null,keyStore=null,trustStore=null] [junit4] 2> 365938 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@5cc181bf{SSL,[ssl, http/1.1]}{127.0.0.1:42928} [junit4] 2> 365938 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.Server Started @366022ms [junit4] 2> 365938 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/ey/n, hostPort=42928, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_2DBC4176144E107-001/tempDir-001/control/cores} [junit4] 2> 365939 ERROR (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 365939 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 365939 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.1.0 [junit4] 2> 365939 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 365939 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 365951 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-05-10T04:56:59.278Z [junit4] 2> 365951 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_2DBC4176144E107-001/tempDir-001/control/solr.xml [junit4] 2> 365967 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 365967 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 365969 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@2a7e1ee7, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 366865 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false] [junit4] 2> 366865 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] 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> 366884 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@303aa4c7[provider=null,keyStore=null,trustStore=null] [junit4] 2> 366899 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] 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> 367029 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@77954dd6[provider=null,keyStore=null,trustStore=null] [junit4] 2> 367264 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 367264 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 367340 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2a7e1ee7 [junit4] 2> 367394 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2a7e1ee7 [junit4] 2> 367394 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2a7e1ee7 [junit4] 2> 367396 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_2DBC4176144E107-001/tempDir-001/control/cores [junit4] 2> 367396 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 367479 INFO (coreLoadExecutor-509-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 367832 INFO (coreLoadExecutor-509-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0 [junit4] 2> 368328 INFO (coreLoadExecutor-509-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 368452 WARN (coreLoadExecutor-509-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader Solr loaded a deprecated plugin/analysis class [solr.TrieIntField]. Please consult documentation how to replace it accordingly. [junit4] 2> 368512 WARN (coreLoadExecutor-509-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader Solr loaded a deprecated plugin/analysis class [solr.TrieFloatField]. Please consult documentation how to replace it accordingly. [junit4] 2> 368515 WARN (coreLoadExecutor-509-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader Solr loaded a deprecated plugin/analysis class [solr.TrieLongField]. Please consult documentation how to replace it accordingly. [junit4] 2> 368551 WARN (coreLoadExecutor-509-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader Solr loaded a deprecated plugin/analysis class [solr.TrieDoubleField]. Please consult documentation how to replace it accordingly. [junit4] 2> 368710 WARN (coreLoadExecutor-509-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader Solr loaded a deprecated plugin/analysis class [solr.TrieDateField]. Please consult documentation how to replace it accordingly. [junit4] 2> 369275 WARN (coreLoadExecutor-509-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader Solr loaded a deprecated plugin/analysis class [solr.EnumField]. Please consult documentation how to replace it accordingly. [junit4] 2> 369442 INFO (coreLoadExecutor-509-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 369734 INFO (coreLoadExecutor-509-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 369735 INFO (coreLoadExecutor-509-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@2a7e1ee7 [junit4] 2> 369768 INFO (coreLoadExecutor-509-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_2DBC4176144E107-001/tempDir-001/control/cores/collection1/data/] [junit4] 2> 369769 INFO (coreLoadExecutor-509-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=34, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 370294 INFO (coreLoadExecutor-509-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 370294 INFO (coreLoadExecutor-509-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 370296 INFO (coreLoadExecutor-509-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 370296 INFO (coreLoadExecutor-509-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 370296 INFO (coreLoadExecutor-509-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1702456529, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1] [junit4] 2> 370298 INFO (coreLoadExecutor-509-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@229e18a1[collection1] main] [junit4] 2> 370351 INFO (coreLoadExecutor-509-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 370388 INFO (coreLoadExecutor-509-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 370681 INFO (coreLoadExecutor-509-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 370681 INFO (coreLoadExecutor-509-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1633119606165995520 [junit4] 2> 370695 INFO (searcherExecutor-510-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 370711 INFO (searcherExecutor-510-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 370711 INFO (searcherExecutor-510-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 370711 INFO (searcherExecutor-510-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 370712 INFO (searcherExecutor-510-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 370712 INFO (searcherExecutor-510-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 370712 INFO (searcherExecutor-510-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 370712 INFO (searcherExecutor-510-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 370713 INFO (searcherExecutor-510-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 370732 INFO (searcherExecutor-510-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@229e18a1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 372837 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_2DBC4176144E107-001/tempDir-001/shard0/cores/collection1 [junit4] 2> 372890 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 372890 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 372890 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 372890 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] 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> 372953 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 372953 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 372953 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 372968 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3e9adde8{/ey/n,null,AVAILABLE} [junit4] 2> 372968 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@6736a573[provider=null,keyStore=null,trustStore=null] [junit4] 2> 372969 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@28fab432{SSL,[ssl, http/1.1]}{127.0.0.1:44657} [junit4] 2> 372969 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.Server Started @373052ms [junit4] 2> 372969 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/ey/n, hostPort=44657, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_2DBC4176144E107-001/tempDir-001/shard0/cores} [junit4] 2> 372969 ERROR (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 372969 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 372969 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.1.0 [junit4] 2> 372969 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 372969 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 372969 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-05-10T04:57:06.308Z [junit4] 2> 372969 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_2DBC4176144E107-001/tempDir-001/shard0/solr.xml [junit4] 2> 373006 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 373006 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 373007 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@2a7e1ee7, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 373693 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false] [junit4] 2> 373694 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] 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> 373695 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@4ce99a4b[provider=null,keyStore=null,trustStore=null] [junit4] 2> 373710 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] 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> 373711 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@6b665cd3[provider=null,keyStore=null,trustStore=null] [junit4] 2> 373803 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 373803 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 373878 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2a7e1ee7 [junit4] 2> 373948 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2a7e1ee7 [junit4] 2> 373949 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2a7e1ee7 [junit4] 2> 373950 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_2DBC4176144E107-001/tempDir-001/shard0/cores [junit4] 2> 373950 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 374094 INFO (coreLoadExecutor-523-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 374259 INFO (coreLoadExecutor-523-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0 [junit4] 2> 374403 INFO (coreLoadExecutor-523-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 375006 INFO (coreLoadExecutor-523-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 375096 INFO (coreLoadExecutor-523-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 375116 INFO (coreLoadExecutor-523-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@2a7e1ee7 [junit4] 2> 375116 INFO (coreLoadExecutor-523-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_2DBC4176144E107-001/tempDir-001/shard0/cores/collection1/data/] [junit4] 2> 375132 INFO (coreLoadExecutor-523-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=34, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 375605 INFO (coreLoadExecutor-523-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 375605 INFO (coreLoadExecutor-523-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 375606 INFO (coreLoadExecutor-523-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 375606 INFO (coreLoadExecutor-523-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 375621 INFO (coreLoadExecutor-523-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1702456529, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1] [junit4] 2> 375621 INFO (coreLoadExecutor-523-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@10545518[collection1] main] [junit4] 2> 375622 INFO (coreLoadExecutor-523-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 375715 INFO (coreLoadExecutor-523-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 375972 INFO (coreLoadExecutor-523-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 375972 INFO (coreLoadExecutor-523-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1633119611714011136 [junit4] 2> 376022 INFO (searcherExecutor-524-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 376023 INFO (searcherExecutor-524-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 376023 INFO (searcherExecutor-524-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 376023 INFO (searcherExecutor-524-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 376023 INFO (searcherExecutor-524-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 376023 INFO (searcherExecutor-524-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 376024 INFO (searcherExecutor-524-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 376024 INFO (searcherExecutor-524-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 376024 INFO (searcherExecutor-524-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 376039 INFO (searcherExecutor-524-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@10545518[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 385614 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_2DBC4176144E107-001/tempDir-001/shard1/cores/collection1 [junit4] 2> 385648 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 385663 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 385664 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 385664 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] 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> 385850 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 385850 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 385850 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 385850 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1c784a96{/ey/n,null,AVAILABLE} [junit4] 2> 385851 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@23839c6d[provider=null,keyStore=null,trustStore=null] [junit4] 2> 385878 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@3d226427{SSL,[ssl, http/1.1]}{127.0.0.1:34266} [junit4] 2> 385878 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.Server Started @385962ms [junit4] 2> 385878 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/ey/n, hostPort=34266, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_2DBC4176144E107-001/tempDir-001/shard1/cores} [junit4] 2> 385878 ERROR (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 385878 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 385879 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.1.0 [junit4] 2> 385879 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 385879 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 385879 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-05-10T04:57:19.218Z [junit4] 2> 385879 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_2DBC4176144E107-001/tempDir-001/shard1/solr.xml [junit4] 2> 385916 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 385916 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 385918 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@2a7e1ee7, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 386981 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false] [junit4] 2> 386982 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] 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> 386983 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@882bafe[provider=null,keyStore=null,trustStore=null] [junit4] 2> 386999 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] 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> 387051 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@4048502[provider=null,keyStore=null,trustStore=null] [junit4] 2> 387561 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 387561 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 387762 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2a7e1ee7 [junit4] 2> 387801 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2a7e1ee7 [junit4] 2> 387801 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2a7e1ee7 [junit4] 2> 387815 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_2DBC4176144E107-001/tempDir-001/shard1/cores [junit4] 2> 387834 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 387851 INFO (coreLoadExecutor-537-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 388108 INFO (coreLoadExecutor-537-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0 [junit4] 2> 388401 INFO (coreLoadExecutor-537-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 389458 INFO (coreLoadExecutor-537-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 389639 INFO (coreLoadExecutor-537-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 389640 INFO (coreLoadExecutor-537-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@2a7e1ee7 [junit4] 2> 389640 INFO (coreLoadExecutor-537-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_2DBC4176144E107-001/tempDir-001/shard1/cores/collection1/data/] [junit4] 2> 389659 INFO (coreLoadExecutor-537-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=34, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 390017 INFO (coreLoadExecutor-537-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 390017 INFO (coreLoadExecutor-537-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 390018 INFO (coreLoadExecutor-537-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 390018 INFO (coreLoadExecutor-537-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 390034 INFO (coreLoadExecutor-537-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1702456529, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1] [junit4] 2> 390087 INFO (coreLoadExecutor-537-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@59d96934[collection1] main] [junit4] 2> 390088 INFO (coreLoadExecutor-537-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 390270 INFO (coreLoadExecutor-537-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 390992 INFO (coreLoadExecutor-537-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 390993 INFO (coreLoadExecutor-537-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1633119627464671232 [junit4] 2> 390994 INFO (searcherExecutor-538-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 391084 INFO (searcherExecutor-538-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 391100 INFO (searcherExecutor-538-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 391100 INFO (searcherExecutor-538-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 391104 INFO (searcherExecutor-538-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 391173 INFO (searcherExecutor-538-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 391173 INFO (searcherExecutor-538-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 391174 INFO (searcherExecutor-538-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 391174 INFO (searcherExecutor-538-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 391190 INFO (searcherExecutor-538-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@59d96934[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 392476 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_2DBC4176144E107-001/tempDir-001/shard2/cores/collection1 [junit4] 2> 392563 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 392564 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 392564 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 392564 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] 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> 392672 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 392672 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 392672 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 392692 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@75f20ac5{/ey/n,null,AVAILABLE} [junit4] 2> 392693 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@11dafd09[provider=null,keyStore=null,trustStore=null] [junit4] 2> 392712 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@73db90b3{SSL,[ssl, http/1.1]}{127.0.0.1:39876} [junit4] 2> 392712 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.Server Started @392795ms [junit4] 2> 392712 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/ey/n, hostPort=39876, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_2DBC4176144E107-001/tempDir-001/shard2/cores} [junit4] 2> 392745 ERROR (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 392745 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 392745 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.1.0 [junit4] 2> 392745 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 392745 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 392745 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-05-10T04:57:26.084Z [junit4] 2> 392746 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_2DBC4176144E107-001/tempDir-001/shard2/solr.xml [junit4] 2> 392802 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 392802 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 392803 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@2a7e1ee7, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 394313 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false] [junit4] 2> 394314 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] 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> 394333 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@3359548b[provider=null,keyStore=null,trustStore=null] [junit4] 2> 394336 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] 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> 394353 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@73cf26f1[provider=null,keyStore=null,trustStore=null] [junit4] 2> 394463 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 394463 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 394519 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2a7e1ee7 [junit4] 2> 394678 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2a7e1ee7 [junit4] 2> 394678 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2a7e1ee7 [junit4] 2> 394680 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_2DBC4176144E107-001/tempDir-001/shard2/cores [junit4] 2> 394680 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 394731 INFO (coreLoadExecutor-551-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 394987 INFO (coreLoadExecutor-551-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0 [junit4] 2> 395135 INFO (coreLoadExecutor-551-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 405357 INFO (coreLoadExecutor-551-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 405431 INFO (coreLoadExecutor-551-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 405432 INFO (coreLoadExecutor-551-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@2a7e1ee7 [junit4] 2> 405432 INFO (coreLoadExecutor-551-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_2DBC4176144E107-001/tempDir-001/shard2/cores/collection1/data/] [junit4] 2> 405451 INFO (coreLoadExecutor-551-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=34, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 405778 INFO (coreLoadExecutor-551-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 405778 INFO (coreLoadExecutor-551-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 405779 INFO (coreLoadExecutor-551-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 405779 INFO (coreLoadExecutor-551-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 405794 INFO (coreLoadExecutor-551-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1702456529, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1] [junit4] 2> 405795 INFO (coreLoadExecutor-551-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6c5b915d[collection1] main] [junit4] 2> 405796 INFO (coreLoadExecutor-551-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 405896 INFO (coreLoadExecutor-551-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 406152 INFO (coreLoadExecutor-551-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 406153 INFO (coreLoadExecutor-551-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1633119643361083392 [junit4] 2> 406154 INFO (searcherExecutor-552-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 406167 INFO (searcherExecutor-552-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 406167 INFO (searcherExecutor-552-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 406167 INFO (searcherExecutor-552-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 406167 INFO (searcherExecutor-552-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 406167 INFO (searcherExecutor-552-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 406168 INFO (searcherExecutor-552-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 406168 INFO (searcherExecutor-552-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 406168 INFO (searcherExecutor-552-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 406188 INFO (searcherExecutor-552-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6c5b915d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 407166 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_2DBC4176144E107-001/tempDir-001/shard3/cores/collection1 [junit4] 2> 407186 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 407187 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 407187 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 407187 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] 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> 407188 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 407188 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 407200 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 407201 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@614c2eff{/ey/n,null,AVAILABLE} [junit4] 2> 407201 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@3d83f0e1[provider=null,keyStore=null,trustStore=null] [junit4] 2> 407222 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@127a8e5e{SSL,[ssl, http/1.1]}{127.0.0.1:33823} [junit4] 2> 407222 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.s.Server Started @407306ms [junit4] 2> 407222 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/ey/n, hostPort=33823, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_2DBC4176144E107-001/tempDir-001/shard3/cores} [junit4] 2> 407258 ERROR (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 407258 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 407258 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.1.0 [junit4] 2> 407258 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 407258 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 407258 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-05-10T04:57:40.597Z [junit4] 2> 407259 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_2DBC4176144E107-001/tempDir-001/shard3/solr.xml [junit4] 2> 407294 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 407295 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 407296 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@2a7e1ee7, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 407930 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false] [junit4] 2> 407987 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] 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> 408003 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@1f80ab5[provider=null,keyStore=null,trustStore=null] [junit4] 2> 408025 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] 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> 408026 WARN (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@8b5bd45[provider=null,keyStore=null,trustStore=null] [junit4] 2> 408171 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 408172 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 408315 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2a7e1ee7 [junit4] 2> 408406 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2a7e1ee7 [junit4] 2> 408424 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2a7e1ee7 [junit4] 2> 408426 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_2DBC4176144E107-001/tempDir-001/shard3/cores [junit4] 2> 408426 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 408498 INFO (coreLoadExecutor-565-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 409314 INFO (coreLoadExecutor-565-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0 [junit4] 2> 409666 INFO (coreLoadExecutor-565-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 410525 INFO (coreLoadExecutor-565-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 410562 INFO (coreLoadExecutor-565-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 410563 INFO (coreLoadExecutor-565-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@2a7e1ee7 [junit4] 2> 410563 INFO (coreLoadExecutor-565-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedFacetPivotSmallTest_2DBC4176144E107-001/tempDir-001/shard3/cores/collection1/data/] [junit4] 2> 410577 INFO (coreLoadExecutor-565-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=34, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 410956 INFO (coreLoadExecutor-565-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 410956 INFO (coreLoadExecutor-565-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 411026 INFO (coreLoadExecutor-565-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 411026 INFO (coreLoadExecutor-565-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 411027 INFO (coreLoadExecutor-565-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1702456529, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1] [junit4] 2> 411028 INFO (coreLoadExecutor-565-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@123faaf3[collection1] main] [junit4] 2> 411028 INFO (coreLoadExecutor-565-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 411137 INFO (coreLoadExecutor-565-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 411430 INFO (coreLoadExecutor-565-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 411430 INFO (coreLoadExecutor-565-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1633119648894418944 [junit4] 2> 411500 INFO (searcherExecutor-566-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 411501 INFO (searcherExecutor-566-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 411501 INFO (searcherExecutor-566-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 411501 INFO (searcherExecutor-566-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 411501 INFO (searcherExecutor-566-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 411501 INFO (searcherExecutor-566-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 411502 INFO (searcherExecutor-566-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 411520 INFO (searcherExecutor-566-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 411520 INFO (searcherExecutor-566-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 411558 INFO (searcherExecutor-566-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@123faaf3[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 411573 INFO (TEST-DistributedFacetPivotSmallTest.test-seed#[2DBC4176144E107]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test [junit4] 2> 411757 INFO (qtp1990798092-1819) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ey/n path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1633119649200603136)} 0 35 [junit4] 2> 412069 INFO (qtp1383735191-1842) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ey/n path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1633119649504690176)} 0 57 [junit4] 2> 412214 INFO (qtp858599053-1866) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ey/n path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1633119649695531008)} 0 19 [junit4] 2> 412378 INFO (qtp1427138910-1886) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ey/n path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1633119649885323264)} 0 51 [junit4] 2> 412525 INFO (qtp1776371273-1910) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ey/n path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1633119650022686720)} 0 18 [junit4] 2> 412653 INFO (qtp1990798092-1816) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ey/n path=/update params={wt=javabin&version=2}{add=[19 (1633119650063581184)]} 0 108 [junit4] 2> 412670 INFO (qtp1427138910-1887) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ey/n path=/update params={wt=javabin&version=2}{add=[19 (1633119650192556032)]} 0 2 [junit4] 2> 412743 INFO (qtp1990798092-1817) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ey/n path=/update params={wt=javabin&version=2}{add=[20 (1633119650230304768)]} 0 39 [junit4] 2> 412851 INFO (qtp1383735191-1843) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ey/n path=/update params={wt=javabin&version=2}{add=[20 (1633119650329919488)]} 0 52 [junit4] 2> 412853 INFO (qtp1990798092-1818) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ey/n path=/update params={wt=javabin&version=2}{add=[21 (1633119650385494016)]} 0 0 [junit4] 2> 412959 INFO (qtp858599053-1862) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ey/n path=/update params={wt=javabin&version=2}{add=[21 (1633119650444214272)]} 0 51 [junit4] 2> 412980 INFO (qtp1990798092-1820) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ey/n path=/update params={wt=javabin&version=2}{add=[22 (1633119650498740224)]} 0 19 [junit4] 2> 412982 INFO (qtp1427138910-1888) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ey/n path=/update params={wt=javabin&version=2}{add=[22 (1633119650520760320)]} 0 1 [junit4] 2> 413033 INFO (qtp1990798092-1819) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ey/n path=/update params={wt=javabin&version=2}{add=[23 (1633119650574237696)]} 0 0 [junit4] 2> 413127 INFO (qtp1776371273-1911) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ey/n path=/update params={wt=javabin&version=2}{add=[23 (1633119650652880896)]} 0 20 [junit4] 2> 413161 INFO (qtp1990798092-1816) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ey/n path=/update params={wt=javabin&version=2}{add=[24 (1633119650674900992)]} 0 33 [junit4] 2> 413178 INFO (qtp1383735191-1839) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ey/n path=/update params={wt=javabin&version=2}{add=[24 (1633119650711601152)]} 0 15 [junit4] 2> 413180 INFO (qtp1990798092-1817) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ey/n path=/update params={wt=javabin&version=2}{add=[25 (1633119650728378368)]} 0 1 [junit4] 2> 413250 INFO (qtp858599053-1863) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ey/n path=/update params={wt=javabin&version=2}{add=[25 (1633119650750398464)]} 0 50 [junit4] 2> 413252 INFO (qtp1990798092-1818) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ey/n path=/update params={wt=javabin&version=2}{add=[26 (1633119650803875840)]} 0 0 [junit4] 2> 413253 INFO (qtp1427138910-1889) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ey/n path=/update params={wt=javabin&version=2}{add=[26 (1633119650805972992)]} 0 0 [junit4] 2> 413361 INFO (qtp1990798092-1820) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ey/n path=/update params={wt=javabin&version=2}{add=[27 (1633119650824847360)]} 0 90 [junit4] 2> 413456 INFO (qtp1776371273-1912) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ey/n path=/update params={wt=javabin&version=2}{add=[27 (1633119650926559232)]} 0 87 [junit4] 2> 413490 INFO (qtp1990798092-1819) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ey/n path=/update params={wt=javabin&version=2}{add=[28 (1633119651054485504)]} 0 1 [junit4] 2> 413493 INFO (qtp1383735191-1840) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ey/n path=/update params={wt=javabin&version=2}{add=[28 (1633119651056582656)]} 0 0 [junit4] 2> 413545 INFO (qtp1990798092-1816) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1633119651112157184,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 413545 INFO (qtp1990798092-1816) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@67f84130 commitCommandVersion:1633119651112157184 [junit4] 2> 414038 INFO (qtp1990798092-1816) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1b5143ee[collection1] main] [junit4] 2> 414039 INFO (qtp1990798092-1816) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 414109 INFO (searcherExecutor-510-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1b5143ee[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=1557464267194}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))} [junit4] 2> 414110 INFO (qtp1990798092-1816) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ey/n path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 565 [junit4] 2> 414126 INFO (qtp1383735191-1841) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1633119651721379840,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 414126 INFO (qtp1383735191-1841) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@57a96755 commitCommandVersion:1633119651721379840 [junit4] 2> 414274 INFO (qtp1383735191-1841) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@646f561f[collection1] main] [junit4] 2> 414291 INFO (qtp1383735191-1841) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 414293 INFO (searcherExecutor-524-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@646f561f[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=1557464267539}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))} [junit4] 2> 414293 INFO (qtp1383735191-1841) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ey/n path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 168 [junit4] 2> 414344 INFO (qtp858599053-1864) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1633119651949969408,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 414344 INFO (qtp858599053-1864) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@3692a2f9 commitCommandVersion:1633119651949969408 [junit4] 2> 414549 INFO (qtp858599053-1864) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@77c69a23[collection1] main] [junit4] 2> 414550 INFO (qtp858599053-1864) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 414585 INFO (searcherExecutor-538-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@77c69a23[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.1.0):C2:[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=1557464267795}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))} [junit4] 2> 414586 INFO (qtp858599053-1864) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ey/n path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 241 [junit4] 2> 414768 INFO (qtp1427138910-1885) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1633119652394565632,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 414768 INFO (qtp1427138910-1885) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@2a13dd1f commitCommandVersion:1633119652394565632 [junit4] 2> 414933 INFO (qtp1427138910-1885) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@8c5e349[collection1] main] [junit4] 2> 414934 INFO (qtp1427138910-1885) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 414949 INFO (searcherExecutor-552-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@8c5e349[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=1557464268181}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))} [junit4] 2> 414949 INFO (qtp1427138910-1885) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ey/n path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 181 [junit4] 2> 414951 INFO (qtp1776371273-1908) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1633119652586455040,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 414951 INFO (qtp1776371273-1908) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@73e28103 commitCommandVersion:1633119652586455040 [junit4] 2> 415366 INFO (qtp1776371273-1908) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@7433ccb8[collection1] main] [junit4] 2> 415366 INFO (qtp1776371273-1908) [ x:collection1] [...truncated too long message...] gs :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/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-Tests-8.1/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-Tests-8.1/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-Tests-8.1/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-Tests-8.1/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-Tests-8.1/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-Tests-8.1/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-Tests-8.1/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-Tests-8.1/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-Tests-8.1/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-Tests-8.1/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-Tests-8.1/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-Tests-8.1/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-Tests-8.1/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-Tests-8.1/lucene/top-level-ivy-settings.xml resolve: jar-checksums: [mkdir] Created dir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/null1334979678 [copy] Copying 239 files to /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/null1334979678 [delete] Deleting directory /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/null1334979678 check-working-copy: [ivy:cachepath] :: resolving dependencies :: #;[email protected] [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 66ms :: artifacts dl 2ms --------------------------------------------------------------------- | | modules || artifacts | | conf | number| search|dwnlded|evicted|| number|dwnlded| --------------------------------------------------------------------- | default | 9 | 0 | 0 | 0 || 9 | 0 | --------------------------------------------------------------------- [wc-checker] Initializing working copy... [wc-checker] Checking working copy status... -jenkins-base: BUILD SUCCESSFUL Total time: 227 minutes 28 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: [email protected] For additional commands, e-mail: [email protected]
