You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2021/05/08 00:12:21 UTC
[JENKINS] Lucene » Lucene-Solr-Tests-8.x - Build # 2328 - Unstable!
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-8.x/2328/
1 tests failed.
FAILED: org.apache.solr.handler.component.TermVectorComponentDistributedTest.test
Error Message:
Error from server at http://127.0.0.1:38549/collection1: org.apache.solr.client.solrj.SolrServerException: java.lang.ArithmeticException: / by zero
Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:38549/collection1: org.apache.solr.client.solrj.SolrServerException: java.lang.ArithmeticException: / by zero
at __randomizedtesting.SeedInfo.seed([C51802F6B7B9C5BE:4D4C3D2C1945A846]:0)
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:681)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:266)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:214)
at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1003)
at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1018)
at org.apache.solr.BaseDistributedSearchTestCase.queryServer(BaseDistributedSearchTestCase.java:625)
at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:677)
at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:655)
at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:634)
at org.apache.solr.handler.component.TermVectorComponentDistributedTest.test(TermVectorComponentDistributedTest.java:144)
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:1117)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1061)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
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.junit.rules.RunRules.evaluate(RunRules.java:20)
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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
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 13258 lines...]
[junit4] Suite: org.apache.solr.handler.component.TermVectorComponentDistributedTest
[junit4] 2> 2766 INFO (SUITE-TermVectorComponentDistributedTest-seed#[C51802F6B7B9C5BE]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/server/solr/configsets/_default/conf'
[junit4] 2> 2779 INFO (SUITE-TermVectorComponentDistributedTest-seed#[C51802F6B7B9C5BE]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 2789 INFO (SUITE-TermVectorComponentDistributedTest-seed#[C51802F6B7B9C5BE]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.component.TermVectorComponentDistributedTest_C51802F6B7B9C5BE-001/data-dir-1-001
[junit4] 2> 3087 INFO (SUITE-TermVectorComponentDistributedTest-seed#[C51802F6B7B9C5BE]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 3140 INFO (SUITE-TermVectorComponentDistributedTest-seed#[C51802F6B7B9C5BE]-worker) [ ] o.e.j.u.log Logging initialized @3168ms to org.eclipse.jetty.util.log.Slf4jLog
[junit4] 2> 3145 INFO (SUITE-TermVectorComponentDistributedTest-seed#[C51802F6B7B9C5BE]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 3174 INFO (SUITE-TermVectorComponentDistributedTest-seed#[C51802F6B7B9C5BE]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
[junit4] 2> 3446 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.component.TermVectorComponentDistributedTest_C51802F6B7B9C5BE-001/tempDir-001/control/cores/collection1
[junit4] 2> 4246 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 4249 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 4255 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_281-b09
[junit4] 2> 4268 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 4269 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 4272 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 4295 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2e2886ca{/,null,AVAILABLE}
[junit4] 2> 4315 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1921d74b{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42897}
[junit4] 2> 4315 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.e.j.s.Server Started @4347ms
[junit4] 2> 4315 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=42897, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.component.TermVectorComponentDistributedTest_C51802F6B7B9C5BE-001/tempDir-001/control/cores}
[junit4] 2> 4401 ERROR (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 4401 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 4401 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.9.0
[junit4] 2> 4402 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 4402 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
[junit4] 2> 4402 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-05-07T23:14:49.786Z
[junit4] 2> 4403 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.component.TermVectorComponentDistributedTest_C51802F6B7B9C5BE-001/tempDir-001/control/solr.xml
[junit4] 2> 4624 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 4625 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 4641 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@47dc965f, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 6555 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 6991 WARN (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@525c6184[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 6991 WARN (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@525c6184[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 7145 WARN (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@4070dd48[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 7145 WARN (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@4070dd48[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 7589 WARN (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 8006 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 8008 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 8148 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@47dc965f
[junit4] 2> 8149 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@47dc965f
[junit4] 2> 8149 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@47dc965f
[junit4] 2> 8196 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.component.TermVectorComponentDistributedTest_C51802F6B7B9C5BE-001/tempDir-001/control/cores
[junit4] 2> 8199 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 8547 INFO (coreLoadExecutor-15-thread-1) [ x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 9186 INFO (coreLoadExecutor-15-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.0
[junit4] 2> 9197 WARN (coreLoadExecutor-15-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
[junit4] 2> 9209 WARN (coreLoadExecutor-15-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter section instead
[junit4] 2> 9276 INFO (coreLoadExecutor-15-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 9664 WARN (coreLoadExecutor-15-thread-1) [ x:collection1 ] o.a.s.D.s.WordDelimiterFilterFactory Solr loaded a deprecated plugin/analysis class [solr.WordDelimiterFilterFactory]. Please consult documentation how to replace it accordingly.
[junit4] 2> 9686 WARN (coreLoadExecutor-15-thread-1) [ x:collection1 ] o.a.s.D.s.GeoHashField Solr loaded a deprecated plugin/analysis class [solr.GeoHashField]. Please consult documentation how to replace it accordingly.
[junit4] 2> 9696 WARN (coreLoadExecutor-15-thread-1) [ x:collection1 ] o.a.s.D.s.LatLonType Solr loaded a deprecated plugin/analysis class [solr.LatLonType]. Please consult documentation how to replace it accordingly.
[junit4] 2> 9704 WARN (coreLoadExecutor-15-thread-1) [ x:collection1 ] o.a.s.D.s.CurrencyField Solr loaded a deprecated plugin/analysis class [solr.CurrencyField]. Please consult documentation how to replace it accordingly.
[junit4] 2> 10517 INFO (coreLoadExecutor-15-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 10895 INFO (coreLoadExecutor-15-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 10942 INFO (coreLoadExecutor-15-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@47dc965f
[junit4] 2> 10958 INFO (coreLoadExecutor-15-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.component.TermVectorComponentDistributedTest_C51802F6B7B9C5BE-001/tempDir-001/control/cores/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.component.TermVectorComponentDistributedTest_C51802F6B7B9C5BE-001/tempDir-001/control/cores/collection1/data/]
[junit4] 2> 10997 INFO (coreLoadExecutor-15-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=23, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 12680 INFO (coreLoadExecutor-15-thread-1) [ x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 12680 INFO (coreLoadExecutor-15-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 12691 INFO (coreLoadExecutor-15-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 12692 INFO (coreLoadExecutor-15-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 12694 INFO (coreLoadExecutor-15-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=39, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8181005140445013]
[junit4] 2> 12812 INFO (coreLoadExecutor-15-thread-1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 12872 INFO (coreLoadExecutor-15-thread-1) [ x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 13195 INFO (coreLoadExecutor-15-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 13205 INFO (coreLoadExecutor-15-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1699143272197259264
[junit4] 2> 13209 INFO (searcherExecutor-17-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 13212 INFO (searcherExecutor-17-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 13213 INFO (searcherExecutor-17-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 13213 INFO (searcherExecutor-17-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 13214 INFO (searcherExecutor-17-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 13215 INFO (searcherExecutor-17-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 13216 INFO (searcherExecutor-17-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 13216 INFO (searcherExecutor-17-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 13217 INFO (searcherExecutor-17-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 13229 INFO (searcherExecutor-17-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 13812 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.component.TermVectorComponentDistributedTest_C51802F6B7B9C5BE-001/tempDir-001/shard0/cores/collection1
[junit4] 2> 13814 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 13814 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 13814 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_281-b09
[junit4] 2> 13816 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 13816 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 13816 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 13817 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@609d4983{/,null,AVAILABLE}
[junit4] 2> 13824 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@62d1c16b{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:44697}
[junit4] 2> 13824 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.e.j.s.Server Started @13856ms
[junit4] 2> 13824 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=44697, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.component.TermVectorComponentDistributedTest_C51802F6B7B9C5BE-001/tempDir-001/shard0/cores}
[junit4] 2> 13824 ERROR (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 13824 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 13825 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.9.0
[junit4] 2> 13825 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 13825 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
[junit4] 2> 13825 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-05-07T23:14:59.209Z
[junit4] 2> 13825 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.component.TermVectorComponentDistributedTest_C51802F6B7B9C5BE-001/tempDir-001/shard0/solr.xml
[junit4] 2> 13829 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 13829 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 13832 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@47dc965f, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 14130 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 14347 WARN (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@2a3f9af6[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 14347 WARN (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@2a3f9af6[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 14377 WARN (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@7ce67f5f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 14377 WARN (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@7ce67f5f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 14390 WARN (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 14408 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 14409 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 14436 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@47dc965f
[junit4] 2> 14451 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@47dc965f
[junit4] 2> 14451 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@47dc965f
[junit4] 2> 14453 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.component.TermVectorComponentDistributedTest_C51802F6B7B9C5BE-001/tempDir-001/shard0/cores
[junit4] 2> 14454 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 14482 INFO (coreLoadExecutor-34-thread-1) [ x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 14523 INFO (coreLoadExecutor-34-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.0
[junit4] 2> 14524 WARN (coreLoadExecutor-34-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
[junit4] 2> 14524 WARN (coreLoadExecutor-34-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter section instead
[junit4] 2> 14531 INFO (coreLoadExecutor-34-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 14543 INFO (coreLoadExecutor-34-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 14570 INFO (coreLoadExecutor-34-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 14572 INFO (coreLoadExecutor-34-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@47dc965f
[junit4] 2> 14573 INFO (coreLoadExecutor-34-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.component.TermVectorComponentDistributedTest_C51802F6B7B9C5BE-001/tempDir-001/shard0/cores/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.component.TermVectorComponentDistributedTest_C51802F6B7B9C5BE-001/tempDir-001/shard0/cores/collection1/data/]
[junit4] 2> 14575 INFO (coreLoadExecutor-34-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=23, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 14662 INFO (coreLoadExecutor-34-thread-1) [ x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 14662 INFO (coreLoadExecutor-34-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 14663 INFO (coreLoadExecutor-34-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 14663 INFO (coreLoadExecutor-34-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 14664 INFO (coreLoadExecutor-34-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=39, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8181005140445013]
[junit4] 2> 14674 INFO (coreLoadExecutor-34-thread-1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 14691 INFO (coreLoadExecutor-34-thread-1) [ x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 14990 INFO (coreLoadExecutor-34-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 14990 INFO (coreLoadExecutor-34-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1699143274068967424
[junit4] 2> 14991 INFO (searcherExecutor-36-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 14992 INFO (searcherExecutor-36-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 14992 INFO (searcherExecutor-36-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 14992 INFO (searcherExecutor-36-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 14993 INFO (searcherExecutor-36-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 14993 INFO (searcherExecutor-36-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 14993 INFO (searcherExecutor-36-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 14994 INFO (searcherExecutor-36-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 14994 INFO (searcherExecutor-36-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 14997 INFO (searcherExecutor-36-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 15493 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[C51802F6B7B9C5BE]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 16174 INFO (qtp1219337947-18) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[0 (1699143275184652288)]} 0 148
[junit4] 2> 16229 INFO (qtp1145414865-40) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[0 (1699143275361861632)]} 0 7
[junit4] 2> 16233 INFO (qtp1219337947-19) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[1 (1699143275370250240)]} 0 2
[junit4] 2> 16237 INFO (qtp1145414865-38) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[1 (1699143275374444544)]} 0 2
[junit4] 2> 16255 INFO (qtp1219337947-20) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[2 (1699143275394367488)]} 0 1
[junit4] 2> 16258 INFO (qtp1145414865-41) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[2 (1699143275397513216)]} 0 1
[junit4] 2> 16261 INFO (qtp1219337947-21) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[3 (1699143275400658944)]} 0 1
[junit4] 2> 16263 INFO (qtp1145414865-42) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[3 (1699143275402756096)]} 0 1
[junit4] 2> 16265 INFO (qtp1219337947-17) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[4 (1699143275405901824)]} 0 1
[junit4] 2> 16268 INFO (qtp1145414865-39) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[4 (1699143275407998976)]} 0 1
[junit4] 2> 16270 INFO (qtp1219337947-18) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[5 (1699143275410096128)]} 0 1
[junit4] 2> 16272 INFO (qtp1145414865-40) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[5 (1699143275412193280)]} 0 1
[junit4] 2> 16277 INFO (qtp1219337947-19) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[6 (1699143275417436160)]} 0 1
[junit4] 2> 16280 INFO (qtp1145414865-38) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[6 (1699143275421630464)]} 0 1
[junit4] 2> 16282 INFO (qtp1219337947-20) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[7 (1699143275423727616)]} 0 1
[junit4] 2> 16285 INFO (qtp1145414865-41) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[7 (1699143275425824768)]} 0 1
[junit4] 2> 16292 INFO (qtp1219337947-21) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[8 (1699143275433164800)]} 0 6
[junit4] 2> 16294 INFO (qtp1145414865-42) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[8 (1699143275436310528)]} 0 1
[junit4] 2> 16296 INFO (qtp1219337947-17) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[9 (1699143275438407680)]} 0 1
[junit4] 2> 16299 INFO (qtp1145414865-39) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[9 (1699143275440504832)]} 0 1
[junit4] 2> 16786 INFO (searcherExecutor-17-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 10 ms
[junit4] 2> 16789 INFO (qtp1219337947-18) [ 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 486
[junit4] 2> 16815 INFO (searcherExecutor-36-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 16816 INFO (qtp1145414865-40) [ 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 24
[junit4] 2> 17039 INFO (qtp1219337947-19) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:0&tv=true&distrib=false&qt=tvrh&tv.tf=true&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=218
[junit4] 2> 17563 INFO (qtp1145414865-39) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=id&shards.purpose=4&tv.tf=true&start=0&fsv=true&sort=id+desc&shard.url=[::1]:4/|[::1]:6/|http://127.0.0.1:44697/collection1&rid=127.0.0.1-1&rows=10&version=2&q=id:0&omitHeader=false&NOW=1620429302450&isShard=true&wt=javabin} hits=1 status=0 QTime=2
[junit4] 2> 17602 INFO (qtp1145414865-40) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&shards.purpose=64&tv.tf=true&shard.url=[::1]:4/|[::1]:6/|http://127.0.0.1:44697/collection1&rid=127.0.0.1-1&version=2&q=id:0&omitHeader=false&NOW=1620429302450&ids=0&isShard=true&wt=javabin} status=0 QTime=2
[junit4] 2> 17608 INFO (qtp1145414865-38) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:0&shards=[::1]:4/|[::1]:6/|http://127.0.0.1:44697/collection1&tv=true&qt=tvrh&tv.tf=true&sort=id+desc&wt=javabin&version=2} rid=127.0.0.1-1 hits=1 status=0 QTime=542
[junit4] 2> 17619 INFO (qtp1219337947-20) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:0&tv=true&distrib=false&qt=tvrh&fl=*,score&tv.tf=true&sort=id+asc&tv.fl=test_basictv,test_offtv&wt=javabin&version=2} hits=1 status=0 QTime=8
[junit4] 2> 17629 INFO (qtp1145414865-42) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=*,score&shards.purpose=32768&tv.tf=true&sort=id+asc&tv.fl=test_basictv,test_offtv&shard.url=[::1]:8/|http://127.0.0.1:44697/collection1|[::1]:4/|[::1]:6/&rid=127.0.0.1-3&version=2&q=id:0&omitHeader=false&NOW=1620429303005&isShard=true&wt=javabin} status=0 QTime=3
[junit4] 2> 17634 INFO (qtp1145414865-39) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=16388&tv.tf=true&start=0&fsv=true&solr.stats.col=&sort=id+asc&tv.fl=test_basictv,test_offtv&shard.url=[::1]:8/|http://127.0.0.1:44697/collection1|[::1]:4/|[::1]:6/&rid=127.0.0.1-3&rows=10&version=2&q=id:0&solr.stats.term=&omitHeader=false&NOW=1620429303005&isShard=true&solr.stats.terms=id:0&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 17790 INFO (qtp1145414865-38) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=*,score&shards.purpose=64&tv.tf=true&tv.fl=test_basictv,test_offtv&shard.url=[::1]:8/|http://127.0.0.1:44697/collection1|[::1]:4/|[::1]:6/&rid=127.0.0.1-3&version=2&q=id:0&omitHeader=false&NOW=1620429303005&ids=0&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 17793 INFO (qtp1145414865-41) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:0&shards=[::1]:8/|http://127.0.0.1:44697/collection1|[::1]:4/|[::1]:6/&tv=true&qt=tvrh&fl=*,score&tv.tf=true&sort=id+asc&tv.fl=test_basictv,test_offtv&wt=javabin&version=2} rid=127.0.0.1-3 hits=1 status=0 QTime=171
[junit4] 2> 17796 INFO (qtp1219337947-21) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:0&tv=true&distrib=false&qt=tvrh&fl=*,score&tv.tf=true&sort=id+asc&tv.fl=test_basictv&tv.fl=test_offtv&wt=javabin&version=2} hits=1 status=0 QTime=0
[junit4] 2> 17799 INFO (qtp1145414865-39) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=*,score&shards.purpose=32768&tv.tf=true&solr.stats.fields=id&sort=id+asc&tv.fl=test_basictv&tv.fl=test_offtv&shard.url=[::1]:4/|[::1]:6/|http://127.0.0.1:44697/collection1|[::1]:8/&rid=127.0.0.1-5&version=2&q=id:0&omitHeader=false&NOW=1620429303181&isShard=true&solr.stats.terms=id:0&wt=javabin} status=0 QTime=0
[junit4] 2> 17804 INFO (qtp1145414865-42) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=16388&tv.tf=true&start=0&fsv=true&solr.stats.col=&sort=id+asc&tv.fl=test_basictv&tv.fl=test_offtv&shard.url=[::1]:4/|[::1]:6/|http://127.0.0.1:44697/collection1|[::1]:8/&rid=127.0.0.1-5&rows=10&version=2&q=id:0&solr.stats.term=&omitHeader=false&NOW=1620429303181&isShard=true&solr.stats.terms=id:0&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 17806 INFO (qtp1145414865-38) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=*,score&shards.purpose=64&tv.tf=true&tv.fl=test_basictv&tv.fl=test_offtv&shard.url=[::1]:4/|[::1]:6/|http://127.0.0.1:44697/collection1|[::1]:8/&rid=127.0.0.1-5&version=2&q=id:0&omitHeader=false&NOW=1620429303181&ids=0&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 17807 INFO (qtp1145414865-40) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:0&shards=[::1]:4/|[::1]:6/|http://127.0.0.1:44697/collection1|[::1]:8/&tv=true&qt=tvrh&fl=*,score&tv.tf=true&sort=id+asc&tv.fl=test_basictv&tv.fl=test_offtv&wt=javabin&version=2} rid=127.0.0.1-5 hits=1 status=0 QTime=10
[junit4] 2> 17814 INFO (qtp1219337947-17) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:0&tv=true&distrib=false&qt=tvrh&fl=*,score&tv.tf=true&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=4
[junit4] 2> 17818 INFO (qtp1145414865-39) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=*,score&shards.purpose=32768&tv.tf=true&sort=id+desc&shard.url=[::1]:6/|http://127.0.0.1:44697/collection1|[::1]:8/&rid=127.0.0.1-7&version=2&q=id:0&omitHeader=false&NOW=1620429303200&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 17821 INFO (qtp1145414865-42) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=16388&tv.tf=true&start=0&fsv=true&solr.stats.col=&sort=id+desc&shard.url=[::1]:6/|http://127.0.0.1:44697/collection1|[::1]:8/&rid=127.0.0.1-7&rows=10&version=2&q=id:0&solr.stats.term=&omitHeader=false&NOW=1620429303200&isShard=true&solr.stats.terms=id:0&wt=javabin} hits=1 status=0 QTime=1
[junit4] 2> 17823 INFO (qtp1145414865-38) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=*,score&shards.purpose=64&tv.tf=true&shard.url=[::1]:6/|http://127.0.0.1:44697/collection1|[::1]:8/&rid=127.0.0.1-7&version=2&q=id:0&omitHeader=false&NOW=1620429303200&ids=0&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 17825 INFO (qtp1145414865-41) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:0&shards=[::1]:6/|http://127.0.0.1:44697/collection1|[::1]:8/&tv=true&qt=tvrh&fl=*,score&tv.tf=true&sort=id+desc&wt=javabin&version=2} rid=127.0.0.1-7 hits=1 status=0 QTime=8
[junit4] 2> 17943 INFO (qtp1219337947-18) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:0&tv=true&distrib=false&qt=tvrh&fl=score,test_basictv,[docid],test_postv,val:sum(3,4)&tv.tf=true&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=116
[junit4] 2> 17956 INFO (qtp1145414865-39) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=score,test_basictv,[docid],test_postv,val:sum(3,4)&shards.purpose=32768&tv.tf=true&solr.stats.fields=id&sort=id+desc&shard.url=[::1]:4/|http://127.0.0.1:44697/collection1&rid=127.0.0.1-9&version=2&q=id:0&omitHeader=false&NOW=1620429303338&isShard=true&solr.stats.terms=id:0&wt=javabin} status=0 QTime=0
[junit4] 2> 17959 INFO (qtp1145414865-42) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=16388&tv.tf=true&start=0&fsv=true&solr.stats.col=&sort=id+desc&shard.url=[::1]:4/|http://127.0.0.1:44697/collection1&rid=127.0.0.1-9&rows=10&version=2&q=id:0&solr.stats.term=&omitHeader=false&NOW=1620429303338&isShard=true&solr.stats.terms=id:0&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 17962 INFO (qtp1145414865-38) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=score,test_basictv,[docid],test_postv,val:sum(3,4)&fl=id&shards.purpose=64&tv.tf=true&shard.url=[::1]:4/|http://127.0.0.1:44697/collection1&rid=127.0.0.1-9&version=2&q=id:0&omitHeader=false&NOW=1620429303338&ids=0&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 17963 INFO (qtp1145414865-40) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:0&shards=[::1]:4/|http://127.0.0.1:44697/collection1&tv=true&qt=tvrh&fl=score,test_basictv,[docid],test_postv,val:sum(3,4)&tv.tf=true&sort=id+desc&wt=javabin&version=2} rid=127.0.0.1-9 hits=1 status=0 QTime=9
[junit4] 2> 17966 INFO (qtp1219337947-19) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:0&tv=true&distrib=false&qt=tvrh&fl=score,test_basictv&fl=[docid],test_postv,val:sum(3,4)&tv.tf=true&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=0
[junit4] 2> 17969 INFO (qtp1145414865-39) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=score,test_basictv&fl=[docid],test_postv,val:sum(3,4)&shards.purpose=32768&tv.tf=true&sort=id+desc&shard.url=[::1]:4/|http://127.0.0.1:44697/collection1|[::1]:6/&rid=127.0.0.1-11&version=2&q=id:0&omitHeader=false&NOW=1620429303351&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 17972 INFO (qtp1145414865-42) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=16388&tv.tf=true&start=0&fsv=true&solr.stats.col=&sort=id+desc&shard.url=[::1]:4/|http://127.0.0.1:44697/collection1|[::1]:6/&rid=127.0.0.1-11&rows=10&version=2&q=id:0&solr.stats.term=&omitHeader=false&NOW=1620429303351&isShard=true&solr.stats.terms=id:0&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 17974 INFO (qtp1145414865-38) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=score,test_basictv&fl=[docid],test_postv,val:sum(3,4)&fl=id&shards.purpose=64&tv.tf=true&shard.url=[::1]:4/|http://127.0.0.1:44697/collection1|[::1]:6/&rid=127.0.0.1-11&version=2&q=id:0&omitHeader=false&NOW=1620429303351&ids=0&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 17977 INFO (qtp1145414865-41) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:0&shards=[::1]:4/|http://127.0.0.1:44697/collection1|[::1]:6/&tv=true&qt=tvrh&fl=score,test_basictv&fl=[docid],test_postv,val:sum(3,4)&tv.tf=true&sort=id+desc&wt=javabin&version=2} rid=127.0.0.1-11 hits=1 status=0 QTime=9
[junit4] 2> 17984 INFO (qtp1219337947-20) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:0&tv=true&tv.positions=true&distrib=false&qt=tvrh&tv.tf=true&tv.df=true&tv.offsets=true&sort=id+asc&tv.tf_idf=true&wt=javabin&version=2} hits=1 status=0 QTime=0
[junit4] 2> 17988 INFO (qtp1145414865-39) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&tv.positions=true&df=text&distrib=false&qt=tvrh&fl=id&shards.purpose=4&tv.tf=true&start=0&fsv=true&tv.offsets=true&sort=id+asc&shard.url=http://127.0.0.1:44697/collection1&rid=127.0.0.1-13&rows=10&tv.tf_idf=true&version=2&q=id:0&omitHeader=false&tv.df=true&NOW=1620429303370&isShard=true&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 17990 INFO (qtp1145414865-42) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&tv.positions=true&df=text&distrib=false&qt=tvrh&shards.purpose=64&tv.tf=true&tv.offsets=true&shard.url=http://127.0.0.1:44697/collection1&rid=127.0.0.1-13&tv.tf_idf=true&version=2&q=id:0&omitHeader=false&tv.df=true&NOW=1620429303370&ids=0&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 17991 INFO (qtp1145414865-40) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:0&shards=http://127.0.0.1:44697/collection1&tv=true&tv.positions=true&qt=tvrh&tv.tf=true&tv.df=true&tv.offsets=true&sort=id+asc&tv.tf_idf=true&wt=javabin&version=2} rid=127.0.0.1-13 hits=1 status=0 QTime=4
[junit4] 2> 17993 INFO (qtp1219337947-21) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:0&tv=true&tv.all=true&distrib=false&qt=tvrh&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=0
[junit4] 2> 17995 INFO (qtp1145414865-41) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=id&shards.purpose=4&start=0&fsv=true&sort=id+desc&shard.url=http://127.0.0.1:44697/collection1&rid=127.0.0.1-15&rows=10&version=2&q=id:0&tv.all=true&omitHeader=false&NOW=1620429303378&isShard=true&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 18000 INFO (qtp1145414865-39) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&shards.purpose=64&shard.url=http://127.0.0.1:44697/collection1&rid=127.0.0.1-15&version=2&q=id:0&tv.all=true&omitHeader=false&NOW=1620429303378&ids=0&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 18001 INFO (qtp1145414865-38) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:0&shards=http://127.0.0.1:44697/collection1&tv=true&tv.all=true&qt=tvrh&sort=id+desc&wt=javabin&version=2} rid=127.0.0.1-15 hits=1 status=0 QTime=7
[junit4] 2> 18003 INFO (qtp1219337947-17) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:0&tv=true&tv.all=true&distrib=false&qt=tvrh&sort=id+desc&distrib.singlePass=true&rows=1&wt=javabin&version=2} hits=1 status=0 QTime=0
[junit4] 2> 18005 INFO (qtp1145414865-40) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=*&shards.purpose=68&start=0&fsv=true&sort=id+desc&distrib.singlePass=true&shard.url=http://127.0.0.1:44697/collection1&rows=1&rid=127.0.0.1-17&version=2&q=id:0&tv.all=true&omitHeader=false&NOW=1620429303388&isShard=true&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 18006 INFO (qtp1145414865-42) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:0&shards=http://127.0.0.1:44697/collection1&tv=true&tv.all=true&qt=tvrh&sort=id+desc&distrib.singlePass=true&rows=1&wt=javabin&version=2} rid=127.0.0.1-17 hits=1 status=0 QTime=2
[junit4] 2> 18008 INFO (qtp1219337947-18) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={f.test_basictv.tv.tf_idf=false&tv=true&tv.positions=true&distrib=false&qt=tvrh&f.test_posofftv.tv.positions=false&tv.tf=true&f.test_basictv.tv.df=false&tv.offsets=true&sort=id+desc&tv.fl=test_basictv,test_notv,test_postv,test_offtv,test_posofftv&tv.tf_idf=true&version=2&q=id:0&f.test_offtv.tv.offsets=false&tv.df=true&f.test_basictv.tv.tf=false&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 18011 INFO (qtp1145414865-39) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&fl=id&shards.purpose=4&tv.tf=true&f.test_basictv.tv.df=false&fsv=true&shard.url=http://127.0.0.1:44697/collection1&rid=127.0.0.1-19&wt=javabin&f.test_basictv.tv.tf_idf=false&tv.positions=true&qt=tvrh&f.test_posofftv.tv.positions=false&start=0&tv.offsets=true&sort=id+desc&tv.fl=test_basictv,test_notv,test_postv,test_offtv,test_posofftv&rows=10&tv.tf_idf=true&version=2&q=id:0&f.test_offtv.tv.offsets=false&omitHeader=false&tv.df=true&NOW=1620429303393&f.test_basictv.tv.tf=false&isShard=true} hits=1 status=0 QTime=0
[junit4] 2> 18013 INFO (qtp1145414865-38) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&shards.purpose=64&tv.tf=true&f.test_basictv.tv.df=false&shard.url=http://127.0.0.1:44697/collection1&rid=127.0.0.1-19&wt=javabin&f.test_basictv.tv.tf_idf=false&tv.positions=true&qt=tvrh&f.test_posofftv.tv.positions=false&tv.offsets=true&tv.fl=test_basictv,test_notv,test_postv,test_offtv,test_posofftv&tv.tf_idf=true&version=2&q=id:0&f.test_offtv.tv.offsets=false&omitHeader=false&tv.df=true&NOW=1620429303393&f.test_basictv.tv.tf=false&ids=0&isShard=true} status=0 QTime=0
[junit4] 2> 18014 INFO (qtp1145414865-41) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={f.test_basictv.tv.tf_idf=false&tv=true&tv.positions=true&qt=tvrh&f.test_posofftv.tv.positions=false&tv.tf=true&f.test_basictv.tv.df=false&tv.offsets=true&sort=id+desc&tv.fl=test_basictv,test_notv,test_postv,test_offtv,test_posofftv&tv.tf_idf=true&version=2&q=id:0&shards=http://127.0.0.1:44697/collection1&f.test_offtv.tv.offsets=false&tv.df=true&f.test_basictv.tv.tf=false&wt=javabin} rid=127.0.0.1-19 hits=1 status=0 QTime=5
[junit4] 2> 18016 INFO (qtp1219337947-19) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:7&tv=true&distrib=false&qt=tvrh&tv.tf=true&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=0
[junit4] 2> 18019 INFO (qtp1145414865-42) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=id&shards.purpose=4&tv.tf=true&start=0&fsv=true&sort=id+desc&shard.url=http://127.0.0.1:44697/collection1&rid=127.0.0.1-21&rows=10&version=2&q=id:7&omitHeader=false&NOW=1620429303401&isShard=true&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 18021 INFO (qtp1145414865-39) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&shards.purpose=64&tv.tf=true&shard.url=http://127.0.0.1:44697/collection1&rid=127.0.0.1-21&version=2&q=id:7&omitHeader=false&NOW=1620429303401&ids=7&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 18023 INFO (qtp1145414865-40) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:7&shards=http://127.0.0.1:44697/collection1&tv=true&qt=tvrh&tv.tf=true&sort=id+desc&wt=javabin&version=2} rid=127.0.0.1-21 hits=1 status=0 QTime=5
[junit4] 2> 18025 INFO (qtp1219337947-20) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:7&tv=true&distrib=false&qt=tvrh&fl=*,score&tv.tf=true&sort=id+asc&tv.fl=test_basictv,test_offtv&wt=javabin&version=2} hits=1 status=0 QTime=0
[junit4] 2> 18028 INFO (qtp1145414865-41) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=*,score&shards.purpose=32768&tv.tf=true&solr.stats.fields=id&sort=id+asc&tv.fl=test_basictv,test_offtv&shard.url=http://127.0.0.1:44697/collection1|[::1]:8/&rid=127.0.0.1-23&version=2&q=id:7&omitHeader=false&NOW=1620429303410&isShard=true&solr.stats.terms=id:0&wt=javabin} status=0 QTime=0
[junit4] 2> 18030 INFO (qtp1145414865-42) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=16388&tv.tf=true&start=0&fsv=true&solr.stats.col=&sort=id+asc&tv.fl=test_basictv,test_offtv&shard.url=http://127.0.0.1:44697/collection1|[::1]:8/&rid=127.0.0.1-23&rows=10&version=2&q=id:7&solr.stats.term=&omitHeader=false&NOW=1620429303410&isShard=true&solr.stats.terms=id:0!id:7&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 18033 INFO (qtp1145414865-39) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=*,score&shards.purpose=64&tv.tf=true&tv.fl=test_basictv,test_offtv&shard.url=http://127.0.0.1:44697/collection1|[::1]:8/&rid=127.0.0.1-23&version=2&q=id:7&omitHeader=false&NOW=1620429303410&ids=7&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 18034 INFO (qtp1145414865-38) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:7&shards=http://127.0.0.1:44697/collection1|[::1]:8/&tv=true&qt=tvrh&fl=*,score&tv.tf=true&sort=id+asc&tv.fl=test_basictv,test_offtv&wt=javabin&version=2} rid=127.0.0.1-23 hits=1 status=0 QTime=7
[junit4] 2> 18035 INFO (qtp1219337947-21) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:7&tv=true&distrib=false&qt=tvrh&fl=*,score&tv.tf=true&sort=id+asc&tv.fl=test_basictv&tv.fl=test_offtv&wt=javabin&version=2} hits=1 status=0 QTime=0
[junit4] 2> 18038 INFO (qtp1145414865-41) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=*,score&shards.purpose=32768&tv.tf=true&solr.stats.fields=id&sort=id+asc&tv.fl=test_basictv&tv.fl=test_offtv&shard.url=[::1]:8/|http://127.0.0.1:44697/collection1|[::1]:6/&rid=127.0.0.1-25&version=2&q=id:7&omitHeader=false&NOW=1620429303420&isShard=true&solr.stats.terms=id:7&wt=javabin} status=0 QTime=0
[junit4] 2> 18040 INFO (qtp1145414865-42) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=16388&tv.tf=true&start=0&fsv=true&solr.stats.col=&sort=id+asc&tv.fl=test_basictv&tv.fl=test_offtv&shard.url=[::1]:8/|http://127.0.0.1:44697/collection1|[::1]:6/&rid=127.0.0.1-25&rows=10&version=2&q=id:7&solr.stats.term=&omitHeader=false&NOW=1620429303420&isShard=true&solr.stats.terms=id:7&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 18042 INFO (qtp1145414865-39) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=*,score&shards.purpose=64&tv.tf=true&tv.fl=test_basictv&tv.fl=test_offtv&shard.url=[::1]:8/|http://127.0.0.1:44697/collection1|[::1]:6/&rid=127.0.0.1-25&version=2&q=id:7&omitHeader=false&NOW=1620429303420&ids=7&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 18043 INFO (qtp1145414865-40) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:7&shards=[::1]:8/|http://127.0.0.1:44697/collection1|[::1]:6/&tv=true&qt=tvrh&fl=*,score&tv.tf=true&sort=id+asc&tv.fl=test_basictv&tv.fl=test_offtv&wt=javabin&version=2} rid=127.0.0.1-25 hits=1 status=0 QTime=6
[junit4] 2> 18045 INFO (qtp1219337947-17) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:7&tv=true&distrib=false&qt=tvrh&fl=*,score&tv.tf=true&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=0
[junit4] 2> 18047 INFO (qtp1145414865-41) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=*,score&shards.purpose=32768&tv.tf=true&sort=id+desc&shard.url=[::1]:6/|[::1]:8/|http://127.0.0.1:44697/collection1&rid=127.0.0.1-27&version=2&q=id:7&omitHeader=false&NOW=1620429303430&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 18049 INFO (qtp1145414865-42) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=16388&tv.tf=true&start=0&fsv=true&solr.stats.col=&sort=id+desc&shard.url=[::1]:6/|[::1]:8/|http://127.0.0.1:44697/collection1&rid=127.0.0.1-27&rows=10&version=2&q=id:7&solr.stats.term=&omitHeader=false&NOW=1620429303430&isShard=true&solr.stats.terms=id:7&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 18051 INFO (qtp1145414865-39) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=*,score&shards.purpose=64&tv.tf=true&shard.url=[::1]:6/|[::1]:8/|http://127.0.0.1:44697/collection1&rid=127.0.0.1-27&version=2&q=id:7&omitHeader=false&NOW=1620429303430&ids=7&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 18052 INFO (qtp1145414865-38) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:7&shards=[::1]:6/|[::1]:8/|http://127.0.0.1:44697/collection1&tv=true&qt=tvrh&fl=*,score&tv.tf=true&sort=id+desc&wt=javabin&version=2} rid=127.0.0.1-27 hits=1 status=0 QTime=6
[junit4] 2> 18054 INFO (qtp1219337947-18) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:7&tv=true&distrib=false&qt=tvrh&fl=score,test_basictv,[docid],test_postv,val:sum(3,4)&tv.tf=true&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=0
[junit4] 2> 18059 INFO (qtp1145414865-41) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=score,test_basictv,[docid],test_postv,val:sum(3,4)&shards.purpose=32768&tv.tf=true&solr.stats.fields=id&sort=id+desc&shard.url=http://127.0.0.1:44697/collection1|[::1]:6/|[::1]:4/|[::1]:8/&rid=127.0.0.1-29&version=2&q=id:7&omitHeader=false&NOW=1620429303439&isShard=true&solr.stats.terms=id:7&wt=javabin} status=0 QTime=0
[junit4] 2> 18063 INFO (qtp1145414865-42) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=16388&tv.tf=true&start=0&fsv=true&solr.stats.col=&sort=id+desc&shard.url=http://127.0.0.1:44697/collection1|[::1]:6/|[::1]:4/|[::1]:8/&rid=127.0.0.1-29&rows=10&version=2&q=id:7&solr.stats.term=&omitHeader=false&NOW=1620429303439&isShard=true&solr.stats.terms=id:7&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 18066 INFO (qtp1145414865-39) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=score,test_basictv,[docid],test_postv,val:sum(3,4)&fl=id&shards.purpose=64&tv.tf=true&shard.url=http://127.0.0.1:44697/collection1|[::1]:6/|[::1]:4/|[::1]:8/&rid=127.0.0.1-29&version=2&q=id:7&omitHeader=false&NOW=1620429303439&ids=7&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 18067 INFO (qtp1145414865-40) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:7&shards=http://127.0.0.1:44697/collection1|[::1]:6/|[::1]:4/|[::1]:8/&tv=true&qt=tvrh&fl=score,test_basictv,[docid],test_postv,val:sum(3,4)&tv.tf=true&sort=id+desc&wt=javabin&version=2} rid=127.0.0.1-29 hits=1 status=0 QTime=12
[junit4] 2> 18069 INFO (qtp1219337947-19) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:7&tv=true&distrib=false&qt=tvrh&fl=score,test_basictv&fl=[docid],test_postv,val:sum(3,4)&tv.tf=true&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=0
[junit4] 2> 18071 INFO (qtp1145414865-41) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=score,test_basictv&fl=[docid],test_postv,val:sum(3,4)&shards.purpose=32768&tv.tf=true&sort=id+desc&shard.url=http://127.0.0.1:44697/collection1&rid=127.0.0.1-31&version=2&q=id:7&omitHeader=false&NOW=1620429303454&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 18074 INFO (qtp1145414865-42) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=16388&tv.tf=true&start=0&fsv=true&solr.stats.col=id,10,10,10,10&sort=id+desc&shard.url=http://127.0.0.1:44697/collection1&rid=127.0.0.1-31&rows=10&version=2&q=id:7&solr.stats.term=id:7,1,1&omitHeader=false&NOW=1620429303454&isShard=true&solr.stats.terms=id:7&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 18077 INFO (qtp1145414865-39) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=score,test_basictv&fl=[docid],test_postv,val:sum(3,4)&fl=id&shards.purpose=64&tv.tf=true&shard.url=http://127.0.0.1:44697/collection1&rid=127.0.0.1-31&version=2&q=id:7&omitHeader=false&NOW=1620429303454&ids=7&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 18079 INFO (qtp1145414865-38) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:7&shards=http://127.0.0.1:44697/collection1&tv=true&qt=tvrh&fl=score,test_basictv&fl=[docid],test_postv,val:sum(3,4)&tv.tf=true&sort=id+desc&wt=javabin&version=2} rid=127.0.0.1-31 hits=1 status=0 QTime=9
[junit4] 2> 18080 INFO (qtp1219337947-20) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:7&tv=true&tv.positions=true&distrib=false&qt=tvrh&tv.tf=true&tv.df=true&tv.offsets=true&sort=id+asc&tv.tf_idf=true&wt=javabin&version=2} hits=1 status=0 QTime=0
[junit4] 2> 18084 INFO (qtp1145414865-41) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&tv.positions=true&df=text&distrib=false&qt=tvrh&fl=id&shards.purpose=4&tv.tf=true&start=0&fsv=true&tv.offsets=true&sort=id+asc&shard.url=http://127.0.0.1:44697/collection1&rid=127.0.0.1-33&rows=10&tv.tf_idf=true&version=2&q=id:7&omitHeader=false&tv.df=true&NOW=1620429303466&isShard=true&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 18085 INFO (qtp1145414865-42) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&tv.positions=true&df=text&distrib=false&qt=tvrh&shards.purpose=64&tv.tf=true&tv.offsets=true&shard.url=http://127.0.0.1:44697/collection1&rid=127.0.0.1-33&tv.tf_idf=true&version=2&q=id:7&omitHeader=false&tv.df=true&NOW=1620429303466&ids=7&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 18086 INFO (qtp1145414865-40) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:7&shards=http://127.0.0.1:44697/collection1&tv=true&tv.positions=true&qt=tvrh&tv.tf=true&tv.df=true&tv.offsets=true&sort=id+asc&tv.tf_idf=true&wt=javabin&version=2} rid=127.0.0.1-33 hits=1 status=0 QTime=4
[junit4] 2> 18087 INFO (qtp1219337947-21) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:7&tv=true&tv.all=true&distrib=false&qt=tvrh&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=0
[junit4] 2> 18090 INFO (qtp1145414865-38) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=id&shards.purpose=4&start=0&fsv=true&sort=id+desc&shard.url=[::1]:6/|http://127.0.0.1:44697/collection1&rid=127.0.0.1-35&rows=10&version=2&q=id:7&tv.all=true&omitHeader=false&NOW=1620429303472&isShard=true&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 18092 INFO (qtp1145414865-41) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&shards.purpose=64&shard.url=[::1]:6/|http://127.0.0.1:44697/collection1&rid=127.0.0.1-35&version=2&q=id:7&tv.all=true&omitHeader=false&NOW=1620429303472&ids=7&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 18092 INFO (qtp1145414865-39) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:7&shards=[::1]:6/|http://127.0.0.1:44697/collection1&tv=true&tv.all=true&qt=tvrh&sort=id+desc&wt=javabin&version=2} rid=127.0.0.1-35 hits=1 status=0 QTime=4
[junit4] 2> 18105 INFO (qtp1219337947-17) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:7&tv=true&tv.all=true&distrib=false&qt=tvrh&sort=id+desc&distrib.singlePass=true&rows=1&wt=javabin&version=2} hits=1 status=0 QTime=0
[junit4] 2> 18108 INFO (qtp1145414865-40) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=*&shards.purpose=68&start=0&fsv=true&sort=id+desc&distrib.singlePass=true&shard.url=[::1]:6/|http://127.0.0.1:44697/collection1|[::1]:4/|[::1]:8/&rows=1&rid=127.0.0.1-37&version=2&q=id:7&tv.all=true&omitHeader=false&NOW=1620429303491&isShard=true&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 18110 INFO (qtp1145414865-42) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:7&shards=[::1]:6/|http://127.0.0.1:44697/collection1|[::1]:4/|[::1]:8/&tv=true&tv.all=true&qt=tvrh&sort=id+desc&distrib.singlePass=true&rows=1&wt=javabin&version=2} rid=127.0.0.1-37 hits=1 status=0 QTime=3
[junit4] 2> 18111 INFO (qtp1219337947-18) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={f.test_basictv.tv.tf_idf=false&tv=true&tv.positions=true&distrib=false&qt=tvrh&f.test_posofftv.tv.positions=false&tv.tf=true&f.test_basictv.tv.df=false&tv.offsets=true&sort=id+desc&tv.fl=test_basictv,test_notv,test_postv,test_offtv,test_posofftv&tv.tf_idf=true&version=2&q=id:7&f.test_offtv.tv.offsets=false&tv.df=true&f.test_basictv.tv.tf=false&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 18115 INFO (qtp1145414865-41) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&fl=id&shards.purpose=4&tv.tf=true&f.test_basictv.tv.df=false&fsv=true&shard.url=[::1]:4/|http://127.0.0.1:44697/collection1&rid=127.0.0.1-39&wt=javabin&f.test_basictv.tv.tf_idf=false&tv.positions=true&qt=tvrh&f.test_posofftv.tv.positions=false&start=0&tv.offsets=true&sort=id+desc&tv.fl=test_basictv,test_notv,test_postv,test_offtv,test_posofftv&rows=10&tv.tf_idf=true&version=2&q=id:7&f.test_offtv.tv.offsets=false&omitHeader=false&tv.df=true&NOW=1620429303496&f.test_basictv.tv.tf=false&isShard=true} hits=1 status=0 QTime=0
[junit4] 2> 18117 INFO (qtp1145414865-39) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&shards.purpose=64&tv.tf=true&f.test_basictv.tv.df=false&shard.url=[::1]:4/|http://127.0.0.1:44697/collection1&rid=127.0.0.1-39&wt=javabin&f.test_basictv.tv.tf_idf=false&tv.positions=true&qt=tvrh&f.test_posofftv.tv.positions=false&tv.offsets=true&tv.fl=test_basictv,test_notv,test_postv,test_offtv,test_posofftv&tv.tf_idf=true&version=2&q=id:7&f.test_offtv.tv.offsets=false&omitHeader=false&tv.df=true&NOW=1620429303496&f.test_basictv.tv.tf=false&ids=7&isShard=true} status=0 QTime=0
[junit4] 2> 18118 INFO (qtp1145414865-38) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={f.test_basictv.tv.tf_idf=false&tv=true&tv.positions=true&qt=tvrh&f.test_posofftv.tv.positions=false&tv.tf=true&f.test_basictv.tv.df=false&tv.offsets=true&sort=id+desc&tv.fl=test_basictv,test_notv,test_postv,test_offtv,test_posofftv&tv.tf_idf=true&version=2&q=id:7&shards=[::1]:4/|http://127.0.0.1:44697/collection1&f.test_offtv.tv.offsets=false&tv.df=true&f.test_basictv.tv.tf=false&wt=javabin} rid=127.0.0.1-39 hits=1 status=0 QTime=6
[junit4] 2> 18144 INFO (qtp1219337947-19) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:[3+TO+6]&tv=true&distrib=false&qt=tvrh&tv.tf=true&sort=id+desc&wt=javabin&version=2} hits=4 status=0 QTime=24
[junit4] 2> 18153 INFO (qtp1145414865-42) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=id&shards.purpose=4&tv.tf=true&start=0&fsv=true&sort=id+desc&shard.url=http://127.0.0.1:44697/collection1|[::1]:8/&rid=127.0.0.1-41&rows=10&version=2&q=id:[3+TO+6]&omitHeader=false&NOW=1620429303531&isShard=true&wt=javabin} hits=4 status=0 QTime=0
[junit4] 2> 18156 INFO (qtp1145414865-41) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&shards.purpose=64&tv.tf=true&shard.url=http://127.0.0.1:44697/collection1|[::1]:8/&rid=127.0.0.1-41&version=2&q=id:[3+TO+6]&omitHeader=false&NOW=1620429303531&ids=3,4,5,6&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 18161 INFO (qtp1145414865-40) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:[3+TO+6]&shards=http://127.0.0.1:44697/collection1|[::1]:8/&tv=true&qt=tvrh&tv.tf=true&sort=id+desc&wt=javabin&version=2} rid=127.0.0.1-41 hits=4 status=0 QTime=14
[junit4] 2> 18202 INFO (qtp1219337947-20) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:[3+TO+6]&tv=true&distrib=false&qt=tvrh&fl=*,score&tv.tf=true&sort=id+asc&tv.fl=test_basictv,test_offtv&wt=javabin&version=2} hits=4 status=0 QTime=39
[junit4] 2> 18209 INFO (qtp1145414865-38) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=*,score&shards.purpose=32768&tv.tf=true&solr.stats.fields=id&sort=id+asc&tv.fl=test_basictv,test_offtv&shard.url=[::1]:6/|http://127.0.0.1:44697/collection1|[::1]:8/&rid=127.0.0.1-43&version=2&q=id:[3+TO+6]&omitHeader=false&NOW=1620429303590&isShard=true&solr.stats.terms=id:7&wt=javabin} status=0 QTime=0
[junit4] 2> 18213 INFO (qtp1145414865-42) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=16388&tv.tf=true&start=0&fsv=true&solr.stats.col=&sort=id+asc&tv.fl=test_basictv,test_offtv&shard.url=[::1]:6/|http://127.0.0.1:44697/collection1|[::1]:8/&rid=127.0.0.1-43&rows=10&version=2&q=id:[3+TO+6]&solr.stats.term=&omitHeader=false&NOW=1620429303590&isShard=true&solr.stats.terms=id:7&wt=javabin} hits=4 status=0 QTime=1
[junit4] 2> 18216 INFO (qtp1145414865-41) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=*,score&shards.purpose=64&tv.tf=true&tv.fl=test_basictv,test_offtv&shard.url=[::1]:6/|http://127.0.0.1:44697/collection1|[::1]:8/&rid=127.0.0.1-43&version=2&q=id:[3+TO+6]&omitHeader=false&NOW=1620429303590&ids=3,4,5,6&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 18217 INFO (qtp1145414865-39) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:[3+TO+6]&shards=[::1]:6/|http://127.0.0.1:44697/collection1|[::1]:8/&tv=true&qt=tvrh&fl=*,score&tv.tf=true&sort=id+asc&tv.fl=test_basictv,test_offtv&wt=javabin&version=2} rid=127.0.0.1-43 hits=4 status=0 QTime=11
[junit4] 2> 18219 INFO (qtp1219337947-21) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:[3+TO+6]&tv=true&distrib=false&qt=tvrh&fl=*,score&tv.tf=true&sort=id+asc&tv.fl=test_basictv&tv.fl=test_offtv&wt=javabin&version=2} hits=4 status=0 QTime=0
[junit4] 2> 18223 INFO (qtp1145414865-38) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=16388&tv.tf=true&start=0&fsv=true&sort=id+asc&tv.fl=test_basictv&tv.fl=test_offtv&shard.url=http://127.0.0.1:44697/collection1|[::1]:6/|[::1]:4/|[::1]:8/&rid=127.0.0.1-45&rows=10&version=2&q=id:[3+TO+6]&omitHeader=false&NOW=1620429303604&isShard=true&wt=javabin} hits=4 status=0 QTime=0
[junit4] 2> 18226 INFO (qtp1145414865-42) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=*,score&shards.purpose=64&tv.tf=true&tv.fl=test_basictv&tv.fl=test_offtv&shard.url=http://127.0.0.1:44697/collection1|[::1]:6/|[::1]:4/|[::1]:8/&rid=127.0.0.1-45&version=2&q=id:[3+TO+6]&omitHeader=false&NOW=1620429303604&ids=3,4,5,6&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 18227 INFO (qtp1145414865-40) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:[3+TO+6]&shards=http://127.0.0.1:44697/collection1|[::1]:6/|[::1]:4/|[::1]:8/&tv=true&qt=tvrh&fl=*,score&tv.tf=true&sort=id+asc&tv.fl=test_basictv&tv.fl=test_offtv&wt=javabin&version=2} rid=127.0.0.1-45 hits=4 status=0 QTime=6
[junit4] 2> 18229 INFO (qtp1219337947-17) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:[3+TO+6]&tv=true&distrib=false&qt=tvrh&fl=*,score&tv.tf=true&sort=id+desc&wt=javabin&version=2} hits=4 status=0 QTime=1
[junit4] 2> 18236 INFO (qtp1145414865-39) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=16388&tv.tf=true&start=0&fsv=true&sort=id+desc&shard.url=http://127.0.0.1:44697/collection1&rid=127.0.0.1-47&rows=10&version=2&q=id:[3+TO+6]&omitHeader=false&NOW=1620429303615&isShard=true&wt=javabin} hits=4 status=0 QTime=3
[junit4] 2> 18238 INFO (qtp1145414865-38) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=*,score&shards.purpose=64&tv.tf=true&shard.url=http://127.0.0.1:44697/collection1&rid=127.0.0.1-47&version=2&q=id:[3+TO+6]&omitHeader=false&NOW=1620429303615&ids=3,4,5,6&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 18239 INFO (qtp1145414865-41) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:[3+TO+6]&shards=http://127.0.0.1:44697/collection1&tv=true&qt=tvrh&fl=*,score&tv.tf=true&sort=id+desc&wt=javabin&version=2} rid=127.0.0.1-47 hits=4 status=0 QTime=7
[junit4] 2> 18240 INFO (qtp1219337947-18) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:[3+TO+6]&tv=true&distrib=false&qt=tvrh&fl=score,test_basictv,[docid],test_postv,val:sum(3,4)&tv.tf=true&sort=id+desc&wt=javabin&version=2} hits=4 status=0 QTime=0
[junit4] 2> 18244 INFO (qtp1145414865-40) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=16388&tv.tf=true&start=0&fsv=true&sort=id+desc&shard.url=[::1]:6/|http://127.0.0.1:44697/collection1&rid=127.0.0.1-49&rows=10&version=2&q=id:[3+TO+6]&omitHeader=false&NOW=1620429303625&isShard=true&wt=javabin} hits=4 status=0 QTime=0
[junit4] 2> 18246 INFO (qtp1145414865-39) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=score,test_basictv,[docid],test_postv,val:sum(3,4)&fl=id&shards.purpose=64&tv.tf=true&shard.url=[::1]:6/|http://127.0.0.1:44697/collection1&rid=127.0.0.1-49&version=2&q=id:[3+TO+6]&omitHeader=false&NOW=1620429303625&ids=3,4,5,6&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 18247 INFO (qtp1145414865-42) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:[3+TO+6]&shards=[::1]:6/|http://127.0.0.1:44697/collection1&tv=true&qt=tvrh&fl=score,test_basictv,[docid],test_postv,val:sum(3,4)&tv.tf=true&sort=id+desc&wt=javabin&version=2} rid=127.0.0.1-49 hits=4 status=0 QTime=5
[junit4] 2> 18250 INFO (qtp1219337947-19) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:[3+TO+6]&tv=true&distrib=false&qt=tvrh&fl=score,test_basictv&fl=[docid],test_postv,val:sum(3,4)&tv.tf=true&sort=id+desc&wt=javabin&version=2} hits=4 status=0 QTime=0
[junit4] 2> 18253 INFO (qtp1145414865-41) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=16388&tv.tf=true&start=0&fsv=true&sort=id+desc&shard.url=[::1]:8/|http://127.0.0.1:44697/collection1&rid=127.0.0.1-51&rows=10&version=2&q=id:[3+TO+6]&omitHeader=false&NOW=1620429303635&isShard=true&wt=javabin} hits=4 status=0 QTime=0
[junit4] 2> 18255 INFO (qtp1145414865-40) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=score,test_basictv&fl=[docid],test_postv,val:sum(3,4)&fl=id&shards.purpose=64&tv.tf=true&shard.url=[::1]:8/|http://127.0.0.1:44697/collection1&rid=127.0.0.1-51&version=2&q=id:[3+TO+6]&omitHeader=false&NOW=1620429303635&ids=3,4,5,6&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 18255 INFO (qtp1145414865-38) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:[3+TO+6]&shards=[::1]:8/|http://127.0.0.1:44697/collection1&tv=true&qt=tvrh&fl=score,test_basictv&fl=[docid],test_postv,val:sum(3,4)&tv.tf=true&sort=id+desc&wt=javabin&version=2} rid=127.0.0.1-51 hits=4 status=0 QTime=4
[junit4] 2> 18257 INFO (qtp1219337947-20) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:[3+TO+6]&tv=true&tv.positions=true&distrib=false&qt=tvrh&tv.tf=true&tv.df=true&tv.offsets=true&sort=id+asc&tv.tf_idf=true&wt=javabin&version=2} hits=4 status=0 QTime=0
[junit4] 2> 18259 INFO (qtp1145414865-42) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&tv.positions=true&df=text&distrib=false&qt=tvrh&fl=id&shards.purpose=4&tv.tf=true&start=0&fsv=true&tv.offsets=true&sort=id+asc&shard.url=http://127.0.0.1:44697/collection1&rid=127.0.0.1-53&rows=10&tv.tf_idf=true&version=2&q=id:[3+TO+6]&omitHeader=false&tv.df=true&NOW=1620429303642&isShard=true&wt=javabin} hits=4 status=0 QTime=0
[junit4] 2> 18261 INFO (qtp1145414865-41) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&tv.positions=true&df=text&distrib=false&qt=tvrh&shards.purpose=64&tv.tf=true&tv.offsets=true&shard.url=http://127.0.0.1:44697/collection1&rid=127.0.0.1-53&tv.tf_idf=true&version=2&q=id:[3+TO+6]&omitHeader=false&tv.df=true&NOW=1620429303642&ids=3,4,5,6&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 18262 INFO (qtp1145414865-39) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:[3+TO+6]&shards=http://127.0.0.1:44697/collection1&tv=true&tv.positions=true&qt=tvrh&tv.tf=true&tv.df=true&tv.offsets=true&sort=id+asc&tv.tf_idf=true&wt=javabin&version=2} rid=127.0.0.1-53 hits=4 status=0 QTime=4
[junit4] 2> 18263 INFO (qtp1219337947-21) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:[3+TO+6]&tv=true&tv.all=true&distrib=false&qt=tvrh&sort=id+desc&wt=javabin&version=2} hits=4 status=0 QTime=0
[junit4] 2> 18266 INFO (qtp1145414865-38) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&fl=id&shards.purpose=4&start=0&fsv=true&sort=id+desc&shard.url=[::1]:8/|http://127.0.0.1:44697/collection1&rid=127.0.0.1-55&rows=10&version=2&q=id:[3+TO+6]&tv.all=true&omitHeader=false&NOW=1620429303649&isShard=true&wt=javabin} hits=4 status=0 QTime=0
[junit4] 2> 18268 INFO (qtp1145414865-42) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&df=text&distrib=false&qt=tvrh&shards.purpose=64&shard.url=[::1]:8/|http://127.0.0.1:44697/collection1&rid=127.0.0.1-55&version=2&q=id:[3+TO+6]&tv.all=true&omitHeader=false&NOW=1620429303649&ids=3,4,5,6&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 18269 INFO (qtp1145414865-40) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:[3+TO+6]&shards=[::1]:8/|http://127.0.0.1:44697/collection1&tv=true&tv.all=true&qt=tvrh&sort=id+desc&wt=javabin&version=2} rid=127.0.0.1-55 hits=4 status=0 QTime=4
[junit4] 2> 18270 INFO (qtp1219337947-17) [ x:col
[...truncated too long message...]
etty tag=null
[junit4] 2> 34049 INFO (closeThreadPool-200-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@17231a9a: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@53cfa21
[junit4] 2> 34052 INFO (closeThreadPool-200-thread-6) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
[junit4] 2> 34052 INFO (closeThreadPool-200-thread-6) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@277fabc1: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@66896de1
[junit4] 2> 34060 INFO (closeThreadPool-200-thread-2) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@3a254a99{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 34060 INFO (closeThreadPool-200-thread-6) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
[junit4] 2> 34060 INFO (closeThreadPool-200-thread-6) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@50b6f6ea: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@3b474239
[junit4] 2> 34062 INFO (closeThreadPool-200-thread-6) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
[junit4] 2> 34062 INFO (closeThreadPool-200-thread-6) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@305432a0: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@53cfa21
[junit4] 2> 34069 INFO (closeThreadPool-200-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@6c79771f{/,null,STOPPED}
[junit4] 2> 34069 INFO (closeThreadPool-200-thread-2) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 34070 INFO (closeThreadPool-200-thread-8) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
[junit4] 2> 34071 INFO (closeThreadPool-200-thread-7) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
[junit4] 2> 34070 INFO (closeThreadPool-200-thread-8) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6e630eed: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@7598a292
[junit4] 2> 34071 INFO (closeThreadPool-200-thread-7) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@130a306c: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@2165c334
[junit4] 2> 34078 INFO (closeThreadPool-200-thread-7) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
[junit4] 2> 34078 INFO (closeThreadPool-200-thread-7) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@59710e56: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@3b474239
[junit4] 2> 34080 INFO (closeThreadPool-200-thread-8) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
[junit4] 2> 34080 INFO (closeThreadPool-200-thread-8) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@7c7ab022: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@3b474239
[junit4] 2> 34082 INFO (closeThreadPool-200-thread-8) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
[junit4] 2> 34082 INFO (closeThreadPool-200-thread-8) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@7a23a3bf: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@53cfa21
[junit4] 2> 34082 INFO (closeThreadPool-200-thread-7) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
[junit4] 2> 34082 INFO (closeThreadPool-200-thread-7) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2f96b3b4: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@53cfa21
[junit4] 2> 34084 INFO (closeThreadPool-200-thread-6) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@367b56be{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 34088 INFO (closeThreadPool-200-thread-6) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1fd5db4b{/,null,STOPPED}
[junit4] 2> 34088 INFO (closeThreadPool-200-thread-6) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 34089 INFO (closeThreadPool-200-thread-7) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@6ec665f0{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 34090 INFO (closeThreadPool-200-thread-7) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@7c3db763{/,null,STOPPED}
[junit4] 2> 34090 INFO (closeThreadPool-200-thread-7) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 34090 INFO (closeThreadPool-200-thread-8) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@2ca7352b{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 34090 INFO (closeThreadPool-200-thread-8) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2c894e48{/,null,STOPPED}
[junit4] 2> 34090 INFO (closeThreadPool-200-thread-8) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TermVectorComponentDistributedTest -Dtests.method=test -Dtests.seed=C51802F6B7B9C5BE -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=it-IT -Dtests.timezone=America/Argentina/Buenos_Aires -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] ERROR 30.9s J0 | TermVectorComponentDistributedTest.test <<<
[junit4] > Throwable #1: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:38549/collection1: org.apache.solr.client.solrj.SolrServerException: java.lang.ArithmeticException: / by zero
[junit4] > at __randomizedtesting.SeedInfo.seed([C51802F6B7B9C5BE:4D4C3D2C1945A846]:0)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:681)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:266)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
[junit4] > at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:214)
[junit4] > at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1003)
[junit4] > at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1018)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase.queryServer(BaseDistributedSearchTestCase.java:625)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:677)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:655)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:634)
[junit4] > at org.apache.solr.handler.component.TermVectorComponentDistributedTest.test(TermVectorComponentDistributedTest.java:144)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:1117)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1061)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.component.TermVectorComponentDistributedTest_C51802F6B7B9C5BE-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene87): {test_postv=Lucene84, test_basictv=PostingsFormat(name=Direct), test_posofftv=BlockTreeOrds(blocksize=128), multiDefault=PostingsFormat(name=MockRandom), test_notv=PostingsFormat(name=MockRandom), _root_=BlockTreeOrds(blocksize=128), id=PostingsFormat(name=Direct), test_offtv=BlockTreeOrds(blocksize=128)}, docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene80), _version_=DocValuesFormat(name=Direct), intDefault=DocValuesFormat(name=Direct), id_i1=DocValuesFormat(name=Direct), range_facet_i_dv=DocValuesFormat(name=Asserting), intDvoDefault=DocValuesFormat(name=Lucene80), timestamp=DocValuesFormat(name=Asserting), range_facet_l=DocValuesFormat(name=Asserting)}, maxPointsInLeafNode=544, maxMBSortInHeap=6.052932556977056, sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=it-IT, timezone=America/Argentina/Buenos_Aires
[junit4] 2> NOTE: Linux 4.15.0-142-generic amd64/Oracle Corporation 1.8.0_281 (64-bit)/cpus=4,threads=1,free=127513200,total=319291392
[junit4] 2> NOTE: All tests run in this JVM: [TermVectorComponentDistributedTest]
[junit4] Completed [2/937 (1!)] on J0 in 33.58s, 1 test, 1 error <<< FAILURES!
[...truncated 54027 lines...]