lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Apache Jenkins Server <jenk...@builds.apache.org>
Subject [JENKINS] Lucene-Solr-NightlyTests-master - Build # 1746 - Still Failing
Date Wed, 09 Jan 2019 11:25:35 GMT
Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-master/1746/

1 tests failed.
FAILED:  org.apache.solr.TestDistributedSearch.test

Error Message:


Stack Trace:
java.lang.NullPointerException
	at __randomizedtesting.SeedInfo.seed([362C6D8DDAF5E9A:8B36F90273533362]:0)
	at org.apache.solr.TestDistributedSearch.test(TestDistributedSearch.java:596)
	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$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:1096)
	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1042)
	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 13700 lines...]
   [junit4] Suite: org.apache.solr.TestDistributedSearch
   [junit4]   2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_362C6D8DDAF5E9A-001/init-core-data-001
   [junit4]   2> 520398 WARN  (SUITE-TestDistributedSearch-seed#[362C6D8DDAF5E9A]-worker) [    ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=65 numCloses=65
   [junit4]   2> 520398 INFO  (SUITE-TestDistributedSearch-seed#[362C6D8DDAF5E9A]-worker) [    ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 520401 INFO  (SUITE-TestDistributedSearch-seed#[362C6D8DDAF5E9A]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=https://issues.apache.org/jira/browse/SOLR-9061)
   [junit4]   2> 520401 INFO  (SUITE-TestDistributedSearch-seed#[362C6D8DDAF5E9A]-worker) [    ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 520401 INFO  (SUITE-TestDistributedSearch-seed#[362C6D8DDAF5E9A]-worker) [    ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
   [junit4]   2> 520587 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_362C6D8DDAF5E9A-001/tempDir-001/control/cores/collection1
   [junit4]   2> 520589 WARN  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 520589 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 520589 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 520589 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] 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> 520599 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 520599 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 520599 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 520600 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2392f619{/,null,AVAILABLE}
   [junit4]   2> 520601 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@25c4b8b3{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:41424}
   [junit4]   2> 520602 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.e.j.s.Server Started @520702ms
   [junit4]   2> 520602 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=41424, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_362C6D8DDAF5E9A-001/tempDir-001/control/cores}
   [junit4]   2> 520602 ERROR (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 520602 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 520602 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 9.0.0
   [junit4]   2> 520602 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 520602 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 520602 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2019-01-09T09:59:27.442Z
   [junit4]   2> 520603 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_362C6D8DDAF5E9A-001/tempDir-001/control/solr.xml
   [junit4]   2> 520610 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 520610 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 520613 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@21fab7a3, but no JMX reporters were configured - adding default JMX reporter.
   [junit4]   2> 520744 WARN  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@6baa69d0[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 520749 WARN  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@2f1a39c5[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 520781 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 520781 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 520809 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@21fab7a3
   [junit4]   2> 520823 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@21fab7a3
   [junit4]   2> 520823 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@21fab7a3
   [junit4]   2> 520825 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_362C6D8DDAF5E9A-001/tempDir-001/control/cores
   [junit4]   2> 520825 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 520826 INFO  (coreLoadExecutor-1547-thread-1) [    x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 520875 INFO  (coreLoadExecutor-1547-thread-1) [    x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
   [junit4]   2> 520902 INFO  (coreLoadExecutor-1547-thread-1) [    x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 521038 INFO  (coreLoadExecutor-1547-thread-1) [    x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 521049 INFO  (coreLoadExecutor-1547-thread-1) [    x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1, trusted=true
   [junit4]   2> 521049 INFO  (coreLoadExecutor-1547-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@21fab7a3
   [junit4]   2> 521049 INFO  (coreLoadExecutor-1547-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_362C6D8DDAF5E9A-001/tempDir-001/control/cores/collection1/data/]
   [junit4]   2> 521051 INFO  (coreLoadExecutor-1547-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=47, maxMergedSegmentMB=51.759765625, floorSegmentMB=1.2939453125, forceMergeDeletesPctAllowed=0.7379600603557568, segmentsPerTier=18.0, maxCFSSegmentSizeMB=1.693359375, noCFSRatio=0.2973747530521602, deletesPctAllowed=40.87297584024827
   [junit4]   2> 521138 INFO  (coreLoadExecutor-1547-thread-1) [    x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 521138 INFO  (coreLoadExecutor-1547-thread-1) [    x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 521140 INFO  (coreLoadExecutor-1547-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 521141 INFO  (coreLoadExecutor-1547-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 521142 INFO  (coreLoadExecutor-1547-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=47, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.12375418416298666]
   [junit4]   2> 521142 INFO  (coreLoadExecutor-1547-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@14e5ddc8[collection1] main]
   [junit4]   2> 521143 INFO  (coreLoadExecutor-1547-thread-1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 521152 INFO  (coreLoadExecutor-1547-thread-1) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 521199 INFO  (coreLoadExecutor-1547-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 521199 INFO  (coreLoadExecutor-1547-thread-1) [    x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1622176398614462464
   [junit4]   2> 521201 INFO  (searcherExecutor-1548-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 521202 INFO  (searcherExecutor-1548-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 521202 INFO  (searcherExecutor-1548-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 521202 INFO  (searcherExecutor-1548-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 521202 INFO  (searcherExecutor-1548-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 521202 INFO  (searcherExecutor-1548-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 521203 INFO  (searcherExecutor-1548-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 521203 INFO  (searcherExecutor-1548-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 521204 INFO  (searcherExecutor-1548-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 521206 INFO  (searcherExecutor-1548-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@14e5ddc8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 521872 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_362C6D8DDAF5E9A-001/tempDir-001/shard0/cores/collection1
   [junit4]   2> 521873 WARN  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 521873 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 521873 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 521873 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] 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> 521874 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 521875 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 521875 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 521875 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1c6eb769{/,null,AVAILABLE}
   [junit4]   2> 521876 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@2cb4b2f5{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:35414}
   [junit4]   2> 521876 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.e.j.s.Server Started @521976ms
   [junit4]   2> 521876 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=35414, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_362C6D8DDAF5E9A-001/tempDir-001/shard0/cores}
   [junit4]   2> 521876 ERROR (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 521876 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 521876 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 9.0.0
   [junit4]   2> 521876 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 521876 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 521876 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2019-01-09T09:59:28.716Z
   [junit4]   2> 521877 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_362C6D8DDAF5E9A-001/tempDir-001/shard0/solr.xml
   [junit4]   2> 521882 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 521882 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 521883 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@21fab7a3, but no JMX reporters were configured - adding default JMX reporter.
   [junit4]   2> 522071 WARN  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@6cd53c0c[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 522081 WARN  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@363e7752[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 522109 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 522109 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 522135 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@21fab7a3
   [junit4]   2> 522151 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@21fab7a3
   [junit4]   2> 522151 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@21fab7a3
   [junit4]   2> 522154 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_362C6D8DDAF5E9A-001/tempDir-001/shard0/cores
   [junit4]   2> 522154 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 522155 INFO  (coreLoadExecutor-1561-thread-1) [    x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 522204 INFO  (coreLoadExecutor-1561-thread-1) [    x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
   [junit4]   2> 522229 INFO  (coreLoadExecutor-1561-thread-1) [    x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 522367 INFO  (coreLoadExecutor-1561-thread-1) [    x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 522377 INFO  (coreLoadExecutor-1561-thread-1) [    x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1, trusted=true
   [junit4]   2> 522377 INFO  (coreLoadExecutor-1561-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@21fab7a3
   [junit4]   2> 522378 INFO  (coreLoadExecutor-1561-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_362C6D8DDAF5E9A-001/tempDir-001/shard0/cores/collection1/data/]
   [junit4]   2> 522380 INFO  (coreLoadExecutor-1561-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=47, maxMergedSegmentMB=51.759765625, floorSegmentMB=1.2939453125, forceMergeDeletesPctAllowed=0.7379600603557568, segmentsPerTier=18.0, maxCFSSegmentSizeMB=1.693359375, noCFSRatio=0.2973747530521602, deletesPctAllowed=40.87297584024827
   [junit4]   2> 522477 INFO  (coreLoadExecutor-1561-thread-1) [    x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 522477 INFO  (coreLoadExecutor-1561-thread-1) [    x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 522480 INFO  (coreLoadExecutor-1561-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 522480 INFO  (coreLoadExecutor-1561-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 522481 INFO  (coreLoadExecutor-1561-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=47, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.12375418416298666]
   [junit4]   2> 522482 INFO  (coreLoadExecutor-1561-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@23fe232b[collection1] main]
   [junit4]   2> 522483 INFO  (coreLoadExecutor-1561-thread-1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 522493 INFO  (coreLoadExecutor-1561-thread-1) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 522531 INFO  (coreLoadExecutor-1561-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 522531 INFO  (coreLoadExecutor-1561-thread-1) [    x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1622176400011165696
   [junit4]   2> 522533 INFO  (searcherExecutor-1562-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 522534 INFO  (searcherExecutor-1562-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 522534 INFO  (searcherExecutor-1562-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 522534 INFO  (searcherExecutor-1562-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 522534 INFO  (searcherExecutor-1562-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 522535 INFO  (searcherExecutor-1562-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 522535 INFO  (searcherExecutor-1562-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 522535 INFO  (searcherExecutor-1562-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 522536 INFO  (searcherExecutor-1562-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 522538 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 522540 INFO  (searcherExecutor-1562-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@23fe232b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 522555 INFO  (qtp2121296646-8670) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1622176400021651456)} 0 14
   [junit4]   2> 522567 INFO  (qtp151567408-8692) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1622176400038428672)} 0 10
   [junit4]   2> 522595 INFO  (qtp2121296646-8671) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[1 (1622176400051011584)]} 0 27
   [junit4]   2> 522601 INFO  (qtp151567408-8693) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[1 (1622176400079323136)]} 0 4
   [junit4]   2> 522603 INFO  (qtp2121296646-8672) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[2 (1622176400084566016)]} 0 1
   [junit4]   2> 522611 INFO  (qtp151567408-8694) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[2 (1622176400094003200)]} 0 1
   [junit4]   2> 522613 INFO  (qtp2121296646-8673) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[3 (1622176400096100352)]} 0 0
   [junit4]   2> 522614 INFO  (qtp151567408-8695) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[3 (1622176400097148928)]} 0 1
   [junit4]   2> 522616 INFO  (qtp2121296646-8674) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[4 (1622176400099246080)]} 0 1
   [junit4]   2> 522618 INFO  (qtp151567408-8691) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[4 (1622176400100294656)]} 0 1
   [junit4]   2> 522619 INFO  (qtp2121296646-8670) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[5 (1622176400102391808)]} 0 0
   [junit4]   2> 522620 INFO  (qtp151567408-8692) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[5 (1622176400103440384)]} 0 0
   [junit4]   2> 522632 INFO  (qtp2121296646-8671) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[6 (1622176400105537536)]} 0 11
   [junit4]   2> 522634 INFO  (qtp151567408-8693) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[6 (1622176400118120448)]} 0 0
   [junit4]   2> 522635 INFO  (qtp2121296646-8672) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[7 (1622176400120217600)]} 0 0
   [junit4]   2> 522637 INFO  (qtp151567408-8694) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[7 (1622176400121266176)]} 0 0
   [junit4]   2> 522638 INFO  (qtp2121296646-8673) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[8 (1622176400122314752)]} 0 1
   [junit4]   2> 522640 INFO  (qtp151567408-8695) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[8 (1622176400124411904)]} 0 1
   [junit4]   2> 522641 INFO  (qtp2121296646-8674) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[9 (1622176400125460480)]} 0 0
   [junit4]   2> 522642 INFO  (qtp151567408-8691) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[9 (1622176400127557632)]} 0 0
   [junit4]   2> 522643 INFO  (qtp2121296646-8670) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1622176400128606208,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 522643 INFO  (qtp2121296646-8670) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@2e67ffd2 commitCommandVersion:1622176400128606208
   [junit4]   2> 522666 INFO  (qtp2121296646-8670) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@74cdcf56[collection1] main]
   [junit4]   2> 522669 INFO  (searcherExecutor-1548-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@74cdcf56[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):c9:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=9.0.0, os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.4.0-137-generic, timestamp=1547027969498}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
   [junit4]   2> 522669 INFO  (qtp2121296646-8670) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 522669 INFO  (qtp2121296646-8670) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 26
   [junit4]   2> 522670 INFO  (qtp151567408-8692) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1622176400156917760,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 522670 INFO  (qtp151567408-8692) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@116b6b69 commitCommandVersion:1622176400156917760
   [junit4]   2> 522682 INFO  (qtp151567408-8692) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@3e78b7ba[collection1] main]
   [junit4]   2> 522685 INFO  (searcherExecutor-1562-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3e78b7ba[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):c9:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=9.0.0, os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.4.0-137-generic, timestamp=1547027969517}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
   [junit4]   2> 522685 INFO  (qtp151567408-8692) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 522685 INFO  (qtp151567408-8692) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 15
   [junit4]   2> 522690 INFO  (qtp2121296646-8671) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[10 (1622176400173694976)]} 0 4
   [junit4]   2> 522692 INFO  (qtp151567408-8693) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[10 (1622176400178937856)]} 0 1
   [junit4]   2> 522696 INFO  (qtp2121296646-8672) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[11 (1622176400181035008)]} 0 2
   [junit4]   2> 522699 INFO  (qtp151567408-8694) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[11 (1622176400184180736)]} 0 2
   [junit4]   2> 522700 INFO  (qtp2121296646-8673) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[12 (1622176400188375040)]} 0 0
   [junit4]   2> 522701 INFO  (qtp151567408-8695) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[12 (1622176400189423616)]} 0 0
   [junit4]   2> 522702 INFO  (qtp2121296646-8674) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[13 (1622176400190472192)]} 0 0
   [junit4]   2> 522703 INFO  (qtp151567408-8691) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[13 (1622176400191520768)]} 0 0
   [junit4]   2> 522705 INFO  (qtp2121296646-8670) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[1001 (1622176400192569344)]} 0 1
   [junit4]   2> 522707 INFO  (qtp151567408-8692) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[1001 (1622176400194666496)]} 0 1
   [junit4]   2> 522708 INFO  (qtp2121296646-8671) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[14 (1622176400196763648)]} 0 0
   [junit4]   2> 522709 INFO  (qtp151567408-8693) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[14 (1622176400197812224)]} 0 0
   [junit4]   2> 522710 INFO  (qtp2121296646-8672) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[15 (1622176400198860800)]} 0 0
   [junit4]   2> 522711 INFO  (qtp151567408-8694) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[15 (1622176400199909376)]} 0 0
   [junit4]   2> 522712 INFO  (qtp2121296646-8673) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[16 (1622176400200957952)]} 0 0
   [junit4]   2> 522713 INFO  (qtp151567408-8695) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[16 (1622176400202006528)]} 0 0
   [junit4]   2> 522715 INFO  (qtp2121296646-8674) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[17 (1622176400203055104)]} 0 0
   [junit4]   2> 522716 INFO  (qtp151567408-8691) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[17 (1622176400204103680)]} 0 0
   [junit4]   2> 522717 INFO  (qtp2121296646-8670) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[100 (1622176400206200832)]} 0 0
   [junit4]   2> 522718 INFO  (qtp151567408-8693) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[100 (1622176400206200832)]} 0 0
   [junit4]   2> 522719 INFO  (qtp2121296646-8671) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[101 (1622176400207249408)]} 0 0
   [junit4]   2> 522720 INFO  (qtp151567408-8692) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[101 (1622176400208297984)]} 0 0
   [junit4]   2> 522721 INFO  (qtp2121296646-8672) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[102 (1622176400209346560)]} 0 0
   [junit4]   2> 522722 INFO  (qtp151567408-8694) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[102 (1622176400210395136)]} 0 0
   [junit4]   2> 522723 INFO  (qtp2121296646-8673) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[103 (1622176400211443712)]} 0 0
   [junit4]   2> 522724 INFO  (qtp151567408-8695) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[103 (1622176400212492288)]} 0 0
   [junit4]   2> 522725 INFO  (qtp2121296646-8674) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[104 (1622176400213540864)]} 0 0
   [junit4]   2> 522726 INFO  (qtp151567408-8691) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[104 (1622176400214589440)]} 0 0
   [junit4]   2> 522727 INFO  (qtp2121296646-8670) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[105 (1622176400215638016)]} 0 0
   [junit4]   2> 522728 INFO  (qtp151567408-8693) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[105 (1622176400216686592)]} 0 0
   [junit4]   2> 522729 INFO  (qtp2121296646-8671) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[106 (1622176400217735168)]} 0 0
   [junit4]   2> 522730 INFO  (qtp151567408-8692) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[106 (1622176400218783744)]} 0 0
   [junit4]   2> 522731 INFO  (qtp2121296646-8672) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[107 (1622176400220880896)]} 0 0
   [junit4]   2> 522732 INFO  (qtp151567408-8694) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[107 (1622176400221929472)]} 0 0
   [junit4]   2> 522733 INFO  (qtp2121296646-8673) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[108 (1622176400222978048)]} 0 0
   [junit4]   2> 522734 INFO  (qtp151567408-8695) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[108 (1622176400224026624)]} 0 0
   [junit4]   2> 522735 INFO  (qtp2121296646-8674) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[109 (1622176400225075200)]} 0 0
   [junit4]   2> 522736 INFO  (qtp151567408-8691) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[109 (1622176400226123776)]} 0 0
   [junit4]   2> 522737 INFO  (qtp2121296646-8670) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[110 (1622176400227172352)]} 0 0
   [junit4]   2> 522738 INFO  (qtp151567408-8693) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[110 (1622176400228220928)]} 0 0
   [junit4]   2> 522739 INFO  (qtp2121296646-8671) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[111 (1622176400229269504)]} 0 0
   [junit4]   2> 522740 INFO  (qtp151567408-8692) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[111 (1622176400230318080)]} 0 0
   [junit4]   2> 522741 INFO  (qtp2121296646-8672) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[112 (1622176400231366656)]} 0 0
   [junit4]   2> 522742 INFO  (qtp151567408-8694) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[112 (1622176400231366656)]} 0 0
   [junit4]   2> 522743 INFO  (qtp2121296646-8673) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[113 (1622176400233463808)]} 0 0
   [junit4]   2> 522744 INFO  (qtp151567408-8695) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[113 (1622176400233463808)]} 0 0
   [junit4]   2> 522745 INFO  (qtp2121296646-8674) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[114 (1622176400234512384)]} 0 0
   [junit4]   2> 522746 INFO  (qtp151567408-8691) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[114 (1622176400235560960)]} 0 0
   [junit4]   2> 522747 INFO  (qtp2121296646-8670) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[115 (1622176400237658112)]} 0 0
   [junit4]   2> 522748 INFO  (qtp151567408-8693) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[115 (1622176400238706688)]} 0 0
   [junit4]   2> 522749 INFO  (qtp2121296646-8671) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[116 (1622176400239755264)]} 0 0
   [junit4]   2> 522750 INFO  (qtp151567408-8692) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[116 (1622176400240803840)]} 0 0
   [junit4]   2> 522751 INFO  (qtp2121296646-8672) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[117 (1622176400241852416)]} 0 0
   [junit4]   2> 522752 INFO  (qtp151567408-8694) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[117 (1622176400242900992)]} 0 0
   [junit4]   2> 522753 INFO  (qtp2121296646-8673) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[118 (1622176400243949568)]} 0 0
   [junit4]   2> 522754 INFO  (qtp151567408-8695) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[118 (1622176400243949568)]} 0 0
   [junit4]   2> 522755 INFO  (qtp2121296646-8674) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[119 (1622176400246046720)]} 0 0
   [junit4]   2> 522756 INFO  (qtp151567408-8691) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[119 (1622176400246046720)]} 0 0
   [junit4]   2> 522757 INFO  (qtp2121296646-8670) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[120 (1622176400247095296)]} 0 0
   [junit4]   2> 522758 INFO  (qtp151567408-8693) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[120 (1622176400248143872)]} 0 0
   [junit4]   2> 522759 INFO  (qtp2121296646-8671) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[121 (1622176400250241024)]} 0 0
   [junit4]   2> 522760 INFO  (qtp151567408-8692) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[121 (1622176400250241024)]} 0 0
   [junit4]   2> 522761 INFO  (qtp2121296646-8672) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[122 (1622176400251289600)]} 0 0
   [junit4]   2> 522762 INFO  (qtp151567408-8694) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[122 (1622176400252338176)]} 0 0
   [junit4]   2> 522763 INFO  (qtp2121296646-8673) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[123 (1622176400254435328)]} 0 0
   [junit4]   2> 522764 INFO  (qtp151567408-8695) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[123 (1622176400254435328)]} 0 0
   [junit4]   2> 522765 INFO  (qtp2121296646-8674) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[124 (1622176400255483904)]} 0 0
   [junit4]   2> 522766 INFO  (qtp151567408-8691) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[124 (1622176400257581056)]} 0 0
   [junit4]   2> 522767 INFO  (qtp2121296646-8670) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[125 (1622176400258629632)]} 0 0
   [junit4]   2> 522768 INFO  (qtp151567408-8693) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[125 (1622176400258629632)]} 0 0
   [junit4]   2> 522769 INFO  (qtp2121296646-8671) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[126 (1622176400259678208)]} 0 0
   [junit4]   2> 522770 INFO  (qtp151567408-8692) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[126 (1622176400260726784)]} 0 0
   [junit4]   2> 522771 INFO  (qtp2121296646-8672) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[127 (1622176400261775360)]} 0 0
   [junit4]   2> 522772 INFO  (qtp151567408-8694) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[127 (1622176400262823936)]} 0 0
   [junit4]   2> 522773 INFO  (qtp2121296646-8673) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[128 (1622176400263872512)]} 0 0
   [junit4]   2> 522774 INFO  (qtp151567408-8695) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[128 (1622176400264921088)]} 0 0
   [junit4]   2> 522775 INFO  (qtp2121296646-8674) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[129 (1622176400265969664)]} 0 0
   [junit4]   2> 522776 INFO  (qtp151567408-8691) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[129 (1622176400267018240)]} 0 0
   [junit4]   2> 522777 INFO  (qtp2121296646-8670) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[130 (1622176400268066816)]} 0 0
   [junit4]   2> 522778 INFO  (qtp151567408-8693) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[130 (1622176400269115392)]} 0 0
   [junit4]   2> 522778 INFO  (qtp2121296646-8671) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[131 (1622176400270163968)]} 0 0
   [junit4]   2> 522779 INFO  (qtp151567408-8692) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[131 (1622176400271212544)]} 0 0
   [junit4]   2> 522780 INFO  (qtp2121296646-8672) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[132 (1622176400272261120)]} 0 0
   [junit4]   2> 522781 INFO  (qtp151567408-8694) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[132 (1622176400273309696)]} 0 0
   [junit4]   2> 522782 INFO  (qtp2121296646-8673) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[133 (1622176400274358272)]} 0 0
   [junit4]   2> 522783 INFO  (qtp151567408-8695) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[133 (1622176400275406848)]} 0 0
   [junit4]   2> 522784 INFO  (qtp2121296646-8674) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[134 (1622176400276455424)]} 0 0
   [junit4]   2> 522785 INFO  (qtp151567408-8691) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[134 (1622176400277504000)]} 0 0
   [junit4]   2> 522786 INFO  (qtp2121296646-8670) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[135 (1622176400278552576)]} 0 0
   [junit4]   2> 522787 INFO  (qtp151567408-8693) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[135 (1622176400279601152)]} 0 0
   [junit4]   2> 522788 INFO  (qtp2121296646-8671) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[136 (1622176400280649728)]} 0 0
   [junit4]   2> 522789 INFO  (qtp151567408-8692) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[136 (1622176400280649728)]} 0 1
   [junit4]   2> 522794 INFO  (qtp2121296646-8672) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[137 (1622176400286941184)]} 0 0
   [junit4]   2> 522795 INFO  (qtp151567408-8694) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[137 (1622176400287989760)]} 0 0
   [junit4]   2> 522796 INFO  (qtp2121296646-8673) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[138 (1622176400289038336)]} 0 0
   [junit4]   2> 522797 INFO  (qtp151567408-8695) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[138 (1622176400290086912)]} 0 0
   [junit4]   2> 522798 INFO  (qtp2121296646-8674) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[139 (1622176400291135488)]} 0 0
   [junit4]   2> 522799 INFO  (qtp151567408-8691) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[139 (1622176400292184064)]} 0 0
   [junit4]   2> 522801 INFO  (qtp2121296646-8670) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[140 (1622176400293232640)]} 0 1
   [junit4]   2> 522802 INFO  (qtp151567408-8693) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[140 (1622176400294281216)]} 0 0
   [junit4]   2> 522803 INFO  (qtp2121296646-8671) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[141 (1622176400295329792)]} 0 0
   [junit4]   2> 522804 INFO  (qtp151567408-8692) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[141 (1622176400296378368)]} 0 0
   [junit4]   2> 522805 INFO  (qtp2121296646-8672) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[142 (1622176400297426944)]} 0 0
   [junit4]   2> 522806 INFO  (qtp151567408-8694) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[142 (1622176400298475520)]} 0 0
   [junit4]   2> 522807 INFO  (qtp2121296646-8673) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[143 (1622176400299524096)]} 0 0
   [junit4]   2> 522808 INFO  (qtp151567408-8695) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[143 (1622176400300572672)]} 0 0
   [junit4]   2> 522808 INFO  (qtp2121296646-8674) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[144 (1622176400301621248)]} 0 0
   [junit4]   2> 522809 INFO  (qtp151567408-8691) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[144 (1622176400302669824)]} 0 0
   [junit4]   2> 522810 INFO  (qtp2121296646-8670) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[145 (1622176400303718400)]} 0 0
   [junit4]   2> 522811 INFO  (qtp151567408-8693) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[145 (1622176400304766976)]} 0 0
   [junit4]   2> 522812 INFO  (qtp2121296646-8671) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[146 (1622176400305815552)]} 0 0
   [junit4]   2> 522813 INFO  (qtp151567408-8692) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[146 (1622176400306864128)]} 0 0
   [junit4]   2> 522814 INFO  (qtp2121296646-8672) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[147 (1622176400307912704)]} 0 0
   [junit4]   2> 522815 INFO  (qtp151567408-8694) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[147 (1622176400307912704)]} 0 0
   [junit4]   2> 522816 INFO  (qtp2121296646-8673) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[148 (1622176400308961280)]} 0 0
   [junit4]   2> 522817 INFO  (qtp151567408-8695) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[148 (1622176400310009856)]} 0 0
   [junit4]   2> 522818 INFO  (qtp2121296646-8674) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[149 (1622176400311058432)]} 0 0
   [junit4]   2> 522818 INFO  (qtp151567408-8691) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[149 (1622176400312107008)]} 0 0
   [junit4]   2> 522819 INFO  (qtp2121296646-8670) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1622176400313155584,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 522819 INFO  (qtp2121296646-8670) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@2e67ffd2 commitCommandVersion:1622176400313155584
   [junit4]   2> 522836 INFO  (qtp2121296646-8670) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@60a6cf32[collection1] main]
   [junit4]   2> 522839 INFO  (searcherExecutor-1548-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@60a6cf32[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):c9:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=9.0.0, os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.4.0-137-generic, timestamp=1547027969498}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_1(9.0.0):c59:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=9.0.0, os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.4.0-137-generic, timestamp=1547027969673}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
   [junit4]   2> 522839 INFO  (qtp2121296646-8670) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 522839 INFO  (qtp2121296646-8670) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 20
   [junit4]   2> 522840 INFO  (qtp151567408-8693) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1622176400335175680,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 522843 INFO  (qtp151567408-8693) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@116b6b69 commitCommandVersion:1622176400335175680
   [junit4]   2> 522862 INFO  (qtp151567408-8693) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1198cd4f[collection1] main]
   [junit4]   2> 522865 INFO  (searcherExecutor-1562-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1198cd4f[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):c9:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=9.0.0, os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.4.0-137-generic, timestamp=1547027969517}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_1(9.0.0):c59:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=9.0.0, os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.4.0-137-generic, timestamp=1547027969695}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
   [junit4]   2> 522865 INFO  (qtp151567408-8693) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 522866 INFO  (qtp151567408-8693) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 25
   [junit4]   2> 522868 ERROR (qtp2121296646-8671) [    x:collection1] o.a.s.h.RequestHandlerBase org.apache.solr.common.SolrException: For input string: "non_numeric_value"
   [junit4]   2> 	at org.apache.solr.common.params.SolrParams.getInt(SolrParams.java:236)
   [junit4]   2> 	at org.apache.solr.search.QParser.getSortSpec(QParser.java:270)
   [junit4]   2> 	at org.apache.solr.handler.component.QueryComponent.prepare(QueryComponent.java:185)
   [junit4]   2> 	at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:272)
   [junit4]   2> 	at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:199)
   [junit4]   2> 	at org.apache.solr.core.SolrCore.execute(SolrCore.java:2556)
   [junit4]   2> 	at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:711)
   [junit4]   2> 	at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:516)
   [junit4]   2> 	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:394)
   [junit4]   2> 	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:340)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1610)
   [junit4]   2> 	at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:164)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1610)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:540)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1588)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1345)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:203)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:480)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1557)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:201)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1247)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:144)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:753)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132)
   [junit4]   2> 	at org.eclipse.jetty.server.Server.handle(Server.java:502)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:364)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:260)
   [junit4]   2> 	at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:305)
   [junit4]   2> 	at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103)
   [junit4]   2> 	at org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:118)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:765)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:683)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> Caused by: java.lang.NumberFormatException: For input string: "non_numeric_value"
   [junit4]   2> 	at java.lang.NumberFormatException.forInputString(NumberFormatException.java:65)
   [junit4]   2> 	at java.lang.Integer.parseInt(Integer.java:580)
   [junit4]   2> 	at java.lang.Integer.valueOf(Integer.java:766)
   [junit4]   2> 	at org.apache.solr.common.params.SolrParams.getInt(SolrParams.java:233)
   [junit4]   2> 	... 34 more
   [junit4]   2> 
   [junit4]   2> 522868 INFO  (qtp2121296646-8671) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*&distrib=false&start=non_numeric_value&wt=javabin&version=2} status=400 QTime=0
   [junit4]   2> 522869 INFO  (qtp2121296646-8672) [    x:collection1] o.a.s.h.RequestHandlerBase Ignoring exception matching parameter cannot be negative
   [junit4]   2> 522869 INFO  (qtp2121296646-8672) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*&distrib=false&start=-1&wt=javabin&version=2} status=400 QTime=0
   [junit4]   2> 522870 INFO  (qtp2121296646-8673) [    x:collection1] o.a.s.h.RequestHandlerBase Ignoring exception matching parameter cannot be negative
   [junit4]   2> 522871 INFO  (qtp2121296646-8673) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*&distrib=false&start=0&rows=-1&wt=javabin&version=2} status=400 QTime=0
   [junit4]   2> 522872 ERROR (qtp2121296646-8674) [    x:collection1] o.a.s.h.RequestHandlerBase org.apache.solr.common.SolrException: For input string: "non_numeric_value"
   [junit4]   2> 	at org.apache.solr.common.params.SolrParams.getInt(SolrParams.java:236)
   [junit4]   2> 	at org.apache.solr.search.QParser.getSortSpec(QParser.java:273)
   [junit4]   2> 	at org.apache.solr.handler.component.QueryComponent.prepare(QueryComponent.java:185)
   [junit4]   2> 	at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:272)
   [junit4]   2> 	at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:199)
   [junit4]   2> 	at org.apache.solr.core.SolrCore.execute(SolrCore.java:2556)
   [junit4]   2> 	at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:711)
   [junit4]   2> 	at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:516)
   [junit4]   2> 	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:394)
   [junit4]   2> 	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:340)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1610)
   [junit4]   2> 	at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:164)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1610)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:540)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1588)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1345)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:203)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:480)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1557)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:201)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1247)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:144)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:753)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132)
   [junit4]   2> 	at org.eclipse.jetty.server.Server.handle(Server.java:502)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:364)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:260)
   [junit4]   2> 	at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:305)
   [junit4]   2> 	at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103)
   [junit4]   2> 	at org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:118)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:765)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:683)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> Caused by: java.lang.NumberFormatException: For input string: "non_numeric_value"
   [junit4]   2> 	at java.lang.NumberFormatException.forInputString(NumberFormatException.java:65)
   [junit4]   2> 	at java.lang.Integer.parseInt(Integer.java:580)
   [junit4]   2> 	at java.lang.Integer.valueOf(Integer.java:766)
   [junit4]   2> 	at org.apache.solr.common.params.SolrParams.getInt(SolrParams.java:233)
   [junit4]   2> 	... 34 more
   [junit4]   2> 
   [junit4]   2> 522873 INFO  (qtp2121296646-8674) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*&distrib=false&rows=non_numeric_value&wt=javabin&version=2} status=400 QTime=2
   [junit4]   2> 522875 INFO  (qtp2121296646-8670) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_ti1+desc&wt=javabin&version=2} hits=68 status=0 QTime=1
   [junit4]   2> 522941 INFO  (qtp151567408-8691) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+desc&shard.url=[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1&rows=10&version=2&q=*:*&NOW=1547027969719&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 522946 INFO  (qtp151567408-8693) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1547027969719&ids=122,14,146,126,16,1001,129,108,119,130&isShard=true&shard.url=[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 522948 INFO  (qtp151567408-8692) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1&sort=n_ti1+desc&wt=javabin&version=2} hits=68 status=0 QTime=69
   [junit4]   2> 522952 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.BaseDistributedSearchTestCase starting stress...
   [junit4]   2> 522960 INFO  (qtp151567408-8695) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+desc&shard.url=[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1&rows=10&version=2&q=*:*&NOW=1547027969796&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 522963 INFO  (qtp151567408-8692) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1547027969796&ids=122,14,146,126,16,1001,129,108,119,130&isShard=true&shard.url=[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 522964 INFO  (qtp151567408-8694) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1&sort=n_ti1+desc&wt=javabin&version=2} hits=68 status=0 QTime=8
   [junit4]   2> 522968 INFO  (qtp151567408-8694) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+desc&shard.url=[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1&rows=10&version=2&q=*:*&NOW=1547027969806&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 522969 INFO  (qtp151567408-8695) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1547027969806&ids=122,14,146,126,16,1001,129,108,119,130&isShard=true&shard.url=[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 522970 INFO  (qtp151567408-8691) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1&sort=n_ti1+desc&wt=javabin&version=2} hits=68 status=0 QTime=4
   [junit4]   2> 522973 INFO  (qtp151567408-8695) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+desc&shard.url=[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1&rows=10&version=2&q=*:*&NOW=1547027969812&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 522974 INFO  (qtp151567408-8691) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1547027969812&ids=122,14,146,126,16,1001,129,108,119,130&isShard=true&shard.url=[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 522976 INFO  (qtp151567408-8694) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1&sort=n_ti1+desc&wt=javabin&version=2} hits=68 status=0 QTime=3
   [junit4]   2> 522979 INFO  (qtp151567408-8695) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+desc&shard.url=[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1&rows=10&version=2&q=*:*&NOW=1547027969807&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 522991 INFO  (qtp151567408-8691) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+desc&shard.url=[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1&rows=10&version=2&q=*:*&NOW=1547027969801&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 522992 INFO  (qtp151567408-8694) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1547027969807&ids=122,14,146,126,16,1001,129,108,119,130&isShard=true&shard.url=[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 522993 INFO  (qtp151567408-8692) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1&sort=n_ti1+desc&wt=javabin&version=2} hits=68 status=0 QTime=26
   [junit4]   2> 522995 INFO  (qtp151567408-8695) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1547027969801&ids=122,14,146,126,16,1001,129,108,119,130&isShard=true&shard.url=[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 522996 INFO  (qtp151567408-8693) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1&sort=n_ti1+desc&wt=javabin&version=2} hits=68 status=0 QTime=34
   [junit4]   2> 522998 INFO  (qtp151567408-8694) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+desc&shard.url=[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1&rows=10&version=2&q=*:*&NOW=1547027969837&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 523000 INFO  (qtp151567408-8692) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1547027969837&ids=122,14,146,126,16,1001,129,108,119,130&isShard=true&shard.url=[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 523001 INFO  (qtp151567408-8691) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1&sort=n_ti1+desc&wt=javabin&version=2} hits=68 status=0 QTime=3
   [junit4]   2> 523003 INFO  (qtp2121296646-8671) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&sort=n_ti1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 523053 INFO  (qtp151567408-8693) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+asc&shard.url=[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1|[ff01::114]:33332/&rows=10&version=2&q=*:*&NOW=1547027969845&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 523056 INFO  (qtp151567408-8694) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1547027969845&ids=144,1,113,124,147,148,107,141,10,120&isShard=true&shard.url=[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1|[ff01::114]:33332/&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 523058 INFO  (qtp151567408-8695) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1|[ff01::114]:33332/&sort=n_ti1+asc&wt=javabin&version=2} hits=68 status=0 QTime=53
   [junit4]   2> 523059 INFO  (TEST-TestDistributedSearch.test-seed#[362C6D8DDAF5E9A]) [    ] o.a.s.BaseDistributedSearchTestCase starting stress...
   [junit4]   2> 523067 INFO  (qtp151567408-8691) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+asc&shard.url=[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1|[ff01::114]:33332/&rows=10&version=2&q=*:*&NOW=1547027969905&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 523068 INFO  (qtp151567408-8693) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1547027969905&ids=144,1,113,124,147,148,107,141,10,120&isShard=true&shard.url=[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1|[ff01::114]:33332/&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 523070 INFO  (qtp151567408-8692) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1|[ff01::114]:33332/&sort=n_ti1+asc&wt=javabin&version=2} hits=68 status=0 QTime=4
   [junit4]   2> 523075 INFO  (qtp151567408-8695) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+asc&shard.url=[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1|[ff01::114]:33332/&rows=10&version=2&q=*:*&NOW=1547027969914&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 523077 INFO  (qtp151567408-8691) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1547027969914&ids=144,1,113,124,147,148,107,141,10,120&isShard=true&shard.url=[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1|[ff01::114]:33332/&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 523079 INFO  (qtp151567408-8694) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1|[ff01::114]:33332/&sort=n_ti1+asc&wt=javabin&version=2} hits=68 status=0 QTime=4
   [junit4]   2> 523081 INFO  (qtp151567408-8695) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+asc&shard.url=[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1|[ff01::114]:33332/&rows=10&version=2&q=*:*&NOW=1547027969919&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 523081 INFO  (qtp151567408-8691) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+asc&shard.url=[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1|[ff01::114]:33332/&rows=10&version=2&q=*:*&NOW=1547027969920&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 523083 INFO  (qtp151567408-8694) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1547027969919&ids=144,1,113,124,147,148,107,141,10,120&isShard=true&shard.url=[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1|[ff01::114]:33332/&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 523084 INFO  (qtp151567408-8695) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&df=text&distrib=false&shards.purpose=64&NOW=1547027969920&ids=144,1,113,124,147,148,107,141,10,120&isShard=true&shard.url=[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1|[ff01::114]:33332/&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 523085 INFO  (qtp151567408-8693) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1|[ff01::114]:33332/&sort=n_ti1+asc&wt=javabin&version=2} hits=68 status=0 QTime=5
   [junit4]   2> 523085 INFO  (qtp151567408-8692) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:35414/collection1|[ff01::114]:33332/&sort=n_ti1+asc&wt=javabin&version=2} hits=68 status=0 QTime=5
   [junit4]   2> 523088 INFO  (qtp151567408-8692) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=text&distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+as

[...truncated too long message...]

ning 'ant get-jenkins-line-docs' in the lucene directory.
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestDistributedSearch -Dtests.method=test -Dtests.seed=362C6D8DDAF5E9A -Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true -Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/test-data/enwiki.random.lines.txt -Dtests.locale=el -Dtests.timezone=Europe/Budapest -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
   [junit4] ERROR   91.6s J1 | TestDistributedSearch.test <<<
   [junit4]    > Throwable #1: java.lang.NullPointerException
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([362C6D8DDAF5E9A:8B36F90273533362]:0)
   [junit4]    > 	at org.apache.solr.TestDistributedSearch.test(TestDistributedSearch.java:596)
   [junit4]    > 	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:1096)
   [junit4]    > 	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1042)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_362C6D8DDAF5E9A-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene80), sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@22d2b7f6), locale=el, timezone=Europe/Budapest
   [junit4]   2> NOTE: Linux 4.4.0-137-generic amd64/Oracle Corporation 1.8.0_191 (64-bit)/cpus=4,threads=1,free=176755136,total=507510784
   [junit4]   2> NOTE: All tests run in this JVM: [DeleteShardTest, SyncSliceTest, TestEmbeddedSolrServerConstructors, TestManagedSynonymGraphFilterFactory, TestSlowCompositeReaderWrapper, TestOverriddenPrefixQueryForCustomFieldType, TermVectorComponentTest, BlockJoinFacetRandomTest, TestRuleBasedAuthorizationPlugin, TestSimLargeCluster, SolrGraphiteReporterTest, ConjunctionSolrSpellCheckerTest, SolrMetricReporterTest, CustomHighlightComponentTest, TestMultiValuedNumericRangeQuery, CurrencyFieldTypeTest, TestSolrCoreSnapshots, TestSolrDeletionPolicy1, TestFreeTextSuggestions, TestLockTree, TestInitQParser, ResponseBuilderTest, TestStressCloudBlindAtomicUpdates, TestHdfsUpdateLog, TestSmileRequest, TestSolrXml, TestCryptoKeys, LeaderTragicEventTest, TestReplicaProperties, TestHighlightDedupGrouping, ConfigureRecoveryStrategyTest, TestRecoveryHdfs, TestDistributedSearch]
   [junit4] Completed [139/837 (1!)] on J1 in 91.76s, 1 test, 1 error <<< FAILURES!

[...truncated 48142 lines...]
-ecj-javadoc-lint-src:
    [mkdir] Created dir: /tmp/ecj73257699
 [ecj-lint] Compiling 1241 source files to /tmp/ecj73257699
 [ecj-lint] Processing annotations
 [ecj-lint] Annotations processed
 [ecj-lint] Processing annotations
 [ecj-lint] No elements to process
 [ecj-lint] invalid Class-Path header in manifest of jar file: /x1/jenkins/.ivy2/cache/org.restlet.jee/org.restlet/jars/org.restlet-2.3.0.jar
 [ecj-lint] invalid Class-Path header in manifest of jar file: /x1/jenkins/.ivy2/cache/org.restlet.jee/org.restlet.ext.servlet/jars/org.restlet.ext.servlet-2.3.0.jar
 [ecj-lint] ----------
 [ecj-lint] 1. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/java/org/apache/solr/client/solrj/embedded/EmbeddedSolrServer.java (at line 219)
 [ecj-lint] 	return (NamedList<Object>) new JavaBinCodec(resolver).unmarshal(in);
 [ecj-lint] 	                           ^^^^^^^^^^^^^^^^^^^^^^^^^^
 [ecj-lint] Resource leak: '<unassigned Closeable value>' is never closed
 [ecj-lint] ----------
 [ecj-lint] ----------
 [ecj-lint] 2. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/java/org/apache/solr/cloud/api/collections/RestoreCmd.java (at line 257)
 [ecj-lint] 	throw new SolrException(ErrorCode.BAD_REQUEST, "Unexpected number of replicas, replicationFactor, " +
 [ecj-lint]               Replica.Type.NRT + " or " + Replica.Type.TLOG + " must be greater than 0");
 [ecj-lint] 	^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
 [ecj-lint] Resource leak: 'repository' is not closed at this location
 [ecj-lint] ----------
 [ecj-lint] ----------
 [ecj-lint] 3. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/java/org/apache/solr/handler/loader/JavabinLoader.java (at line 137)
 [ecj-lint] 	new JavaBinCodec() {
 [ecj-lint]       SolrParams params;
 [ecj-lint]       AddUpdateCommand addCmd = null;
 [ecj-lint] 
 [ecj-lint]       @Override
 [ecj-lint]       public List<Object> readIterator(DataInputInputStream fis) throws IOException {
 [ecj-lint]         while (true) {
 [ecj-lint]           Object o = readVal(fis);
 [ecj-lint]           if (o == END_OBJ) break;
 [ecj-lint]           if (o instanceof NamedList) {
 [ecj-lint]             params = ((NamedList) o).toSolrParams();
 [ecj-lint]           } else {
 [ecj-lint]             try {
 [ecj-lint]               if (o instanceof byte[]) {
 [ecj-lint]                 if (params != null) req.setParams(params);
 [ecj-lint]                 byte[] buf = (byte[]) o;
 [ecj-lint]                 contentStreamLoader.load(req, rsp, new ContentStreamBase.ByteArrayStream(buf, null), processor);
 [ecj-lint]               } else {
 [ecj-lint]                 throw new RuntimeException("unsupported type ");
 [ecj-lint]               }
 [ecj-lint]             } catch (Exception e) {
 [ecj-lint]               throw new RuntimeException(e);
 [ecj-lint]             } finally {
 [ecj-lint]               params = null;
 [ecj-lint]               req.setParams(old);
 [ecj-lint]             }
 [ecj-lint]           }
 [ecj-lint]         }
 [ecj-lint]         return Collections.emptyList();
 [ecj-lint]       }
 [ecj-lint] 
 [ecj-lint]     }.unmarshal(in);
 [ecj-lint] 	^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
 [ecj-lint] Resource leak: '<unassigned Closeable value>' is never closed
 [ecj-lint] ----------
 [ecj-lint] ----------
 [ecj-lint] 4. ERROR in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/java/org/apache/solr/update/DocumentBuilder.java (at line 32)
 [ecj-lint] 	import org.apache.solr.common.util.ByteArrayUtf8CharSequence;
 [ecj-lint] 	       ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
 [ecj-lint] The import org.apache.solr.common.util.ByteArrayUtf8CharSequence is never used
 [ecj-lint] ----------
 [ecj-lint] ----------
 [ecj-lint] 5. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/java/org/apache/solr/update/UpdateLog.java (at line 1867)
 [ecj-lint] 	if (exceptionOnExecuteUpdate.get() != null) throw exceptionOnExecuteUpdate.get();
 [ecj-lint] 	                                            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
 [ecj-lint] Resource leak: 'proc' is not closed at this location
 [ecj-lint] ----------
 [ecj-lint] ----------
 [ecj-lint] 6. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/java/org/apache/solr/util/FileUtils.java (at line 50)
 [ecj-lint] 	in = new FileInputStream(src).getChannel();
 [ecj-lint] 	     ^^^^^^^^^^^^^^^^^^^^^^^^
 [ecj-lint] Resource leak: '<unassigned Closeable value>' is never closed
 [ecj-lint] ----------
 [ecj-lint] 7. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/java/org/apache/solr/util/FileUtils.java (at line 51)
 [ecj-lint] 	out = new FileOutputStream(destination).getChannel();
 [ecj-lint] 	      ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
 [ecj-lint] Resource leak: '<unassigned Closeable value>' is never closed
 [ecj-lint] ----------
 [ecj-lint] 7 problems (1 error, 6 warnings)

BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/build.xml:651: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/build.xml:101: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build.xml:680: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/lucene/common-build.xml:2093: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/lucene/common-build.xml:2132: Compile failed; see the compiler error output for details.

Total time: 315 minutes 6 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any

Mime
View raw message