You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2017/01/23 17:29:19 UTC
[JENKINS] Lucene-Solr-6.x-Windows (64bit/jdk1.8.0_121) - Build #
700 - Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Windows/700/
Java: 64bit/jdk1.8.0_121 -XX:+UseCompressedOops -XX:+UseParallelGC
1 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.handler.component.TermVectorComponentDistributedTest
Error Message:
Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_8E911FC879BC9232-001\tempDir-001\shard2\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_8E911FC879BC9232-001\tempDir-001\shard2\collection1 C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_8E911FC879BC9232-001\tempDir-001\shard2: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_8E911FC879BC9232-001\tempDir-001\shard2 C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_8E911FC879BC9232-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_8E911FC879BC9232-001\tempDir-001
Stack Trace:
java.io.IOException: Could not remove the following files (in the order of attempts):
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_8E911FC879BC9232-001\tempDir-001\shard2\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_8E911FC879BC9232-001\tempDir-001\shard2\collection1
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_8E911FC879BC9232-001\tempDir-001\shard2: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_8E911FC879BC9232-001\tempDir-001\shard2
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_8E911FC879BC9232-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_8E911FC879BC9232-001\tempDir-001
at __randomizedtesting.SeedInfo.seed([8E911FC879BC9232]:0)
at org.apache.lucene.util.IOUtils.rm(IOUtils.java:323)
at org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:216)
at com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterAlways(TestRuleAdapter.java:31)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 11054 lines...]
[junit4] Suite: org.apache.solr.handler.component.TermVectorComponentDistributedTest
[junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_8E911FC879BC9232-001\init-core-data-001
[junit4] 2> 280423 INFO (SUITE-TermVectorComponentDistributedTest-seed#[8E911FC879BC9232]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 280423 INFO (SUITE-TermVectorComponentDistributedTest-seed#[8E911FC879BC9232]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
[junit4] 2> 280970 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_8E911FC879BC9232-001\tempDir-001\control\cores\collection1
[junit4] 2> 280973 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 280975 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3d28446{/,null,AVAILABLE}
[junit4] 2> 280978 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@2734e56e{HTTP/1.1,[http/1.1]}{127.0.0.1:56011}
[junit4] 2> 280978 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.e.j.s.Server Started @286436ms
[junit4] 2> 280978 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=56011, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_8E911FC879BC9232-001\tempDir-001\control\cores}
[junit4] 2> 280979 ERROR (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 280979 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 6.5.0
[junit4] 2> 280979 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 280979 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 280979 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-01-23T16:23:07.340Z
[junit4] 2> 280980 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_8E911FC879BC9232-001\tempDir-001\control\solr.xml
[junit4] 2> 280993 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 280997 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_8E911FC879BC9232-001\tempDir-001\control\cores
[junit4] 2> 280997 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 281002 INFO (coreLoadExecutor-1185-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-6.x-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-6.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 281082 INFO (coreLoadExecutor-1185-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.5.0
[junit4] 2> 281100 INFO (coreLoadExecutor-1185-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 281169 WARN (coreLoadExecutor-1185-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 281170 INFO (coreLoadExecutor-1185-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 281185 INFO (coreLoadExecutor-1185-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1
[junit4] 2> 281187 INFO (coreLoadExecutor-1185-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_8E911FC879BC9232-001\tempDir-001\control\cores\collection1\data\]
[junit4] 2> 281187 INFO (coreLoadExecutor-1185-thread-1) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@65825b76
[junit4] 2> 281188 INFO (coreLoadExecutor-1185-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=12, maxMergeAtOnceExplicit=46, maxMergedSegmentMB=3.6298828125, floorSegmentMB=2.064453125, forceMergeDeletesPctAllowed=0.12173039557874854, segmentsPerTier=44.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 281218 INFO (coreLoadExecutor-1185-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 281218 INFO (coreLoadExecutor-1185-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 281219 INFO (coreLoadExecutor-1185-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 281219 INFO (coreLoadExecutor-1185-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 281220 INFO (coreLoadExecutor-1185-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=38, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 281221 INFO (coreLoadExecutor-1185-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@64ef16ff[collection1] main]
[junit4] 2> 281222 INFO (coreLoadExecutor-1185-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 281238 INFO (coreLoadExecutor-1185-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 281289 INFO (coreLoadExecutor-1185-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 281289 INFO (searcherExecutor-1186-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 281291 INFO (searcherExecutor-1186-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 281291 INFO (searcherExecutor-1186-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 281291 INFO (searcherExecutor-1186-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 281291 INFO (searcherExecutor-1186-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 281291 INFO (searcherExecutor-1186-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 281292 INFO (coreLoadExecutor-1185-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1557333108486832128
[junit4] 2> 281292 INFO (searcherExecutor-1186-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 281293 INFO (searcherExecutor-1186-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 281293 INFO (searcherExecutor-1186-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 281294 INFO (searcherExecutor-1186-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@64ef16ff[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 282101 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_8E911FC879BC9232-001\tempDir-001\shard0\cores\collection1
[junit4] 2> 282104 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 282105 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6c346276{/,null,AVAILABLE}
[junit4] 2> 282106 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@7d720e86{HTTP/1.1,[http/1.1]}{127.0.0.1:56014}
[junit4] 2> 282107 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.e.j.s.Server Started @287564ms
[junit4] 2> 282107 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=56014, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_8E911FC879BC9232-001\tempDir-001\shard0\cores}
[junit4] 2> 282107 ERROR (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 282107 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 6.5.0
[junit4] 2> 282107 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 282107 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 282107 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-01-23T16:23:08.468Z
[junit4] 2> 282108 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_8E911FC879BC9232-001\tempDir-001\shard0\solr.xml
[junit4] 2> 282122 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 282126 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_8E911FC879BC9232-001\tempDir-001\shard0\cores
[junit4] 2> 282126 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 282130 INFO (coreLoadExecutor-1196-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-6.x-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-6.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 282196 INFO (coreLoadExecutor-1196-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.5.0
[junit4] 2> 282213 INFO (coreLoadExecutor-1196-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 282287 WARN (coreLoadExecutor-1196-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 282288 INFO (coreLoadExecutor-1196-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 282304 INFO (coreLoadExecutor-1196-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1
[junit4] 2> 282305 INFO (coreLoadExecutor-1196-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_8E911FC879BC9232-001\tempDir-001\shard0\cores\collection1\data\]
[junit4] 2> 282305 INFO (coreLoadExecutor-1196-thread-1) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@65825b76
[junit4] 2> 282306 INFO (coreLoadExecutor-1196-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=12, maxMergeAtOnceExplicit=46, maxMergedSegmentMB=3.6298828125, floorSegmentMB=2.064453125, forceMergeDeletesPctAllowed=0.12173039557874854, segmentsPerTier=44.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 282330 INFO (coreLoadExecutor-1196-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 282330 INFO (coreLoadExecutor-1196-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 282331 INFO (coreLoadExecutor-1196-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 282331 INFO (coreLoadExecutor-1196-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 282332 INFO (coreLoadExecutor-1196-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=38, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 282334 INFO (coreLoadExecutor-1196-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@836d3f[collection1] main]
[junit4] 2> 282334 INFO (coreLoadExecutor-1196-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 282348 INFO (coreLoadExecutor-1196-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 282398 INFO (coreLoadExecutor-1196-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 282399 INFO (searcherExecutor-1197-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 282399 INFO (searcherExecutor-1197-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 282399 INFO (searcherExecutor-1197-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 282399 INFO (searcherExecutor-1197-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 282400 INFO (coreLoadExecutor-1196-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1557333109648654336
[junit4] 2> 282401 INFO (searcherExecutor-1197-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 282401 INFO (searcherExecutor-1197-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 282402 INFO (searcherExecutor-1197-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 282403 INFO (searcherExecutor-1197-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 282403 INFO (searcherExecutor-1197-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 282404 INFO (searcherExecutor-1197-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@836d3f[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 282686 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 282712 INFO (qtp1685342016-2265) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[0 (1557333109952741376)]} 0 23
[junit4] 2> 282723 INFO (qtp2138223701-2275) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[0 (1557333109978955776)]} 0 7
[junit4] 2> 282729 INFO (qtp1685342016-2262) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[1 (1557333109991538688)]} 0 3
[junit4] 2> 282737 INFO (qtp2138223701-2277) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[1 (1557333109997830144)]} 0 3
[junit4] 2> 282742 INFO (qtp1685342016-2261) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[2 (1557333110004121600)]} 0 3
[junit4] 2> 282747 INFO (qtp2138223701-2278) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[2 (1557333110009364480)]} 0 2
[junit4] 2> 282751 INFO (qtp1685342016-2260) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[3 (1557333110014607360)]} 0 1
[junit4] 2> 282755 INFO (qtp2138223701-2278) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[3 (1557333110019850240)]} 0 0
[junit4] 2> 282757 INFO (qtp1685342016-2260) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[4 (1557333110022995968)]} 0 0
[junit4] 2> 282760 INFO (qtp2138223701-2278) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[4 (1557333110025093120)]} 0 0
[junit4] 2> 282761 INFO (qtp1685342016-2258) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[5 (1557333110027190272)]} 0 0
[junit4] 2> 282764 INFO (qtp2138223701-2278) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[5 (1557333110030336000)]} 0 0
[junit4] 2> 282766 INFO (qtp1685342016-2258) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[6 (1557333110032433152)]} 0 0
[junit4] 2> 282769 INFO (qtp2138223701-2278) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[6 (1557333110035578880)]} 0 0
[junit4] 2> 282776 INFO (qtp1685342016-2258) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[7 (1557333110040821760)]} 0 0
[junit4] 2> 282779 INFO (qtp2138223701-2278) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[7 (1557333110045016064)]} 0 0
[junit4] 2> 282782 INFO (qtp1685342016-2258) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[8 (1557333110049210368)]} 0 0
[junit4] 2> 282786 INFO (qtp2138223701-2278) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[8 (1557333110052356096)]} 0 1
[junit4] 2> 282792 INFO (qtp1685342016-2258) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[9 (1557333110056550400)]} 0 2
[junit4] 2> 282794 INFO (qtp2138223701-2278) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[9 (1557333110061793280)]} 0 0
[junit4] 2> 282796 INFO (qtp1685342016-2258) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 282796 INFO (qtp1685342016-2258) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@3861762f
[junit4] 2> 282817 INFO (qtp1685342016-2258) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@736d6637[collection1] main]
[junit4] 2> 282819 INFO (searcherExecutor-1186-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@736d6637[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.5.0):c10)))}
[junit4] 2> 282819 INFO (qtp1685342016-2258) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 282819 INFO (qtp1685342016-2258) [ 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 22
[junit4] 2> 282822 INFO (qtp2138223701-2278) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 282822 INFO (qtp2138223701-2278) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1cf05c26
[junit4] 2> 282841 INFO (qtp2138223701-2278) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@cfa9454[collection1] main]
[junit4] 2> 282844 INFO (searcherExecutor-1197-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@cfa9454[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.5.0):c10)))}
[junit4] 2> 282844 INFO (qtp2138223701-2278) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 282844 INFO (qtp2138223701-2278) [ 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 22
[junit4] 2> 282864 INFO (qtp1685342016-2261) [ 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=17
[junit4] 2> 282876 INFO (qtp2138223701-2282) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=id&shards.purpose=4&tv.tf=true&start=0&fsv=true&sort=id+desc&shard.url=[ff01::083]:33332/|[ff01::213]:33332/|[ff01::114]:33332/|http://127.0.0.1:56014//collection1&rows=10&version=2&q=id:0&NOW=1485188589227&isShard=true&wt=javabin} hits=1 status=0 QTime=3
[junit4] 2> 282883 INFO (qtp2138223701-2282) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:0&tv=true&distrib=false&qt=tvrh&shards.purpose=64&tv.tf=true&NOW=1485188589227&ids=0&isShard=true&shard.url=[ff01::083]:33332/|[ff01::213]:33332/|[ff01::114]:33332/|http://127.0.0.1:56014//collection1&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 282884 INFO (qtp2138223701-2281) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:0&shards=[ff01::083]:33332/|[ff01::213]:33332/|[ff01::114]:33332/|http://127.0.0.1:56014//collection1&tv=true&qt=tvrh&tv.tf=true&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=17
[junit4] 2> 282893 INFO (qtp1685342016-2261) [ 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=3
[junit4] 2> 282905 INFO (qtp2138223701-2279) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=*,score&shards.purpose=32768&tv.tf=true&sort=id+asc&tv.fl=test_basictv,test_offtv&shard.url=[ff01::083]:33332/|[ff01::114]:33332/|http://127.0.0.1:56014//collection1&version=2&q=id:0&NOW=1485188589256&isShard=true&wt=javabin} status=0 QTime=9
[junit4] 2> 282911 INFO (qtp2138223701-2279) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=16388&tv.tf=true&start=0&fsv=true&org.apache.solr.stats.termStats=id:`%08%00%00%00%00,1,1&sort=id+asc&tv.fl=test_basictv,test_offtv&shard.url=[ff01::083]:33332/|[ff01::114]:33332/|http://127.0.0.1:56014//collection1&rows=10&version=2&org.apache.solr.stats.colStats=id,10,10,10,10&q=id:0&NOW=1485188589256&isShard=true&org.apache.solr.stats.terms=id:`%08%00%00%00%00&wt=javabin} hits=1 status=0 QTime=2
[junit4] 2> 282915 INFO (qtp2138223701-2279) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&distrib=false&qt=tvrh&fl=*,score&shards.purpose=64&tv.tf=true&tv.fl=test_basictv,test_offtv&shard.url=[ff01::083]:33332/|[ff01::114]:33332/|http://127.0.0.1:56014//collection1&version=2&q=id:0&NOW=1485188589256&ids=0&isShard=true&wt=javabin} status=0 QTime=1
[junit4] 2> 282915 INFO (qtp2138223701-2282) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:0&shards=[ff01::083]:33332/|[ff01::114]:33332/|http://127.0.0.1:56014//collection1&tv=true&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=20
[junit4] 2> 282922 INFO (qtp1685342016-2261) [ 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> 282926 INFO (qtp2138223701-2281) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=*,score&shards.purpose=32768&tv.tf=true&sort=id+asc&tv.fl=test_basictv&tv.fl=test_offtv&shard.url=http://127.0.0.1:56014//collection1&version=2&q=id:0&NOW=1485188589285&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 282929 INFO (qtp2138223701-2281) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=16388&tv.tf=true&start=0&fsv=true&org.apache.solr.stats.termStats=id:`%08%00%00%00%00,1,1&sort=id+asc&tv.fl=test_basictv&tv.fl=test_offtv&shard.url=http://127.0.0.1:56014//collection1&rows=10&version=2&org.apache.solr.stats.colStats=id,10,10,10,10&q=id:0&NOW=1485188589285&isShard=true&org.apache.solr.stats.terms=id:`%08%00%00%00%00&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 282931 INFO (qtp2138223701-2281) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&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:56014//collection1&version=2&q=id:0&NOW=1485188589285&ids=0&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 282932 INFO (qtp2138223701-2279) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:0&shards=http://127.0.0.1:56014//collection1&tv=true&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=7
[junit4] 2> 282934 INFO (qtp1685342016-2261) [ 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=0
[junit4] 2> 282940 INFO (qtp2138223701-2282) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=*,score&shards.purpose=32768&tv.tf=true&sort=id+desc&shard.url=http://127.0.0.1:56014//collection1|[ff01::213]:33332/&version=2&q=id:0&NOW=1485188589298&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 282943 INFO (qtp2138223701-2282) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=16388&tv.tf=true&start=0&fsv=true&org.apache.solr.stats.termStats=id:`%08%00%00%00%00,1,1&sort=id+desc&shard.url=http://127.0.0.1:56014//collection1|[ff01::213]:33332/&rows=10&version=2&org.apache.solr.stats.colStats=id,10,10,10,10&q=id:0&NOW=1485188589298&isShard=true&org.apache.solr.stats.terms=id:`%08%00%00%00%00&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 282946 INFO (qtp2138223701-2277) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&distrib=false&qt=tvrh&fl=*,score&shards.purpose=64&tv.tf=true&shard.url=http://127.0.0.1:56014//collection1|[ff01::213]:33332/&version=2&q=id:0&NOW=1485188589298&ids=0&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 282947 INFO (qtp2138223701-2281) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:0&shards=http://127.0.0.1:56014//collection1|[ff01::213]:33332/&tv=true&qt=tvrh&fl=*,score&tv.tf=true&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=9
[junit4] 2> 282949 INFO (qtp1685342016-2261) [ 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=0
[junit4] 2> 282955 INFO (qtp2138223701-2279) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=score,test_basictv,[docid],test_postv,val:sum(3,4)&shards.purpose=32768&tv.tf=true&sort=id+desc&shard.url=http://127.0.0.1:56014//collection1&version=2&q=id:0&NOW=1485188589313&isShard=true&wt=javabin} status=0 QTime=1
[junit4] 2> 282957 INFO (qtp2138223701-2279) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=16388&tv.tf=true&start=0&fsv=true&org.apache.solr.stats.termStats=id:`%08%00%00%00%00,1,1&sort=id+desc&shard.url=http://127.0.0.1:56014//collection1&rows=10&version=2&org.apache.solr.stats.colStats=id,10,10,10,10&q=id:0&NOW=1485188589313&isShard=true&org.apache.solr.stats.terms=id:`%08%00%00%00%00&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 282963 INFO (qtp2138223701-2279) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&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:56014//collection1&version=2&q=id:0&NOW=1485188589313&ids=0&isShard=true&wt=javabin} status=0 QTime=2
[junit4] 2> 282963 INFO (qtp2138223701-2277) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:0&shards=http://127.0.0.1:56014//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} hits=1 status=0 QTime=11
[junit4] 2> 282967 INFO (qtp1685342016-2261) [ 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> 282969 INFO (qtp2138223701-2281) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&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:56014//collection1&version=2&q=id:0&NOW=1485188589329&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 282971 INFO (qtp2138223701-2281) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=16388&tv.tf=true&start=0&fsv=true&org.apache.solr.stats.termStats=id:`%08%00%00%00%00,1,1&sort=id+desc&shard.url=http://127.0.0.1:56014//collection1&rows=10&version=2&org.apache.solr.stats.colStats=id,10,10,10,10&q=id:0&NOW=1485188589329&isShard=true&org.apache.solr.stats.terms=id:`%08%00%00%00%00&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 282973 INFO (qtp2138223701-2281) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&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:56014//collection1&version=2&q=id:0&NOW=1485188589329&ids=0&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 282974 INFO (qtp2138223701-2279) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:0&shards=http://127.0.0.1:56014//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} hits=1 status=0 QTime=5
[junit4] 2> 282976 INFO (qtp1685342016-2261) [ 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> 282981 INFO (qtp2138223701-2282) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&tv.positions=true&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:56014//collection1|[ff01::114]:33332/|[ff01::213]:33332/&rows=10&tv.tf_idf=true&version=2&q=id:0&tv.df=true&NOW=1485188589340&isShard=true&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 282987 INFO (qtp2138223701-2282) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&tv.positions=true&distrib=false&qt=tvrh&shards.purpose=64&tv.tf=true&tv.offsets=true&shard.url=http://127.0.0.1:56014//collection1|[ff01::114]:33332/|[ff01::213]:33332/&tv.tf_idf=true&version=2&q=id:0&tv.df=true&NOW=1485188589340&ids=0&isShard=true&wt=javabin} status=0 QTime=2
[junit4] 2> 282992 INFO (qtp2138223701-2281) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:0&shards=http://127.0.0.1:56014//collection1|[ff01::114]:33332/|[ff01::213]:33332/&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} hits=1 status=0 QTime=12
[junit4] 2> 282997 INFO (qtp1685342016-2261) [ 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> 283002 INFO (qtp2138223701-2278) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=id&shards.purpose=4&start=0&fsv=true&sort=id+desc&shard.url=[ff01::213]:33332/|[ff01::083]:33332/|http://127.0.0.1:56014//collection1&rows=10&version=2&q=id:0&tv.all=true&NOW=1485188589360&isShard=true&wt=javabin} hits=1 status=0 QTime=1
[junit4] 2> 283005 INFO (qtp2138223701-2278) [ 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&shards.purpose=64&NOW=1485188589360&ids=0&isShard=true&shard.url=[ff01::213]:33332/|[ff01::083]:33332/|http://127.0.0.1:56014//collection1&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 283006 INFO (qtp2138223701-2282) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:0&shards=[ff01::213]:33332/|[ff01::083]:33332/|http://127.0.0.1:56014//collection1&tv=true&tv.all=true&qt=tvrh&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=6
[junit4] 2> 283007 INFO (qtp1685342016-2261) [ 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> 283014 INFO (qtp2138223701-2277) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&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:56014//collection1&rows=1&version=2&q=id:0&tv.all=true&NOW=1485188589370&isShard=true&wt=javabin} hits=1 status=0 QTime=1
[junit4] 2> 283015 INFO (qtp2138223701-2278) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:0&shards=http://127.0.0.1:56014//collection1&tv=true&tv.all=true&qt=tvrh&sort=id+desc&distrib.singlePass=true&rows=1&wt=javabin&version=2} hits=1 status=0 QTime=5
[junit4] 2> 283016 INFO (qtp1685342016-2261) [ 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> 283019 INFO (qtp2138223701-2280) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&fl=id&shards.purpose=4&tv.tf=true&f.test_basictv.tv.df=false&fsv=true&shard.url=[ff01::114]:33332/|http://127.0.0.1:56014//collection1&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&tv.df=true&NOW=1485188589379&f.test_basictv.tv.tf=false&isShard=true} hits=1 status=0 QTime=0
[junit4] 2> 283023 INFO (qtp2138223701-2280) [ 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&shards.purpose=64&tv.tf=true&f.test_basictv.tv.df=false&tv.offsets=true&tv.fl=test_basictv,test_notv,test_postv,test_offtv,test_posofftv&shard.url=[ff01::114]:33332/|http://127.0.0.1:56014//collection1&tv.tf_idf=true&version=2&q=id:0&f.test_offtv.tv.offsets=false&tv.df=true&NOW=1485188589379&f.test_basictv.tv.tf=false&ids=0&isShard=true&wt=javabin} status=0 QTime=1
[junit4] 2> 283023 INFO (qtp2138223701-2277) [ 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=[ff01::114]:33332/|http://127.0.0.1:56014//collection1&f.test_offtv.tv.offsets=false&tv.df=true&f.test_basictv.tv.tf=false&wt=javabin} hits=1 status=0 QTime=5
[junit4] 2> 283027 INFO (qtp1685342016-2261) [ 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> 283029 INFO (qtp2138223701-2275) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=id&shards.purpose=4&tv.tf=true&start=0&fsv=true&sort=id+desc&shard.url=[ff01::114]:33332/|http://127.0.0.1:56014//collection1|[ff01::083]:33332/|[ff01::213]:33332/&rows=10&version=2&q=id:7&NOW=1485188589389&isShard=true&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 283032 INFO (qtp2138223701-2275) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:7&tv=true&distrib=false&qt=tvrh&shards.purpose=64&tv.tf=true&NOW=1485188589389&ids=7&isShard=true&shard.url=[ff01::114]:33332/|http://127.0.0.1:56014//collection1|[ff01::083]:33332/|[ff01::213]:33332/&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 283032 INFO (qtp2138223701-2280) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:7&shards=[ff01::114]:33332/|http://127.0.0.1:56014//collection1|[ff01::083]:33332/|[ff01::213]:33332/&tv=true&qt=tvrh&tv.tf=true&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=4
[junit4] 2> 283034 INFO (qtp1685342016-2261) [ 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> 283040 INFO (qtp2138223701-2279) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=*,score&shards.purpose=32768&tv.tf=true&sort=id+asc&tv.fl=test_basictv,test_offtv&shard.url=http://127.0.0.1:56014//collection1&version=2&q=id:7&NOW=1485188589397&isShard=true&wt=javabin} status=0 QTime=2
[junit4] 2> 283041 INFO (qtp2138223701-2279) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=16388&tv.tf=true&start=0&fsv=true&org.apache.solr.stats.termStats=id:`%08%00%00%00%07,1,1&sort=id+asc&tv.fl=test_basictv,test_offtv&shard.url=http://127.0.0.1:56014//collection1&rows=10&version=2&org.apache.solr.stats.colStats=id,10,10,10,10&q=id:7&NOW=1485188589397&isShard=true&org.apache.solr.stats.terms=id:`%08%00%00%00%07&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 283044 INFO (qtp2138223701-2279) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&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:56014//collection1&version=2&q=id:7&NOW=1485188589397&ids=7&isShard=true&wt=javabin} status=0 QTime=1
[junit4] 2> 283045 INFO (qtp2138223701-2278) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:7&shards=http://127.0.0.1:56014//collection1&tv=true&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=9
[junit4] 2> 283047 INFO (qtp1685342016-2261) [ 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> 283057 INFO (qtp2138223701-2275) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=*,score&shards.purpose=32768&tv.tf=true&sort=id+asc&tv.fl=test_basictv&tv.fl=test_offtv&shard.url=http://127.0.0.1:56014//collection1|[ff01::213]:33332/&version=2&q=id:7&NOW=1485188589410&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 283059 INFO (qtp2138223701-2275) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=16388&tv.tf=true&start=0&fsv=true&org.apache.solr.stats.termStats=id:`%08%00%00%00%07,1,1&sort=id+asc&tv.fl=test_basictv&tv.fl=test_offtv&shard.url=http://127.0.0.1:56014//collection1|[ff01::213]:33332/&rows=10&version=2&org.apache.solr.stats.colStats=id,10,10,10,10&q=id:7&NOW=1485188589410&isShard=true&org.apache.solr.stats.terms=id:`%08%00%00%00%07&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 283061 INFO (qtp2138223701-2275) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&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:56014//collection1|[ff01::213]:33332/&version=2&q=id:7&NOW=1485188589410&ids=7&isShard=true&wt=javabin} status=0 QTime=1
[junit4] 2> 283063 INFO (qtp2138223701-2279) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:7&shards=http://127.0.0.1:56014//collection1|[ff01::213]:33332/&tv=true&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=13
[junit4] 2> 283065 INFO (qtp1685342016-2261) [ 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> 283068 INFO (qtp2138223701-2281) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=*,score&shards.purpose=32768&tv.tf=true&sort=id+desc&shard.url=[ff01::114]:33332/|http://127.0.0.1:56014//collection1|[ff01::213]:33332/&version=2&q=id:7&NOW=1485188589428&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 283069 INFO (qtp2138223701-2281) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=16388&tv.tf=true&start=0&fsv=true&org.apache.solr.stats.termStats=id:`%08%00%00%00%07,1,1&sort=id+desc&shard.url=[ff01::114]:33332/|http://127.0.0.1:56014//collection1|[ff01::213]:33332/&rows=10&version=2&org.apache.solr.stats.colStats=id,10,10,10,10&q=id:7&NOW=1485188589428&isShard=true&org.apache.solr.stats.terms=id:`%08%00%00%00%07&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 283071 INFO (qtp2138223701-2281) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&distrib=false&qt=tvrh&fl=*,score&shards.purpose=64&tv.tf=true&shard.url=[ff01::114]:33332/|http://127.0.0.1:56014//collection1|[ff01::213]:33332/&version=2&q=id:7&NOW=1485188589428&ids=7&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 283072 INFO (qtp2138223701-2275) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:7&shards=[ff01::114]:33332/|http://127.0.0.1:56014//collection1|[ff01::213]:33332/&tv=true&qt=tvrh&fl=*,score&tv.tf=true&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=4
[junit4] 2> 283073 INFO (qtp1685342016-2261) [ 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> 283077 INFO (qtp2138223701-2279) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=score,test_basictv,[docid],test_postv,val:sum(3,4)&shards.purpose=32768&tv.tf=true&sort=id+desc&shard.url=http://127.0.0.1:56014//collection1&version=2&q=id:7&NOW=1485188589437&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 283078 INFO (qtp2138223701-2279) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=16388&tv.tf=true&start=0&fsv=true&org.apache.solr.stats.termStats=id:`%08%00%00%00%07,1,1&sort=id+desc&shard.url=http://127.0.0.1:56014//collection1&rows=10&version=2&org.apache.solr.stats.colStats=id,10,10,10,10&q=id:7&NOW=1485188589437&isShard=true&org.apache.solr.stats.terms=id:`%08%00%00%00%07&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 283089 INFO (qtp2138223701-2279) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&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:56014//collection1&version=2&q=id:7&NOW=1485188589437&ids=7&isShard=true&wt=javabin} status=0 QTime=10
[junit4] 2> 283090 INFO (qtp2138223701-2281) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:7&shards=http://127.0.0.1:56014//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} hits=1 status=0 QTime=14
[junit4] 2> 283106 INFO (qtp1685342016-2261) [ 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=15
[junit4] 2> 283109 INFO (qtp2138223701-2278) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&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=[ff01::083]:33332/|http://127.0.0.1:56014//collection1&version=2&q=id:7&NOW=1485188589469&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 283113 INFO (qtp2138223701-2278) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=16388&tv.tf=true&start=0&fsv=true&org.apache.solr.stats.termStats=id:`%08%00%00%00%07,1,1&sort=id+desc&shard.url=[ff01::083]:33332/|http://127.0.0.1:56014//collection1&rows=10&version=2&org.apache.solr.stats.colStats=id,10,10,10,10&q=id:7&NOW=1485188589469&isShard=true&org.apache.solr.stats.terms=id:`%08%00%00%00%07&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 283116 INFO (qtp2138223701-2278) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&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=[ff01::083]:33332/|http://127.0.0.1:56014//collection1&version=2&q=id:7&NOW=1485188589469&ids=7&isShard=true&wt=javabin} status=0 QTime=2
[junit4] 2> 283117 INFO (qtp2138223701-2279) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:7&shards=[ff01::083]:33332/|http://127.0.0.1:56014//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} hits=1 status=0 QTime=8
[junit4] 2> 283118 INFO (qtp1685342016-2261) [ 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> 283124 INFO (qtp2138223701-2282) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&tv.positions=true&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:56014//collection1|[ff01::114]:33332/&rows=10&tv.tf_idf=true&version=2&q=id:7&tv.df=true&NOW=1485188589482&isShard=true&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 283127 INFO (qtp2138223701-2282) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&tv.positions=true&distrib=false&qt=tvrh&shards.purpose=64&tv.tf=true&tv.offsets=true&shard.url=http://127.0.0.1:56014//collection1|[ff01::114]:33332/&tv.tf_idf=true&version=2&q=id:7&tv.df=true&NOW=1485188589482&ids=7&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 283128 INFO (qtp2138223701-2278) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:7&shards=http://127.0.0.1:56014//collection1|[ff01::114]:33332/&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} hits=1 status=0 QTime=6
[junit4] 2> 283129 INFO (qtp1685342016-2261) [ 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> 283132 INFO (qtp2138223701-2277) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=id&shards.purpose=4&start=0&fsv=true&sort=id+desc&shard.url=http://127.0.0.1:56014//collection1&rows=10&version=2&q=id:7&tv.all=true&NOW=1485188589492&isShard=true&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 283136 INFO (qtp2138223701-2277) [ 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&shards.purpose=64&NOW=1485188589492&ids=7&isShard=true&shard.url=http://127.0.0.1:56014//collection1&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 283136 INFO (qtp2138223701-2282) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:7&shards=http://127.0.0.1:56014//collection1&tv=true&tv.all=true&qt=tvrh&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=5
[junit4] 2> 283138 INFO (qtp1685342016-2261) [ 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> 283142 INFO (qtp2138223701-2281) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&distrib=false&qt=tvrh&fl=*&shards.purpose=68&start=0&fsv=true&sort=id+desc&distrib.singlePass=true&shard.url=[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:56014//collection1|[ff01::114]:33332/&rows=1&version=2&q=id:7&tv.all=true&NOW=1485188589502&isShard=true&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 283143 INFO (qtp2138223701-2277) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:7&shards=[ff01::083]:33332/|[ff01::213]:33332/|http://127.0.0.1:56014//collection1|[ff01::114]:33332/&tv=true&tv.all=true&qt=tvrh&sort=id+desc&distrib.singlePass=true&rows=1&wt=javabin&version=2} hits=1 status=0 QTime=1
[junit4] 2> 283144 INFO (qtp1685342016-2261) [ 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> 283149 INFO (qtp2138223701-2279) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&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:56014//collection1&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&tv.df=true&NOW=1485188589509&f.test_basictv.tv.tf=false&isShard=true} hits=1 status=0 QTime=0
[junit4] 2> 283151 INFO (qtp2138223701-2279) [ 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&shards.purpose=64&tv.tf=true&f.test_basictv.tv.df=false&tv.offsets=true&tv.fl=test_basictv,test_notv,test_postv,test_offtv,test_posofftv&shard.url=http://127.0.0.1:56014//collection1&tv.tf_idf=true&version=2&q=id:7&f.test_offtv.tv.offsets=false&tv.df=true&NOW=1485188589509&f.test_basictv.tv.tf=false&ids=7&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 283152 INFO (qtp2138223701-2281) [ 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=http://127.0.0.1:56014//collection1&f.test_offtv.tv.offsets=false&tv.df=true&f.test_basictv.tv.tf=false&wt=javabin} hits=1 status=0 QTime=4
[junit4] 2> 283154 INFO (qtp1685342016-2261) [ 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=1
[junit4] 2> 283159 INFO (qtp2138223701-2275) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&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:56014//collection1&rows=10&version=2&q=id:[3+TO+6]&NOW=1485188589517&isShard=true&wt=javabin} hits=4 status=0 QTime=1
[junit4] 2> 283161 INFO (qtp2138223701-2275) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:[3+TO+6]&tv=true&distrib=false&qt=tvrh&shards.purpose=64&tv.tf=true&NOW=1485188589517&ids=3,4,5,6&isShard=true&shard.url=http://127.0.0.1:56014//collection1&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 283162 INFO (qtp2138223701-2282) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:[3+TO+6]&shards=http://127.0.0.1:56014//collection1&tv=true&qt=tvrh&tv.tf=true&sort=id+desc&wt=javabin&version=2} hits=4 status=0 QTime=5
[junit4] 2> 283164 INFO (qtp1685342016-2261) [ 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=1
[junit4] 2> 283169 INFO (qtp2138223701-2280) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=*,score&shards.purpose=32768&tv.tf=true&sort=id+asc&tv.fl=test_basictv,test_offtv&shard.url=[ff01::083]:33332/|[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:56014//collection1&version=2&q=id:[3+TO+6]&NOW=1485188589529&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 283171 INFO (qtp2138223701-2280) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&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,test_offtv&shard.url=[ff01::083]:33332/|[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:56014//collection1&rows=10&version=2&q=id:[3+TO+6]&NOW=1485188589529&isShard=true&wt=javabin} hits=4 status=0 QTime=0
[junit4] 2> 283173 INFO (qtp2138223701-2280) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&distrib=false&qt=tvrh&fl=*,score&shards.purpose=64&tv.tf=true&tv.fl=test_basictv,test_offtv&shard.url=[ff01::083]:33332/|[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:56014//collection1&version=2&q=id:[3+TO+6]&NOW=1485188589529&ids=3,4,5,6&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 283173 INFO (qtp2138223701-2275) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:[3+TO+6]&shards=[ff01::083]:33332/|[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:56014//collection1&tv=true&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=5
[junit4] 2> 283175 INFO (qtp1685342016-2261) [ 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> 283177 INFO (qtp2138223701-2277) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=*,score&shards.purpose=32768&tv.tf=true&sort=id+asc&tv.fl=test_basictv&tv.fl=test_offtv&shard.url=[ff01::114]:33332/|http://127.0.0.1:56014//collection1&version=2&q=id:[3+TO+6]&NOW=1485188589537&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 283178 INFO (qtp2138223701-2277) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&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=[ff01::114]:33332/|http://127.0.0.1:56014//collection1&rows=10&version=2&q=id:[3+TO+6]&NOW=1485188589537&isShard=true&wt=javabin} hits=4 status=0 QTime=0
[junit4] 2> 283188 INFO (qtp2138223701-2277) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&distrib=false&qt=tvrh&fl=*,score&shards.purpose=64&tv.tf=true&tv.fl=test_basictv&tv.fl=test_offtv&shard.url=[ff01::114]:33332/|http://127.0.0.1:56014//collection1&version=2&q=id:[3+TO+6]&NOW=1485188589537&ids=3,4,5,6&isShard=true&wt=javabin} status=0 QTime=8
[junit4] 2> 283188 INFO (qtp2138223701-2280) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:[3+TO+6]&shards=[ff01::114]:33332/|http://127.0.0.1:56014//collection1&tv=true&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=12
[junit4] 2> 283192 INFO (qtp1685342016-2261) [ 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> 283197 INFO (qtp2138223701-2278) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=*,score&shards.purpose=32768&tv.tf=true&sort=id+desc&shard.url=http://127.0.0.1:56014//collection1|[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/&version=2&q=id:[3+TO+6]&NOW=1485188589557&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 283198 INFO (qtp2138223701-2278) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&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:56014//collection1|[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/&rows=10&version=2&q=id:[3+TO+6]&NOW=1485188589557&isShard=true&wt=javabin} hits=4 status=0 QTime=0
[junit4] 2> 283201 INFO (qtp2138223701-2278) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&distrib=false&qt=tvrh&fl=*,score&shards.purpose=64&tv.tf=true&shard.url=http://127.0.0.1:56014//collection1|[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/&version=2&q=id:[3+TO+6]&NOW=1485188589557&ids=3,4,5,6&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 283202 INFO (qtp2138223701-2277) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:[3+TO+6]&shards=http://127.0.0.1:56014//collection1|[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/&tv=true&qt=tvrh&fl=*,score&tv.tf=true&sort=id+desc&wt=javabin&version=2} hits=4 status=0 QTime=6
[junit4] 2> 283204 INFO (qtp1685342016-2261) [ 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> 283208 INFO (qtp2138223701-2281) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=score,test_basictv,[docid],test_postv,val:sum(3,4)&shards.purpose=32768&tv.tf=true&sort=id+desc&shard.url=[ff01::213]:33332/|[ff01::114]:33332/|http://127.0.0.1:56014//collection1&version=2&q=id:[3+TO+6]&NOW=1485188589567&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 283209 INFO (qtp2138223701-2281) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=16388&tv.tf=true&start=0&fsv=true&sort=id+desc&shard.url=[ff01::213]:33332/|[ff01::114]:33332/|http://127.0.0.1:56014//collection1&rows=10&version=2&q=id:[3+TO+6]&NOW=1485188589567&isShard=true&wt=javabin} hits=4 status=0 QTime=0
[junit4] 2> 283211 INFO (qtp2138223701-2281) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&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=[ff01::213]:33332/|[ff01::114]:33332/|http://127.0.0.1:56014//collection1&version=2&q=id:[3+TO+6]&NOW=1485188589567&ids=3,4,5,6&isShard=true&wt=javabin} status=0 QTime=1
[junit4] 2> 283211 INFO (qtp2138223701-2278) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:[3+TO+6]&shards=[ff01::213]:33332/|[ff01::114]:33332/|http://127.0.0.1:56014//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} hits=4 status=0 QTime=4
[junit4] 2> 283221 INFO (qtp1685342016-2261) [ 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=8
[junit4] 2> 283227 INFO (qtp2138223701-2277) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&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:56014//collection1&version=2&q=id:[3+TO+6]&NOW=1485188589585&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 283228 INFO (qtp2138223701-2277) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&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:56014//collection1&rows=10&version=2&q=id:[3+TO+6]&NOW=1485188589585&isShard=true&wt=javabin} hits=4 status=0 QTime=0
[junit4] 2> 283234 INFO (qtp2138223701-2277) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&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:56014//collection1&version=2&q=id:[3+TO+6]&NOW=1485188589585&ids=3,4,5,6&isShard=true&wt=javabin} status=0 QTime=4
[junit4] 2> 283234 INFO (qtp2138223701-2281) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:[3+TO+6]&shards=http://127.0.0.1:56014//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} hits=4 status=0 QTime=10
[junit4] 2> 283237 INFO (qtp1685342016-2261) [ 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> 283239 INFO (qtp2138223701-2278) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&tv.positions=true&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:56014//collection1&rows=10&tv.tf_idf=true&version=2&q=id:[3+TO+6]&tv.df=true&NOW=1485188589599&isShard=true&wt=javabin} hits=4 status=0 QTime=0
[junit4] 2> 283241 INFO (qtp2138223701-2278) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&tv.positions=true&distrib=false&qt=tvrh&shards.purpose=64&tv.tf=true&tv.offsets=true&shard.url=http://127.0.0.1:56014//collection1&tv.tf_idf=true&version=2&q=id:[3+TO+6]&tv.df=true&NOW=1485188589599&ids=3,4,5,6&isShard=true&wt=javabin} status=0 QTime=1
[junit4] 2> 283242 INFO (qtp2138223701-2277) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:[3+TO+6]&shards=http://127.0.0.1:56014//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} hits=4 status=0 QTime=4
[junit4] 2> 283245 INFO (qtp1685342016-2261) [ 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=1
[junit4] 2> 283247 INFO (qtp2138223701-2280) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=id&shards.purpose=4&start=0&fsv=true&sort=id+desc&shard.url=http://127.0.0.1:56014//collection1&rows=10&version=2&q=id:[3+TO+6]&tv.all=true&NOW=1485188589607&isShard=true&wt=javabin} hits=4 status=0 QTime=0
[junit4] 2> 283248 INFO (qtp2138223701-2280) [ 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&shards.purpose=64&NOW=1485188589607&ids=3,4,5,6&isShard=true&shard.url=http://127.0.0.1:56014//collection1&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 283249 INFO (qtp2138223701-2278) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:[3+TO+6]&shards=http://127.0.0.1:56014//collection1&tv=true&tv.all=true&qt=tvrh&sort=id+desc&wt=javabin&version=2} hits=4 status=0 QTime=3
[junit4] 2> 283250 INFO (qtp1685342016-2261) [ 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&distrib.singlePass=true&rows=1&wt=javabin&version=2} hits=4 status=0 QTime=0
[junit4] 2> 283252 INFO (qtp2138223701-2282) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&distrib=false&qt=tvrh&fl=*&shards.purpose=68&start=0&fsv=true&sort=id+desc&distrib.singlePass=true&shard.url=[ff01::213]:33332/|[ff01::083]:33332/|http://127.0.0.1:56014//collection1&rows=1&version=2&q=id:[3+TO+6]&tv.all=true&NOW=1485188589612&isShard=true&wt=javabin} hits=4 status=0 QTime=0
[junit4] 2> 283253 INFO (qtp2138223701-2280) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=id:[3+TO+6]&shards=[ff01::213]:33332/|[ff01::083]:33332/|http://127.0.0.1:56014//collection1&tv=true&tv.all=true&qt=tvrh&sort=id+desc&distrib.singlePass=true&rows=1&wt=javabin&version=2} hits=4 status=0 QTime=2
[junit4] 2> 283264 INFO (qtp1685342016-2261) [ 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:[3+TO+6]&f.test_offtv.tv.offsets=false&tv.df=true&f.test_basictv.tv.tf=false&wt=javabin} hits=4 status=0 QTime=10
[junit4] 2> 283268 INFO (qtp2138223701-2279) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&fl=id&shards.purpose=4&tv.tf=true&f.test_basictv.tv.df=false&fsv=true&shard.url=[ff01::213]:33332/|http://127.0.0.1:56014//collection1&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:[3+TO+6]&f.test_offtv.tv.offsets=false&tv.df=true&NOW=1485188589627&f.test_basictv.tv.tf=false&isShard=true} hits=4 status=0 QTime=0
[junit4] 2> 283270 INFO (qtp2138223701-2279) [ 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&shards.purpose=64&tv.tf=true&f.test_basictv.tv.df=false&tv.offsets=true&tv.fl=test_basictv,test_notv,test_postv,test_offtv,test_posofftv&shard.url=[ff01::213]:33332/|http://127.0.0.1:56014//collection1&tv.tf_idf=true&version=2&q=id:[3+TO+6]&f.test_offtv.tv.offsets=false&tv.df=true&NOW=1485188589627&f.test_basictv.tv.tf=false&ids=3,4,5,6&isShard=true&wt=javabin} status=0 QTime=1
[junit4] 2> 283271 INFO (qtp2138223701-2282) [ 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:[3+TO+6]&shards=[ff01::213]:33332/|http://127.0.0.1:56014//collection1&f.test_offtv.tv.offsets=false&tv.df=true&f.test_basictv.tv.tf=false&wt=javabin} hits=4 status=0 QTime=4
[junit4] 2> 283284 INFO (qtp1685342016-2261) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=*:*&tv=true&distrib=false&qt=tvrh&tv.tf=true&sort=id+desc&wt=javabin&version=2} hits=10 status=0 QTime=12
[junit4] 2> 283291 INFO (qtp2138223701-2275) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&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:56014//collection1|[ff01::083]:33332/|[ff01::213]:33332/&rows=10&version=2&q=*:*&NOW=1485188589647&isShard=true&wt=javabin} hits=10 status=0 QTime=0
[junit4] 2> 283294 INFO (qtp2138223701-2275) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=*:*&tv=true&distrib=false&qt=tvrh&shards.purpose=64&tv.tf=true&NOW=1485188589647&ids=0,1,2,3,4,5,6,7,8,9&isShard=true&shard.url=http://127.0.0.1:56014//collection1|[ff01::083]:33332/|[ff01::213]:33332/&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 283295 INFO (qtp2138223701-2279) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=*:*&shards=http://127.0.0.1:56014//collection1|[ff01::083]:33332/|[ff01::213]:33332/&tv=true&qt=tvrh&tv.tf=true&sort=id+desc&wt=javabin&version=2} hits=10 status=0 QTime=9
[junit4] 2> 283299 INFO (qtp1685342016-2265) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=*:*&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=10 status=0 QTime=2
[junit4] 2> 283301 INFO (qtp2138223701-2281) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=*,score&shards.purpose=32768&tv.tf=true&sort=id+asc&tv.fl=test_basictv,test_offtv&shard.url=http://127.0.0.1:56014//collection1|[ff01::213]:33332/|[ff01::083]:33332/&version=2&q=*:*&NOW=1485188589661&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 283303 INFO (qtp2138223701-2281) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&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,test_offtv&shard.url=http://127.0.0.1:56014//collection1|[ff01::213]:33332/|[ff01::083]:33332/&rows=10&version=2&q=*:*&NOW=1485188589661&isShard=true&wt=javabin} hits=10 status=0 QTime=0
[junit4] 2> 283305 INFO (qtp2138223701-2281) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&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:56014//collection1|[ff01::213]:33332/|[ff01::083]:33332/&version=2&q=*:*&NOW=1485188589661&ids=0,1,2,3,4,5,6,7,8,9&isShard=true&wt=javabin} status=0 QTime=1
[junit4] 2> 283305 INFO (qtp2138223701-2275) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=*:*&shards=http://127.0.0.1:56014//collection1|[ff01::213]:33332/|[ff01::083]:33332/&tv=true&qt=tvrh&fl=*,score&tv.tf=true&sort=id+asc&tv.fl=test_basictv,test_offtv&wt=javabin&version=2} hits=10 status=0 QTime=5
[junit4] 2> 283307 INFO (qtp1685342016-2265) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=*:*&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=10 status=0 QTime=0
[junit4] 2> 283310 INFO (qtp2138223701-2279) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=*,score&shards.purpose=32768&tv.tf=true&sort=id+asc&tv.fl=test_basictv&tv.fl=test_offtv&shard.url=[ff01::114]:33332/|[ff01::083]:33332/|http://127.0.0.1:56014//collection1|[ff01::213]:33332/&version=2&q=*:*&NOW=1485188589670&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 283311 INFO (qtp2138223701-2279) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&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=[ff01::114]:33332/|[ff01::083]:33332/|http://127.0.0.1:56014//collection1|[ff01::213]:33332/&rows=10&version=2&q=*:*&NOW=1485188589670&isShard=true&wt=javabin} hits=10 status=0 QTime=0
[junit4] 2> 283313 INFO (qtp2138223701-2279) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&distrib=false&qt=tvrh&fl=*,score&shards.purpose=64&tv.tf=true&tv.fl=test_basictv&tv.fl=test_offtv&shard.url=[ff01::114]:33332/|[ff01::083]:33332/|http://127.0.0.1:56014//collection1|[ff01::213]:33332/&version=2&q=*:*&NOW=1485188589670&ids=0,1,2,3,4,5,6,7,8,9&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 283313 INFO (qtp2138223701-2281) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=*:*&shards=[ff01::114]:33332/|[ff01::083]:33332/|http://127.0.0.1:56014//collection1|[ff01::213]:33332/&tv=true&qt=tvrh&fl=*,score&tv.tf=true&sort=id+asc&tv.fl=test_basictv&tv.fl=test_offtv&wt=javabin&version=2} hits=10 status=0 QTime=4
[junit4] 2> 283317 INFO (qtp1685342016-2265) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=*:*&tv=true&distrib=false&qt=tvrh&fl=*,score&tv.tf=true&sort=id+desc&wt=javabin&version=2} hits=10 status=0 QTime=1
[junit4] 2> 283320 INFO (qtp2138223701-2275) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=*,score&shards.purpose=32768&tv.tf=true&sort=id+desc&shard.url=[ff01::114]:33332/|http://127.0.0.1:56014//collection1&version=2&q=*:*&NOW=1485188589680&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 283321 INFO (qtp2138223701-2275) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=16388&tv.tf=true&start=0&fsv=true&sort=id+desc&shard.url=[ff01::114]:33332/|http://127.0.0.1:56014//collection1&rows=10&version=2&q=*:*&NOW=1485188589680&isShard=true&wt=javabin} hits=10 status=0 QTime=0
[junit4] 2> 283323 INFO (qtp2138223701-2275) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=true&distrib=false&qt=tvrh&fl=*,score&shards.purpose=64&tv.tf=true&shard.url=[ff01::114]:33332/|http://127.0.0.1:56014//collection1&version=2&q=*:*&NOW=1485188589680&ids=0,1,2,3,4,5,6,7,8,9&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 283324 INFO (qtp2138223701-2279) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=*:*&shards=[ff01::114]:33332/|http://127.0.0.1:56014//collection1&tv=true&qt=tvrh&fl=*,score&tv.tf=true&sort=id+desc&wt=javabin&version=2} hits=10 status=0 QTime=5
[junit4] 2> 283327 INFO (qtp1685342016-2265) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=*:*&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=10 status=0 QTime=0
[junit4] 2> 283330 INFO (qtp2138223701-2281) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={tv=false&distrib=false&qt=tvrh&fl=score,test_basictv,[docid],test_postv,val:sum(3,4)&shards.purpose=32768&tv.tf=true&sort=id+desc&shard.url=[ff01::213]:33332/|http://127.0.0.1:56014//collection1|[ff01::114]:33332/|[ff01::083]:33332/&version=2&q=*:*&
[...truncated too long message...]
e&tv.offsets=true&tv.fl=test_basictv,test_notv,test_postv,test_offtv,test_posofftv&shard.url=http://127.0.0.1:56052//collection1|[ff01::083]:33332/|[ff01::114]:33332/&tv.tf_idf=true&version=2&q=*:*&f.test_offtv.tv.offsets=false&tv.df=true&NOW=1485188599426&f.test_basictv.tv.tf=false&ids=1,4,7&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 293071 INFO (qtp2087859530-2427) [ 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&shards.purpose=64&tv.tf=true&f.test_basictv.tv.df=false&tv.offsets=true&tv.fl=test_basictv,test_notv,test_postv,test_offtv,test_posofftv&shard.url=http://127.0.0.1:56059//collection1|[ff01::083]:33332/|[ff01::213]:33332/&tv.tf_idf=true&version=2&q=*:*&f.test_offtv.tv.offsets=false&tv.df=true&NOW=1485188599426&f.test_basictv.tv.tf=false&ids=0,3,6,9&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 293072 INFO (qtp209758858-2407) [ 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&shards.purpose=64&tv.tf=true&f.test_basictv.tv.df=false&tv.offsets=true&tv.fl=test_basictv,test_notv,test_postv,test_offtv,test_posofftv&shard.url=http://127.0.0.1:56056//collection1&tv.tf_idf=true&version=2&q=*:*&f.test_offtv.tv.offsets=false&tv.df=true&NOW=1485188599426&f.test_basictv.tv.tf=false&ids=2,5,8&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 293072 INFO (qtp209758858-2410) [ 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=*:*&shards=http://127.0.0.1:56052//collection1|[ff01::083]:33332/|[ff01::114]:33332/,http://127.0.0.1:56056//collection1,http://127.0.0.1:56059//collection1|[ff01::083]:33332/|[ff01::213]:33332/&f.test_offtv.tv.offsets=false&tv.df=true&f.test_basictv.tv.tf=false&wt=javabin} hits=10 status=0 QTime=7
[junit4] 2> 293073 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.SolrTestCaseJ4 ###Ending test
[junit4] 2> 293075 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@2aa41311{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 293075 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=349153038
[junit4] 2> 293075 INFO (coreCloseExecutor-1289-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@425c8906
[junit4] 2> 293354 INFO (coreCloseExecutor-1289-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
[junit4] 2> 293355 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 293356 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@a979558{/,null,UNAVAILABLE}
[junit4] 2> 293358 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@24eac2c0{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 293358 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1830135776
[junit4] 2> 293359 INFO (coreCloseExecutor-1291-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@266d5ad2
[junit4] 2> 293460 INFO (coreCloseExecutor-1291-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
[junit4] 2> 293468 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 293469 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@4bfdf48f{/,null,UNAVAILABLE}
[junit4] 2> 293470 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@35ad1610{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 293470 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=75247924
[junit4] 2> 293471 INFO (coreCloseExecutor-1293-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@48a8c737
[junit4] 2> 293528 INFO (coreCloseExecutor-1293-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
[junit4] 2> 293530 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 293530 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@e4a7dac{/,null,UNAVAILABLE}
[junit4] 2> 293533 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@2e5d2601{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 293533 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1628252742
[junit4] 2> 293533 INFO (coreCloseExecutor-1295-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@369fe954
[junit4] 2> 293585 INFO (coreCloseExecutor-1295-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
[junit4] 2> 293586 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 293587 INFO (TEST-TermVectorComponentDistributedTest.test-seed#[8E911FC879BC9232]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@3c7aca08{/,null,UNAVAILABLE}
[junit4] 2> 293590 INFO (SUITE-TermVectorComponentDistributedTest-seed#[8E911FC879BC9232]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: test params are: codec=CheapBastard, sim=RandomSimilarity(queryNorm=false,coord=crazy): {}, locale=uk, timezone=Etc/GMT
[junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 1.8.0_121 (64-bit)/cpus=3,threads=1,free=160334472,total=362283008
[junit4] 2> NOTE: All tests run in this JVM: [TestOmitPositions, TestExclusionRuleCollectionAccess, TestConfigSets, SpatialHeatmapFacetsTest, TestConfigSetsAPIExclusivity, SuggesterTSTTest, TestNumericTerms64, HighlighterConfigTest, TestCloudPivotFacet, SpellingQueryConverterTest, TestComplexPhraseQParserPlugin, TestSolrCLIRunExample, TestValueSourceCache, TestLMDirichletSimilarityFactory, TestInitParams, TestConfigSetImmutable, SolrCmdDistributorTest, SuggesterWFSTTest, ZkSolrClientTest, CurrencyFieldOpenExchangeTest, DebugComponentTest, ChaosMonkeySafeLeaderTest, TestFieldCacheSort, RAMDirectoryFactoryTest, LeaderElectionIntegrationTest, TestReloadAndDeleteDocs, TestFieldResource, TermVectorComponentDistributedTest]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TermVectorComponentDistributedTest -Dtests.seed=8E911FC879BC9232 -Dtests.slow=true -Dtests.locale=uk -Dtests.timezone=Etc/GMT -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] ERROR 0.00s J1 | TermVectorComponentDistributedTest (suite) <<<
[junit4] > Throwable #1: java.io.IOException: Could not remove the following files (in the order of attempts):
[junit4] > C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_8E911FC879BC9232-001\tempDir-001\shard2\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_8E911FC879BC9232-001\tempDir-001\shard2\collection1
[junit4] > C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_8E911FC879BC9232-001\tempDir-001\shard2: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_8E911FC879BC9232-001\tempDir-001\shard2
[junit4] > C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_8E911FC879BC9232-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_8E911FC879BC9232-001\tempDir-001
[junit4] > at __randomizedtesting.SeedInfo.seed([8E911FC879BC9232]:0)
[junit4] > at org.apache.lucene.util.IOUtils.rm(IOUtils.java:323)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] Completed [87/681 (1!)] on J1 in 13.89s, 1 test, 1 error <<< FAILURES!
[...truncated 64448 lines...]