[JENKINS] Lucene-Solr-master-Windows (32bit/jdk1.8.0_102) - Build # 6179 - Unstable!

[Policeman Jenkins Server]

Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/6179/
Java: 32bit/jdk1.8.0_102 -client -XX:+UseParallelGC

2 tests failed.
FAILED:  org.apache.solr.handler.TestReplicationHandler.doTestStressReplication

Error Message:
[index.20161014090249766, index.20161014090250196, index.properties, 
replication.properties, snapshot_metadata] expected:<1> but was:<2>

Stack Trace:
java.lang.AssertionError: [index.20161014090249766, index.20161014090250196, 
index.properties, replication.properties, snapshot_metadata] expected:<1> but 
was:<2>
        at 
__randomizedtesting.SeedInfo.seed([81DDD69A06F55536:5A76D65C03DD3C85]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.failNotEquals(Assert.java:647)
        at org.junit.Assert.assertEquals(Assert.java:128)
        at org.junit.Assert.assertEquals(Assert.java:472)
        at 
org.apache.solr.handler.TestReplicationHandler.checkForSingleIndex(TestReplicationHandler.java:907)
        at 
org.apache.solr.handler.TestReplicationHandler.doTestStressReplication(TestReplicationHandler.java:874)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(Thread.java:745)


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-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_81DDD69A06F55536-001\tempDir-001\shard2\collection1\conf:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_81DDD69A06F55536-001\tempDir-001\shard2\collection1\conf
    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_81DDD69A06F55536-001\tempDir-001\shard2\collection1:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_81DDD69A06F55536-001\tempDir-001\shard2\collection1
    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_81DDD69A06F55536-001\tempDir-001\shard2:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_81DDD69A06F55536-001\tempDir-001\shard2
    
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_81DDD69A06F55536-001\tempDir-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_81DDD69A06F55536-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-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_81DDD69A06F55536-001\tempDir-001\shard2\collection1\conf:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_81DDD69A06F55536-001\tempDir-001\shard2\collection1\conf
   
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_81DDD69A06F55536-001\tempDir-001\shard2\collection1:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_81DDD69A06F55536-001\tempDir-001\shard2\collection1
   
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_81DDD69A06F55536-001\tempDir-001\shard2:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_81DDD69A06F55536-001\tempDir-001\shard2
   
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_81DDD69A06F55536-001\tempDir-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_81DDD69A06F55536-001\tempDir-001

        at __randomizedtesting.SeedInfo.seed([81DDD69A06F55536]: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:367)
        at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 11266 lines...]
   [junit4] Suite: 
org.apache.solr.handler.component.TermVectorComponentDistributedTest
   [junit4]   2> Creating dataDir: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_81DDD69A06F55536-001\init-core-data-001
   [junit4]   2> 922329 INFO  
(SUITE-TermVectorComponentDistributedTest-seed#[81DDD69A06F55536]-worker) [    
] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
   [junit4]   2> 922329 INFO  
(SUITE-TermVectorComponentDistributedTest-seed#[81DDD69A06F55536]-worker) [    
] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
   [junit4]   2> 922878 INFO  
(TEST-TermVectorComponentDistributedTest.test-seed#[81DDD69A06F55536]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_81DDD69A06F55536-001\tempDir-001\control\cores\collection1
   [junit4]   2> 922886 INFO  
(TEST-TermVectorComponentDistributedTest.test-seed#[81DDD69A06F55536]) [    ] 
o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 922887 INFO  
(TEST-TermVectorComponentDistributedTest.test-seed#[81DDD69A06F55536]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@2afcb5{/,null,AVAILABLE}
   [junit4]   2> 922895 INFO  
(TEST-TermVectorComponentDistributedTest.test-seed#[81DDD69A06F55536]) [    ] 
o.e.j.s.ServerConnector Started ServerConnector@fc56fc{SSL,[ssl, 
http/1.1]}{127.0.0.1:51174}
   [junit4]   2> 922895 INFO  
(TEST-TermVectorComponentDistributedTest.test-seed#[81DDD69A06F55536]) [    ] 
o.e.j.s.Server Started @926708ms
   [junit4]   2> 922895 INFO  
(TEST-TermVectorComponentDistributedTest.test-seed#[81DDD69A06F55536]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=51174, 
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_81DDD69A06F55536-001\tempDir-001\control\cores}
   [junit4]   2> 922896 INFO  
(TEST-TermVectorComponentDistributedTest.test-seed#[81DDD69A06F55536]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 922896 INFO  
(TEST-TermVectorComponentDistributedTest.test-seed#[81DDD69A06F55536]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 922896 INFO  
(TEST-TermVectorComponentDistributedTest.test-seed#[81DDD69A06F55536]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 922896 INFO  
(TEST-TermVectorComponentDistributedTest.test-seed#[81DDD69A06F55536]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2016-10-13T21:49:31.772Z
   [junit4]   2> 922897 INFO  
(TEST-TermVectorComponentDistributedTest.test-seed#[81DDD69A06F55536]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_81DDD69A06F55536-001\tempDir-001\control\solr.xml
   [junit4]   2> 922923 INFO  
(TEST-TermVectorComponentDistributedTest.test-seed#[81DDD69A06F55536]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_81DDD69A06F55536-001\tempDir-001\control\cores
   [junit4]   2> 922923 INFO  
(TEST-TermVectorComponentDistributedTest.test-seed#[81DDD69A06F55536]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 922924 INFO  (coreLoadExecutor-3944-thread-1) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/C:/Users/jenkins/workspace/Lucene-Solr-master-Windows/solr/core/src/test-files/solr/collection1/lib,
 
/C:/Users/jenkins/workspace/Lucene-Solr-master-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 922999 INFO  (coreLoadExecutor-3944-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 923043 INFO  (coreLoadExecutor-3944-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 923146 WARN  (coreLoadExecutor-3944-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] default search field in schema is text. 
WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 923150 INFO  (coreLoadExecutor-3944-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 923170 INFO  (coreLoadExecutor-3944-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
configset 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1
   [junit4]   2> 923171 INFO  (coreLoadExecutor-3944-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_81DDD69A06F55536-001\tempDir-001\control\cores\collection1\data\]
   [junit4]   2> 923171 INFO  (coreLoadExecutor-3944-thread-1) [    
x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr 
mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@447168
   [junit4]   2> 923173 INFO  (coreLoadExecutor-3944-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=48, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 923204 INFO  (coreLoadExecutor-3944-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 923204 INFO  (coreLoadExecutor-3944-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 923206 INFO  (coreLoadExecutor-3944-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 923206 INFO  (coreLoadExecutor-3944-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 923206 INFO  (coreLoadExecutor-3944-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=26, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=65.1826171875, 
floorSegmentMB=0.45703125, forceMergeDeletesPctAllowed=16.50482641794205, 
segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 923207 INFO  (coreLoadExecutor-3944-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@12b7234[collection1] 
main]
   [junit4]   2> 923207 INFO  (coreLoadExecutor-3944-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 923218 INFO  (coreLoadExecutor-3944-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 923264 INFO  (coreLoadExecutor-3944-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 923264 INFO  
(searcherExecutor-3945-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 923265 INFO  
(searcherExecutor-3945-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 923265 INFO  
(searcherExecutor-3945-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 923265 INFO  
(searcherExecutor-3945-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 923265 INFO  
(searcherExecutor-3945-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 923266 INFO  
(searcherExecutor-3945-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 923266 INFO  
(searcherExecutor-3945-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 923266 INFO  (coreLoadExecutor-3944-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1548112753739169792
   [junit4]   2> 923267 INFO  
(searcherExecutor-3945-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 923268 INFO  
(searcherExecutor-3945-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 923269 INFO  
(searcherExecutor-3945-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@12b7234[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 924007 INFO  
(TEST-TermVectorComponentDistributedTest.test-seed#[81DDD69A06F55536]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_81DDD69A06F55536-001\tempDir-001\shard0\cores\collection1
   [junit4]   2> 924013 INFO  
(TEST-TermVectorComponentDistributedTest.test-seed#[81DDD69A06F55536]) [    ] 
o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 924014 INFO  
(TEST-TermVectorComponentDistributedTest.test-seed#[81DDD69A06F55536]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@10461fa{/,null,AVAILABLE}
   [junit4]   2> 924019 INFO  
(TEST-TermVectorComponentDistributedTest.test-seed#[81DDD69A06F55536]) [    ] 
o.e.j.s.ServerConnector Started ServerConnector@1a53967{SSL,[ssl, 
http/1.1]}{127.0.0.1:51178}
   [junit4]   2> 924019 INFO  
(TEST-TermVectorComponentDistributedTest.test-seed#[81DDD69A06F55536]) [    ] 
o.e.j.s.Server Started @927832ms
   [junit4]   2> 924019 INFO  
(TEST-TermVectorComponentDistributedTest.test-seed#[81DDD69A06F55536]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=51178, 
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_81DDD69A06F55536-001\tempDir-001\shard0\cores}
   [junit4]   2> 924020 INFO  
(TEST-TermVectorComponentDistributedTest.test-seed#[81DDD69A06F55536]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 924020 INFO  
(TEST-TermVectorComponentDistributedTest.test-seed#[81DDD69A06F55536]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 924020 INFO  
(TEST-TermVectorComponentDistributedTest.test-seed#[81DDD69A06F55536]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 924020 INFO  
(TEST-TermVectorComponentDistributedTest.test-seed#[81DDD69A06F55536]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2016-10-13T21:49:32.896Z
   [junit4]   2> 924021 INFO  
(TEST-TermVectorComponentDistributedTest.test-seed#[81DDD69A06F55536]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_81DDD69A06F55536-001\tempDir-001\shard0\solr.xml
   [junit4]   2> 924056 INFO  
(TEST-TermVectorComponentDistributedTest.test-seed#[81DDD69A06F55536]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_81DDD69A06F55536-001\tempDir-001\shard0\cores
   [junit4]   2> 924056 INFO  
(TEST-TermVectorComponentDistributedTest.test-seed#[81DDD69A06F55536]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 924061 INFO  (coreLoadExecutor-3955-thread-1) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/C:/Users/jenkins/workspace/Lucene-Solr-master-Windows/solr/core/src/test-files/solr/collection1/lib,
 
/C:/Users/jenkins/workspace/Lucene-Solr-master-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 924150 INFO  (coreLoadExecutor-3955-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 924188 INFO  (coreLoadExecutor-3955-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 924310 WARN  (coreLoadExecutor-3955-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] default search field in schema is text. 
WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 924312 INFO  (coreLoadExecutor-3955-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 924336 INFO  (coreLoadExecutor-3955-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
configset 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1
   [junit4]   2> 924336 INFO  (coreLoadExecutor-3955-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.TermVectorComponentDistributedTest_81DDD69A06F55536-001\tempDir-001\shard0\cores\collection1\data\]
   [junit4]   2> 924336 INFO  (coreLoadExecutor-3955-thread-1) [    
x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr 
mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@447168
   [junit4]   2> 924337 INFO  (coreLoadExecutor-3955-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=48, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 924375 INFO  (coreLoadExecutor-3955-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 924375 INFO  (coreLoadExecutor-3955-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 924377 INFO  (coreLoadExecutor-3955-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 924377 INFO  (coreLoadExecutor-3955-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 924378 INFO  (coreLoadExecutor-3955-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=26, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=65.1826171875, 
floorSegmentMB=0.45703125, forceMergeDeletesPctAllowed=16.50482641794205, 
segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 924378 INFO  (coreLoadExecutor-3955-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1f91c2c[collection1] 
main]
   [junit4]   2> 924379 INFO  (coreLoadExecutor-3955-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 924388 INFO  (coreLoadExecutor-3955-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 924432 INFO  (coreLoadExecutor-3955-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 924433 INFO  
(searcherExecutor-3956-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 924433 INFO  
(searcherExecutor-3956-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 924433 INFO  
(searcherExecutor-3956-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 924433 INFO  
(searcherExecutor-3956-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 924434 INFO  
(searcherExecutor-3956-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 924434 INFO  
(searcherExecutor-3956-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 924435 INFO  
(searcherExecutor-3956-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 924435 INFO  (coreLoadExecutor-3955-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1548112754964955136
   [junit4]   2> 924436 INFO  
(searcherExecutor-3956-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 924436 INFO  
(searcherExecutor-3956-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 924438 INFO  
(searcherExecutor-3956-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1f91c2c[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 924562 INFO  
(TEST-TermVectorComponentDistributedTest.test-seed#[81DDD69A06F55536]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 924627 INFO  (qtp4652003-9130) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[0 (1548112755162087424)]} 0 5
   [junit4]   2> 924688 INFO  (qtp22652876-9146) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[0 (1548112755225001984)]} 0 4
   [junit4]   2> 924692 INFO  (qtp4652003-9128) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[1 (1548112755232342016)]} 0 2
   [junit4]   2> 924696 INFO  (qtp22652876-9147) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[1 (1548112755235487744)]} 0 2
   [junit4]   2> 924698 INFO  (qtp4652003-9131) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[2 (1548112755239682048)]} 0 1
   [junit4]   2> 924701 INFO  (qtp22652876-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[2 (1548112755242827776)]} 0 1
   [junit4]   2> 924703 INFO  (qtp4652003-9132) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[3 (1548112755244924928)]} 0 1
   [junit4]   2> 924706 INFO  (qtp22652876-9149) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[3 (1548112755248070656)]} 0 1
   [junit4]   2> 924709 INFO  (qtp4652003-9125) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[4 (1548112755251216384)]} 0 1
   [junit4]   2> 924710 INFO  (qtp22652876-9142) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[4 (1548112755253313536)]} 0 0
   [junit4]   2> 924712 INFO  (qtp4652003-9127) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[5 (1548112755255410688)]} 0 1
   [junit4]   2> 924715 INFO  (qtp22652876-9144) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[5 (1548112755256459264)]} 0 1
   [junit4]   2> 924717 INFO  (qtp4652003-9129) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[6 (1548112755260653568)]} 0 1
   [junit4]   2> 924720 INFO  (qtp22652876-9145) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[6 (1548112755262750720)]} 0 1
   [junit4]   2> 924722 INFO  (qtp4652003-9130) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[7 (1548112755264847872)]} 0 0
   [junit4]   2> 924724 INFO  (qtp22652876-9146) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[7 (1548112755266945024)]} 0 0
   [junit4]   2> 924726 INFO  (qtp4652003-9128) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[8 (1548112755269042176)]} 0 0
   [junit4]   2> 924728 INFO  (qtp22652876-9147) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[8 (1548112755271139328)]} 0 0
   [junit4]   2> 924730 INFO  (qtp4652003-9131) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[9 (1548112755273236480)]} 0 0
   [junit4]   2> 924732 INFO  (qtp22652876-9148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[9 (1548112755275333632)]} 0 1
   [junit4]   2> 924733 INFO  (qtp4652003-9132) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 924733 INFO  (qtp4652003-9132) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@776884
   [junit4]   2> 924745 INFO  (qtp4652003-9132) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@5849cb[collection1] main]
   [junit4]   2> 924746 INFO  (qtp4652003-9132) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 924747 INFO  
(searcherExecutor-3945-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@5849cb[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C10)))}
   [junit4]   2> 924749 INFO  (qtp4652003-9132) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 15
   [junit4]   2> 924750 INFO  (qtp22652876-9149) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 924750 INFO  (qtp22652876-9149) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@d76b7f
   [junit4]   2> 924760 INFO  (qtp22652876-9149) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@19440fc[collection1] main]
   [junit4]   2> 924761 INFO  (qtp22652876-9149) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 924763 INFO  
(searcherExecutor-3956-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@19440fc[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C10)))}
   [junit4]   2> 924764 INFO  (qtp22652876-9149) [    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 13
   [junit4]   2> 924767 INFO  (qtp4652003-9125) [    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=1
   [junit4]   2> 924776 INFO  (qtp22652876-9146) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&distrib=false&qt=tvrh&fl=id&shards.purpose=4&tv.tf=true&start=0&fsv=true&sort=id+desc&shard.url=[ff01::114]:33332/|https://127.0.0.1:51178//collection1&rows=10&version=2&q=id:0&NOW=1476395373644&isShard=true&wt=javabin}
 hits=1 status=0 QTime=0
   [junit4]   2> 924779 INFO  (qtp22652876-9147) [    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=1476395373644&ids=0&isShard=true&shard.url=[ff01::114]:33332/|https://127.0.0.1:51178//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 924780 INFO  (qtp22652876-9142) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=id:0&shards=[ff01::114]:33332/|https://127.0.0.1:51178//collection1&tv=true&qt=tvrh&tv.tf=true&sort=id+desc&wt=javabin&version=2}
 hits=1 status=0 QTime=11
   [junit4]   2> 924783 INFO  (qtp4652003-9127) [    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=1
   [junit4]   2> 924786 INFO  (qtp22652876-9149) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=4&tv.tf=true&start=0&fsv=true&sort=id+asc&tv.fl=test_basictv,test_offtv&shard.url=[ff01::083]:33332/|https://127.0.0.1:51178//collection1|[ff01::213]:33332/&rows=10&version=2&q=id:0&NOW=1476395373660&isShard=true&wt=javabin}
 hits=1 status=0 QTime=1
   [junit4]   2> 924790 INFO  (qtp22652876-9144) [    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/|https://127.0.0.1:51178//collection1|[ff01::213]:33332/&version=2&q=id:0&NOW=1476395373660&ids=0&isShard=true&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 924791 INFO  (qtp22652876-9148) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=id:0&shards=[ff01::083]:33332/|https://127.0.0.1:51178//collection1|[ff01::213]:33332/&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=5
   [junit4]   2> 924793 INFO  (qtp4652003-9129) [    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> 924799 INFO  (qtp22652876-9146) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=4&tv.tf=true&start=0&fsv=true&sort=id+asc&tv.fl=test_basictv&tv.fl=test_offtv&shard.url=[ff01::083]:33332/|https://127.0.0.1:51178//collection1&rows=10&version=2&q=id:0&NOW=1476395373670&isShard=true&wt=javabin}
 hits=1 status=0 QTime=1
   [junit4]   2> 924801 INFO  (qtp22652876-9147) [    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::083]:33332/|https://127.0.0.1:51178//collection1&version=2&q=id:0&NOW=1476395373670&ids=0&isShard=true&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 924802 INFO  (qtp22652876-9145) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=id:0&shards=[ff01::083]:33332/|https://127.0.0.1:51178//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=6
   [junit4]   2> 924804 INFO  (qtp4652003-9130) [    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> 924806 INFO  (qtp22652876-9149) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=4&tv.tf=true&start=0&fsv=true&sort=id+desc&shard.url=https://127.0.0.1:51178//collection1&rows=10&version=2&q=id:0&NOW=1476395373681&isShard=true&wt=javabin}
 hits=1 status=0 QTime=0
   [junit4]   2> 924808 INFO  (qtp22652876-9144) [    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=https://127.0.0.1:51178//collection1&version=2&q=id:0&NOW=1476395373681&ids=0&isShard=true&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 924808 INFO  (qtp22652876-9142) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=id:0&shards=https://127.0.0.1:51178//collection1&tv=true&qt=tvrh&fl=*,score&tv.tf=true&sort=id+desc&wt=javabin&version=2}
 hits=1 status=0 QTime=4
   [junit4]   2> 924811 INFO  (qtp4652003-9128) [    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> 924815 INFO  (qtp22652876-9146) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=4&tv.tf=true&start=0&fsv=true&sort=id+desc&shard.url=[ff01::114]:33332/|https://127.0.0.1:51178//collection1|[ff01::213]:33332/|[ff01::083]:33332/&rows=10&version=2&q=id:0&NOW=1476395373689&isShard=true&wt=javabin}
 hits=1 status=0 QTime=0
   [junit4]   2> 924818 INFO  (qtp22652876-9147) [    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::114]:33332/|https://127.0.0.1:51178//collection1|[ff01::213]:33332/|[ff01::083]:33332/&version=2&q=id:0&NOW=1476395373689&ids=0&isShard=true&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 924819 INFO  (qtp22652876-9148) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=id:0&shards=[ff01::114]:33332/|https://127.0.0.1:51178//collection1|[ff01::213]:33332/|[ff01::083]:33332/&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=5
   [junit4]   2> 924820 INFO  (qtp4652003-9131) [    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> 924823 INFO  (qtp22652876-9149) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=4&tv.tf=true&start=0&fsv=true&sort=id+desc&shard.url=https://127.0.0.1:51178//collection1|[ff01::114]:33332/|[ff01::213]:33332/&rows=10&version=2&q=id:0&NOW=1476395373698&isShard=true&wt=javabin}
 hits=1 status=0 QTime=0
   [junit4]   2> 924825 INFO  (qtp22652876-9144) [    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=https://127.0.0.1:51178//collection1|[ff01::114]:33332/|[ff01::213]:33332/&version=2&q=id:0&NOW=1476395373698&ids=0&isShard=true&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 924826 INFO  (qtp22652876-9145) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=id:0&shards=https://127.0.0.1:51178//collection1|[ff01::114]:33332/|[ff01::213]:33332/&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=3
   [junit4]   2> 924828 INFO  (qtp4652003-9132) [    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=1
   [junit4]   2> 924830 INFO  (qtp22652876-9146) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&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=https://127.0.0.1:51178//collection1&rows=10&tv.tf_idf=true&version=2&q=id:0&tv.df=true&NOW=1476395373705&isShard=true&wt=javabin}
 hits=1 status=0 QTime=0
   [junit4]   2> 924832 INFO  (qtp22652876-9147) [    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=https://127.0.0.1:51178//collection1&tv.tf_idf=true&version=2&q=id:0&tv.df=true&NOW=1476395373705&ids=0&isShard=true&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 924833 INFO  (qtp22652876-9142) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=id:0&shards=https://127.0.0.1:51178//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=1 status=0 QTime=4
   [junit4]   2> 924836 INFO  (qtp4652003-9125) [    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=1
   [junit4]   2> 924839 INFO  (qtp22652876-9149) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&distrib=false&qt=tvrh&fl=id&shards.purpose=4&start=0&fsv=true&sort=id+desc&shard.url=https://127.0.0.1:51178//collection1&rows=10&version=2&q=id:0&tv.all=true&NOW=1476395373712&isShard=true&wt=javabin}
 hits=1 status=0 QTime=0
   [junit4]   2> 924841 INFO  (qtp22652876-9144) [    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=1476395373712&ids=0&isShard=true&shard.url=https://127.0.0.1:51178//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 924842 INFO  (qtp22652876-9148) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=id:0&shards=https://127.0.0.1:51178//collection1&tv=true&tv.all=true&qt=tvrh&sort=id+desc&wt=javabin&version=2}
 hits=1 status=0 QTime=4
   [junit4]   2> 924844 INFO  (qtp4652003-9127) [    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> 924847 INFO  (qtp22652876-9146) [    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::114]:33332/|https://127.0.0.1:51178//collection1|[ff01::213]:33332/&rows=1&version=2&q=id:0&tv.all=true&NOW=1476395373720&isShard=true&wt=javabin}
 hits=1 status=0 QTime=0
   [junit4]   2> 924847 INFO  (qtp22652876-9145) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=id:0&shards=[ff01::083]:33332/|[ff01::114]:33332/|https://127.0.0.1:51178//collection1|[ff01::213]: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=2
   [junit4]   2> 924850 INFO  (qtp4652003-9129) [    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> 924853 INFO  (qtp22652876-9142) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&distrib=false&fl=id&shards.purpose=4&tv.tf=true&f.test_basictv.tv.df=false&fsv=true&shard.url=[ff01::083]:33332/|[ff01::114]:33332/|[ff01::213]:33332/|https://127.0.0.1:51178//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=1476395373727&f.test_basictv.tv.tf=false&isShard=true}
 hits=1 status=0 QTime=1
   [junit4]   2> 924856 INFO  (qtp22652876-9149) [    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::083]:33332/|[ff01::114]:33332/|[ff01::213]:33332/|https://127.0.0.1:51178//collection1&tv.tf_idf=true&version=2&q=id:0&f.test_offtv.tv.offsets=false&tv.df=true&NOW=1476395373727&f.test_basictv.tv.tf=false&ids=0&isShard=true&wt=javabin}
 status=0 QTime=1
   [junit4]   2> 924857 INFO  (qtp22652876-9147) [    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::083]:33332/|[ff01::114]:33332/|[ff01::213]:33332/|https://127.0.0.1:51178//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> 924858 INFO  (qtp4652003-9130) [    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> 924862 INFO  (qtp22652876-9148) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&distrib=false&qt=tvrh&fl=id&shards.purpose=4&tv.tf=true&start=0&fsv=true&sort=id+desc&shard.url=[ff01::213]:33332/|[ff01::083]:33332/|[ff01::114]:33332/|https://127.0.0.1:51178//collection1&rows=10&version=2&q=id:7&NOW=1476395373735&isShard=true&wt=javabin}
 hits=1 status=0 QTime=0
   [junit4]   2> 924864 INFO  (qtp22652876-9146) [    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=1476395373735&ids=7&isShard=true&shard.url=[ff01::213]:33332/|[ff01::083]:33332/|[ff01::114]:33332/|https://127.0.0.1:51178//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 924864 INFO  (qtp22652876-9144) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=id:7&shards=[ff01::213]:33332/|[ff01::083]:33332/|[ff01::114]:33332/|https://127.0.0.1:51178//collection1&tv=true&qt=tvrh&tv.tf=true&sort=id+desc&wt=javabin&version=2}
 hits=1 status=0 QTime=4
   [junit4]   2> 924867 INFO  (qtp4652003-9128) [    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> 924870 INFO  (qtp22652876-9142) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=4&tv.tf=true&start=0&fsv=true&sort=id+asc&tv.fl=test_basictv,test_offtv&shard.url=https://127.0.0.1:51178//collection1&rows=10&version=2&q=id:7&NOW=1476395373744&isShard=true&wt=javabin}
 hits=1 status=0 QTime=0
   [junit4]   2> 924873 INFO  (qtp22652876-9149) [    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=https://127.0.0.1:51178//collection1&version=2&q=id:7&NOW=1476395373744&ids=7&isShard=true&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 924873 INFO  (qtp22652876-9145) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=id:7&shards=https://127.0.0.1:51178//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=4
   [junit4]   2> 924875 INFO  (qtp4652003-9131) [    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> 924878 INFO  (qtp22652876-9148) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=4&tv.tf=true&start=0&fsv=true&sort=id+asc&tv.fl=test_basictv&tv.fl=test_offtv&shard.url=https://127.0.0.1:51178//collection1&rows=10&version=2&q=id:7&NOW=1476395373752&isShard=true&wt=javabin}
 hits=1 status=0 QTime=0
   [junit4]   2> 924879 INFO  (qtp22652876-9146) [    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=https://127.0.0.1:51178//collection1&version=2&q=id:7&NOW=1476395373752&ids=7&isShard=true&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 924880 INFO  (qtp22652876-9147) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=id:7&shards=https://127.0.0.1:51178//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=3
   [junit4]   2> 924881 INFO  (qtp4652003-9132) [    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> 924884 INFO  (qtp22652876-9142) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=4&tv.tf=true&start=0&fsv=true&sort=id+desc&shard.url=https://127.0.0.1:51178//collection1&rows=10&version=2&q=id:7&NOW=1476395373758&isShard=true&wt=javabin}
 hits=1 status=0 QTime=0
   [junit4]   2> 924886 INFO  (qtp22652876-9149) [    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=https://127.0.0.1:51178//collection1&version=2&q=id:7&NOW=1476395373758&ids=7&isShard=true&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 924886 INFO  (qtp22652876-9144) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=id:7&shards=https://127.0.0.1:51178//collection1&tv=true&qt=tvrh&fl=*,score&tv.tf=true&sort=id+desc&wt=javabin&version=2}
 hits=1 status=0 QTime=3
   [junit4]   2> 924889 INFO  (qtp4652003-9125) [    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> 924892 INFO  (qtp22652876-9148) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=4&tv.tf=true&start=0&fsv=true&sort=id+desc&shard.url=[ff01::213]:33332/|[ff01::114]:33332/|https://127.0.0.1:51178//collection1|[ff01::083]:33332/&rows=10&version=2&q=id:7&NOW=1476395373766&isShard=true&wt=javabin}
 hits=1 status=0 QTime=0
   [junit4]   2> 924894 INFO  (qtp22652876-9146) [    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/|https://127.0.0.1:51178//collection1|[ff01::083]:33332/&version=2&q=id:7&NOW=1476395373766&ids=7&isShard=true&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 924894 INFO  (qtp22652876-9145) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=id:7&shards=[ff01::213]:33332/|[ff01::114]:33332/|https://127.0.0.1:51178//collection1|[ff01::083]:33332/&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=3
   [junit4]   2> 924896 INFO  (qtp4652003-9127) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=id:7&tv=true&distrib=false&qt=tvrh&fl=score,test_basictv&fl=[docid],test_postv,val:sum(3,4)&tv.tf=true&sort=id+desc&wt=javabin&version=2}
 hits=1 status=0 QTime=0
   [junit4]   2> 924898 INFO  (qtp22652876-9142) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=4&tv.tf=true&start=0&fsv=true&sort=id+desc&shard.url=https://127.0.0.1:51178//collection1&rows=10&version=2&q=id:7&NOW=1476395373773&isShard=true&wt=javabin}
 hits=1 status=0 QTime=0
   [junit4]   2> 924901 INFO  (qtp22652876-9149) [    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=https://127.0.0.1:51178//collection1&version=2&q=id:7&NOW=1476395373773&ids=7&isShard=true&wt=javabin}
 status=0 QTime=1
   [junit4]   2> 924901 INFO  (qtp22652876-9147) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=id:7&shards=https://127.0.0.1:51178//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=4
   [junit4]   2> 924903 INFO  (qtp4652003-9129) [    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> 924905 INFO  (qtp22652876-9148) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&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=[ff01::083]:33332/|[ff01::213]:33332/|[ff01::114]:33332/|https://127.0.0.1:51178//collection1&rows=10&tv.tf_idf=true&version=2&q=id:7&tv.df=true&NOW=1476395373780&isShard=true&wt=javabin}
 hits=1 status=0 QTime=0
   [junit4]   2> 924907 INFO  (qtp22652876-9146) [    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=[ff01::083]:33332/|[ff01::213]:33332/|[ff01::114]:33332/|https://127.0.0.1:51178//collection1&tv.tf_idf=true&version=2&q=id:7&tv.df=true&NOW=1476395373780&ids=7&isShard=true&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 924908 INFO  (qtp22652876-9144) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=id:7&shards=[ff01::083]:33332/|[ff01::213]:33332/|[ff01::114]:33332/|https://127.0.0.1:51178//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=1 status=0 QTime=3
   [junit4]   2> 924909 INFO  (qtp4652003-9130) [    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> 924911 INFO  (qtp22652876-9142) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&distrib=false&qt=tvrh&fl=id&shards.purpose=4&start=0&fsv=true&sort=id+desc&shard.url=[ff01::114]:33332/|https://127.0.0.1:51178//collection1|[ff01::213]:33332/&rows=10&version=2&q=id:7&tv.all=true&NOW=1476395373786&isShard=true&wt=javabin}
 hits=1 status=0 QTime=0
   [junit4]   2> 924914 INFO  (qtp22652876-9149) [    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=1476395373786&ids=7&isShard=true&shard.url=[ff01::114]:33332/|https://127.0.0.1:51178//collection1|[ff01::213]:33332/&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 924914 INFO  (qtp22652876-9145) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=id:7&shards=[ff01::114]:33332/|https://127.0.0.1:51178//collection1|[ff01::213]:33332/&tv=true&tv.all=true&qt=tvrh&sort=id+desc&wt=javabin&version=2}
 hits=1 status=0 QTime=4
   [junit4]   2> 924917 INFO  (qtp4652003-9128) [    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> 924920 INFO  (qtp22652876-9148) [    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=https://127.0.0.1:51178//collection1&rows=1&version=2&q=id:7&tv.all=true&NOW=1476395373794&isShard=true&wt=javabin}
 hits=1 status=0 QTime=0
   [junit4]   2> 924920 INFO  (qtp22652876-9147) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=id:7&shards=https://127.0.0.1:51178//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=2
   [junit4]   2> 924922 INFO  (qtp4652003-9131) [    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> 924925 INFO  (qtp22652876-9144) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&distrib=false&fl=id&shards.purpose=4&tv.tf=true&f.test_basictv.tv.df=false&fsv=true&shard.url=[ff01::114]:33332/|[ff01::083]:33332/|https://127.0.0.1:51178//collection1|[ff01::213]:33332/&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=1476395373800&f.test_basictv.tv.tf=false&isShard=true}
 hits=1 status=0 QTime=0
   [junit4]   2> 924928 INFO  (qtp22652876-9142) [    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/|[ff01::083]:33332/|https://127.0.0.1:51178//collection1|[ff01::213]:33332/&tv.tf_idf=true&version=2&q=id:7&f.test_offtv.tv.offsets=false&tv.df=true&NOW=1476395373800&f.test_basictv.tv.tf=false&ids=7&isShard=true&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 924928 INFO  (qtp22652876-9146) [    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=[ff01::114]:33332/|[ff01::083]:33332/|https://127.0.0.1:51178//collection1|[ff01::213]:33332/&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> 924931 INFO  (qtp4652003-9132) [    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> 924934 INFO  (qtp22652876-9145) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&distrib=false&qt=tvrh&fl=id&shards.purpose=4&tv.tf=true&start=0&fsv=true&sort=id+desc&shard.url=https://127.0.0.1:51178//collection1&rows=10&version=2&q=id:[3+TO+6]&NOW=1476395373809&isShard=true&wt=javabin}
 hits=4 status=0 QTime=0
   [junit4]   2> 924937 INFO  (qtp22652876-9148) [    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=1476395373809&ids=3,4,5,6&isShard=true&shard.url=https://127.0.0.1:51178//collection1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 924939 INFO  (qtp22652876-9149) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=id:[3+TO+6]&shards=https://127.0.0.1:51178//collection1&tv=true&qt=tvrh&tv.tf=true&sort=id+desc&wt=javabin&version=2}
 hits=4 status=0 QTime=6
   [junit4]   2> 924941 INFO  (qtp4652003-9125) [    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> 924946 INFO  (qtp22652876-9144) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=4&tv.tf=true&start=0&fsv=true&sort=id+asc&tv.fl=test_basictv,test_offtv&shard.url=https://127.0.0.1:51178//collection1|[ff01::114]:33332/|[ff01::083]:33332/|[ff01::213]:33332/&rows=10&version=2&q=id:[3+TO+6]&NOW=1476395373819&isShard=true&wt=javabin}
 hits=4 status=0 QTime=1
   [junit4]   2> 924949 INFO  (qtp22652876-9142) [    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=https://127.0.0.1:51178//collection1|[ff01::114]:33332/|[ff01::083]:33332/|[ff01::213]:33332/&version=2&q=id:[3+TO+6]&NOW=1476395373819&ids=3,4,5,6&isShard=true&wt=javabin}
 status=0 QTime=1
   [junit4]   2> 924949 INFO  (qtp22652876-9147) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=id:[3+TO+6]&shards=https://127.0.0.1:51178//collection1|[ff01::114]:33332/|[ff01::083]:33332/|[ff01::213]:33332/&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=6
   [junit4]   2> 924952 INFO  (qtp4652003-9127) [    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> 924955 INFO  (qtp22652876-9145) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=4&tv.tf=true&start=0&fsv=true&sort=id+asc&tv.fl=test_basictv&tv.fl=test_offtv&shard.url=https://127.0.0.1:51178//collection1|[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/&rows=10&version=2&q=id:[3+TO+6]&NOW=1476395373829&isShard=true&wt=javabin}
 hits=4 status=0 QTime=0
   [junit4]   2> 924957 INFO  (qtp22652876-9148) [    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=https://127.0.0.1:51178//collection1|[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/&version=2&q=id:[3+TO+6]&NOW=1476395373829&ids=3,4,5,6&isShard=true&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 924957 INFO  (qtp22652876-9146) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=id:[3+TO+6]&shards=https://127.0.0.1:51178//collection1|[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]: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=4 status=0 QTime=4
   [junit4]   2> 924961 INFO  (qtp4652003-9129) [    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> 924964 INFO  (qtp22652876-9144) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=4&tv.tf=true&start=0&fsv=true&sort=id+desc&shard.url=[ff01::083]:33332/|https://127.0.0.1:51178//collection1&rows=10&version=2&q=id:[3+TO+6]&NOW=1476395373838&isShard=true&wt=javabin}
 hits=4 status=0 QTime=0
   [junit4]   2> 924966 INFO  (qtp22652876-9142) [    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::083]:33332/|https://127.0.0.1:51178//collection1&version=2&q=id:[3+TO+6]&NOW=1476395373838&ids=3,4,5,6&isShard=true&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 924967 INFO  (qtp22652876-9149) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=id:[3+TO+6]&shards=[ff01::083]:33332/|https://127.0.0.1:51178//collection1&tv=true&qt=tvrh&fl=*,score&tv.tf=true&sort=id+desc&wt=javabin&version=2}
 hits=4 status=0 QTime=4
   [junit4]   2> 924969 INFO  (qtp4652003-9130) [    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> 924972 INFO  (qtp22652876-9145) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=4&tv.tf=true&start=0&fsv=true&sort=id+desc&shard.url=[ff01::213]:33332/|[ff01::083]:33332/|https://127.0.0.1:51178//collection1|[ff01::114]:33332/&rows=10&version=2&q=id:[3+TO+6]&NOW=1476395373847&isShard=true&wt=javabin}
 hits=4 status=0 QTime=0
   [junit4]   2> 924974 INFO  (qtp22652876-9148) [    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::083]:33332/|https://127.0.0.1:51178//collection1|[ff01::114]:33332/&version=2&q=id:[3+TO+6]&NOW=1476395373847&ids=3,4,5,6&isShard=true&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 924975 INFO  (qtp22652876-9147) [    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/|https://127.0.0.1:51178//collection1|[ff01::114]:33332/&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> 924977 INFO  (qtp4652003-9128) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=id:[3+TO+6]&tv=true&distrib=false&qt=tvrh&fl=score,test_basictv&fl=[docid],test_postv,val:sum(3,4)&tv.tf=true&sort=id+desc&wt=javabin&version=2}
 hits=4 status=0 QTime=0
   [junit4]   2> 924979 INFO  (qtp22652876-9144) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=4&tv.tf=true&start=0&fsv=true&sort=id+desc&shard.url=https://127.0.0.1:51178//collection1|[ff01::083]:33332/|[ff01::114]:33332/|[ff01::213]:33332/&rows=10&version=2&q=id:[3+TO+6]&NOW=1476395373854&isShard=true&wt=javabin}
 hits=4 status=0 QTime=0
   [junit4]   2> 924982 INFO  (qtp22652876-9142) [    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=https://127.0.0.1:51178//collection1|[ff01::083]:33332/|[ff01::114]:33332/|[ff01::213]:33332/&version=2&q=id:[3+TO+6]&NOW=1476395373854&ids=3,4,5,6&isShard=true&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 924983 INFO  (qtp22652876-9146) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=id:[3+TO+6]&shards=https://127.0.0.1:51178//collection1|[ff01::083]:33332/|[ff01::114]:33332/|[ff01::213]:33332/&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=4
   [junit4]   2> 924985 INFO  (qtp4652003-9131) [    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=1
   [junit4]   2> 924988 INFO  (qtp22652876-9145) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&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=[ff01::213]:33332/|[ff01::114]:33332/|[ff01::083]:33332/|https://127.0.0.1:51178//collection1&rows=10&tv.tf_idf=true&version=2&q=id:[3+TO+6]&tv.df=true&NOW=1476395373862&isShard=true&wt=javabin}
 hits=4 status=0 QTime=0
   [junit4]   2> 924991 INFO  (qtp22652876-9148) [    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=[ff01::213]:33332/|[ff01::114]:33332/|[ff01::083]:33332/|https://127.0.0.1:51178//collection1&tv.tf_idf=true&version=2&q=id:[3+TO+6]&tv.df=true&NOW=1476395373862&ids=3,4,5,6&isShard=true&wt=javabin}
 status=0 QTime=1
   [junit4]   2> 924992 INFO  (qtp22652876-9149) [    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/|[ff01::083]:33332/|https://127.0.0.1:51178//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=5
   [junit4]   2> 924995 INFO  (qtp4652003-9132) [    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> 924997 INFO  (qtp22652876-9144) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&distrib=false&qt=tvrh&fl=id&shards.purpose=4&start=0&fsv=true&sort=id+desc&shard.url=https://127.0.0.1:51178//collection1&rows=10&version=2&q=id:[3+TO+6]&tv.all=true&NOW=1476395373871&isShard=true&wt=javabin}
 hits=4 status=0 QTime=0
   [junit4]   2> 924999 INFO  (qtp22652876-9142) [    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=1476395373871&ids=3,4,5,6&isShard=true&shard.url=https://127.0.0.1:51178//collection1&wt=javabin&version=2}
 status=0 QTime=1
   [junit4]   2> 925000 INFO  (qtp22652876-9147) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=id:[3+TO+6]&shards=https://127.0.0.1:51178//collection1&tv=true&tv.all=true&qt=tvrh&sort=id+desc&wt=javabin&version=2}
 hits=4 status=0 QTime=4
   [junit4]   2> 925002 INFO  (qtp4652003-9125) [    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> 925005 INFO  (qtp22652876-9145) [    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=https://127.0.0.1:51178//collection1|[ff01::213]:33332/|[ff01::114]:33332/|[ff01::083]:33332/&rows=1&version=2&q=id:[3+TO+6]&tv.all=true&NOW=1476395373879&isShard=true&wt=javabin}
 hits=4 status=0 QTime=0
   [junit4]   2> 925006 INFO  (qtp22652876-9146) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=id:[3+TO+6]&shards=https://127.0.0.1:51178//collection1|[ff01::213]:33332/|[ff01::114]:33332/|[ff01::083]:33332/&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> 925009 INFO  (qtp4652003-9127) [    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=1
   [junit4]   2> 925012 INFO  (qtp22652876-9149) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&distrib=false&fl=id&shards.purpose=4&tv.tf=true&f.test_basictv.tv.df=false&fsv=true&shard.url=https://127.0.0.1:51178//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=1476395373886&f.test_basictv.tv.tf=false&isShard=true}
 hits=4 status=0 QTime=1
   [junit4]   2> 925016 INFO  (qtp22652876-9144) [    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=https://127.0.0.1:51178//collection1&tv.tf_idf=true&version=2&q=id:[3+TO+6]&f.test_offtv.tv.offsets=false&tv.df=true&NOW=1476395373886&f.test_basictv.tv.tf=false&ids=3,4,5,6&isShard=true&wt=javabin}
 status=0 QTime=1
   [junit4]   2> 925016 INFO  (qtp22652876-9148) [    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=https://127.0.0.1:51178//collection1&f.test_offtv.tv.offsets=false&tv.df=true&f.test_basictv.tv.tf=false&wt=javabin}
 hits=4 status=0 QTime=6
   [junit4]   2> 925020 INFO  (qtp4652003-9129) [    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=1
   [junit4]   2> 925023 INFO  (qtp22652876-9147) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&distrib=false&qt=tvrh&fl=id&shards.purpose=4&tv.tf=true&start=0&fsv=true&sort=id+desc&shard.url=https://127.0.0.1:51178//collection1|[ff01::083]:33332/|[ff01::114]:33332/&rows=10&version=2&q=*:*&NOW=1476395373897&isShard=true&wt=javabin}
 hits=10 status=0 QTime=0
   [junit4]   2> 925025 INFO  (qtp22652876-9145) [    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=1476395373897&ids=0,1,2,3,4,5,6,7,8,9&isShard=true&shard.url=https://127.0.0.1:51178//collection1|[ff01::083]:33332/|[ff01::114]:33332/&wt=javabin&version=2}
 status=0 QTime=1
   [junit4]   2> 925028 INFO  (qtp22652876-9142) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=https://127.0.0.1:51178//collection1|[ff01::083]:33332/|[ff01::114]:33332/&tv=true&qt=tvrh&tv.tf=true&sort=id+desc&wt=javabin&version=2}
 hits=10 status=0 QTime=6
   [junit4]   2> 925031 INFO  (qtp4652003-9130) [    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=1
   [junit4]   2> 925036 INFO  (qtp22652876-9149) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=4&tv.tf=true&start=0&fsv=true&sort=id+asc&tv.fl=test_basictv,test_offtv&shard.url=https://127.0.0.1:51178//collection1&rows=10&version=2&q=*:*&NOW=1476395373910&isShard=true&wt=javabin}
 hits=10 status=0 QTime=1
   [junit4]   2> 925038 INFO  (qtp22652876-9144) [    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=https://127.0.0.1:51178//collection1&version=2&q=*:*&NOW=1476395373910&ids=0,1,2,3,4,5,6,7,8,9&isShard=true&wt=javabin}
 status=0 QTime=1
   [junit4]   2> 925040 INFO  (qtp22652876-9146) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=https://127.0.0.1:51178//collection1&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=6
   [junit4]   2> 925042 INFO  (qtp4652003-9128) [    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=1
   [junit4]   2> 925047 INFO  (qtp22652876-9147) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=4&tv.tf=true&start=0&fsv=true&sort=id+asc&tv.fl=test_basictv&tv.fl=test_offtv&shard.url=https://127.0.0.1:51178//collection1&rows=10&version=2&q=*:*&NOW=1476395373921&isShard=true&wt=javabin}
 hits=10 status=0 QTime=1
   [junit4]   2> 925049 INFO  (qtp22652876-9145) [    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=https://127.0.0.1:51178//collection1&version=2&q=*:*&NOW=1476395373921&ids=0,1,2,3,4,5,6,7,8,9&isShard=true&wt=javabin}
 status=0 QTime=1
   [junit4]   2> 925050 INFO  (qtp22652876-9148) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=https://127.0.0.1:51178//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=10 status=0 QTime=5
   [junit4]   2> 925053 INFO  (qtp4652003-9131) [    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> 925057 INFO  (qtp22652876-9149) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=4&tv.tf=true&start=0&fsv=true&sort=id+desc&shard.url=https://127.0.0.1:51178//collection1&rows=10&version=2&q=*:*&NOW=1476395373930&isShard=true&wt=javabin}
 hits=10 status=0 QTime=0
   [junit4]   2> 925059 INFO  (qtp22652876-9144) [    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=https://127.0.0.1:51178//collection1&version=2&q=*:*&NOW=1476395373930&ids=0,1,2,3,4,5,6,7,8,9&isShard=true&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 925059 INFO  (qtp22652876-9142) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=https://127.0.0.1:51178//collection1&tv=true&qt=tvrh&fl=*,score&tv.tf=true&sort=id+desc&wt=javabin&version=2}
 hits=10 status=0 QTime=4
   [junit4]   2> 925062 INFO  (qtp4652003-9132) [    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=1
   [junit4]   2> 925064 INFO  (qtp22652876-9147) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=4&tv.tf=true&start=0&fsv=true&sort=id+desc&shard.url=[ff01::083]:33332/|https://127.0.0.1:51178//collection1&rows=10&version=2&q=*:*&NOW=1476395373939&isShard=true&wt=javabin}
 hits=10 status=0 QTime=0
   [junit4]   2> 925067 INFO  (qtp22652876-9145) [    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::083]:33332/|https://127.0.0.1:51178//collection1&version=2&q=*:*&NOW=1476395373939&ids=0,1,2,3,4,5,6,7,8,9&isShard=true&wt=javabin}
 status=0 QTime=1
   [junit4]   2> 925068 INFO  (qtp22652876-9146) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::083]:33332/|https://127.0.0.1:51178//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=10 status=0 QTime=5
   [junit4]   2> 925071 INFO  (qtp4652003-9125) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&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=10 status=0 QTime=0
   [junit4]   2> 925073 INFO  (qtp22652876-9149) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&distrib=false&qt=tvrh&fl=id&fl=score&shards.purpose=4&tv.tf=true&start=0&fsv=true&sort=id+desc&shard.url=https://127.0.0.1:51178//collection1&rows=10&version=2&q=*:*&NOW=1476395373948&isShard=true&wt=javabin}
 hits=10 status=0 QTime=0
   [junit4]   2> 925076 INFO  (qtp22652876-9144) [    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=https://127.0.0.1:51178//collection1&version=2&q=*:*&NOW=1476395373948&ids=0,1,2,3,4,5,6,7,8,9&isShard=true&wt=javabin}
 status=0 QTime=1
   [junit4]   2> 925077 INFO  (qtp22652876-9148) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=https://127.0.0.1:51178//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=10 status=0 QTime=5
   [junit4]   2> 925081 INFO  (qtp4652003-9127) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&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=10 status=0 QTime=2
   [junit4]   2> 925083 INFO  (qtp22652876-9147) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={tv=true&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=[ff01::083]:33332/|[ff01::114]:33332/|[ff01::213]:33332/|https://127.0.0.1:51178//collection1&rows=10&tv.tf_idf=true&version=2&q=*:*&tv.df=true&NOW=1476395373958&isShard=true&wt=javabin}
 hits=10 status=0 QTime=0
   [junit4]   2> 925088 INFO  (qtp22652876-9145) [    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=[ff01::083]:33332/|[ff01::114]:33332/|[ff01::213]:33332/|https://127.0.0.1:51178//collection1&tv.tf_idf=true&version=2&q=*:*&tv.df=true&NOW=1476395373958&ids=0,1,2,3,4,5,6,7,8,9&isShard=true&wt=javabin}
 status=0 QTime=2
   [junit4]   2> 925089 INFO  (qtp22652876-9142) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&shards=[ff01::083]:33332/|[ff01::114]:33332/|[ff01::213]:33332/|https://127.0.0.1:51178//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=10 status=0 QTime=6
   [junit4]   2> 925093 INFO  (qtp4652003-9129) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=*:*&tv=true&tv.all=true&distrib=false&qt=tvrh&sort=id+desc&wt=javabin&version=2}
 hits=10 status=0 QTime=2
   [junit4]   2> 925096 I

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

eSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, 
mergeFactor=25, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.8348758543399217]
   [junit4]   2> 1751999 INFO  (indexFetcher-6919-thread-1) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1752001 INFO  (indexFetcher-6919-thread-1) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@720816[collection1] main]
   [junit4]   2> 1752001 INFO  
(searcherExecutor-6915-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@720816[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C1)))}
   [junit4]   2> 1752113 INFO  (qtp18600533-14453) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={core=collection1&action=status&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1752115 INFO  (qtp23516357-14444) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=id:2000&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=0
   [junit4]   2> 1752116 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[81DDD69A06F55536])
 [    ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 1 docs
   [junit4]   2> 1752117 INFO  (qtp18600533-14458) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=id:2000&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=0
   [junit4]   2> 1752117 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[81DDD69A06F55536])
 [    ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 1 docs
   [junit4]   2> 1752119 INFO  (qtp18600533-14458) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[2001]} 0 1
   [junit4]   2> 1752119 INFO  (qtp18600533-14458) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1752120 INFO  (qtp18600533-14458) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@184ae99
   [junit4]   2> 1752132 INFO  (qtp18600533-14458) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@83547e[collection1] main]
   [junit4]   2> 1752132 INFO  
(searcherExecutor-6915-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@83547e[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C1)
 Uninverting(_1(7.0.0):C1)))}
   [junit4]   2> 1752132 INFO  (qtp18600533-14458) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1752133 INFO  (qtp18600533-14458) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 12
   [junit4]   2> 1752134 INFO  (qtp18600533-14460) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=id:2001&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=0
   [junit4]   2> 1752135 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[81DDD69A06F55536])
 [    ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 1 docs
   [junit4]   2> 1752135 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[81DDD69A06F55536])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending doTestIndexAndConfigAliasReplication
   [junit4]   2> 1752137 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[81DDD69A06F55536])
 [    ] o.e.j.s.ServerConnector Stopped 
ServerConnector@b12bd4{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1752137 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[81DDD69A06F55536])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=8541885
   [junit4]   2> 1752137 INFO  (coreCloseExecutor-6921-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@7ce970
   [junit4]   2> 1752139 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[81DDD69A06F55536])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@401910{/solr,null,UNAVAILABLE}
   [junit4]   2> 1752143 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[81DDD69A06F55536])
 [    ] o.e.j.s.ServerConnector Stopped 
ServerConnector@1b9a85e{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1752144 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[81DDD69A06F55536])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=31725307
   [junit4]   2> 1752146 INFO  (coreCloseExecutor-6923-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@8dcf21
   [junit4]   2> 1752148 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[81DDD69A06F55536])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@380127{/solr,null,UNAVAILABLE}
   [junit4]   2> 1752154 INFO  
(SUITE-TestReplicationHandler-seed#[81DDD69A06F55536]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_81DDD69A06F55536-001
   [junit4]   2> NOTE: test params are: codec=CheapBastard, 
sim=RandomSimilarity(queryNorm=true): {}, locale=es-PR, 
timezone=Pacific/Guadalcanal
   [junit4]   2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_102 
(32-bit)/cpus=3,threads=1,free=88430248,total=372244480
   [junit4]   2> NOTE: All tests run in this JVM: 
[TestCopyFieldCollectionResource, TestNumericTerms64, 
TestDocBasedVersionConstraints, DocExpirationUpdateProcessorFactoryTest, 
PrimUtilsTest, SpatialFilterTest, TestLazyCores, SolrRequestParserTest, 
TestOverriddenPrefixQueryForCustomFieldType, PeerSyncTest, 
TestAddFieldRealTimeGet, SmileWriterTest, TestPartialUpdateDeduplication, 
TestDistributedSearch, ChaosMonkeyNothingIsSafeTest, TestReRankQParserPlugin, 
InfoHandlerTest, OpenExchangeRatesOrgProviderTest, TestSolrXml, BitVectorTest, 
TestStandardQParsers, TestReplicationHandlerBackup, HighlighterTest, 
TestSchemaSimilarityResource, TestFieldTypeCollectionResource, 
MBeansHandlerTest, RecoveryZkTest, TestUpdate, LeaderElectionTest, 
SolrTestCaseJ4Test, DocValuesMultiTest, TestSQLHandlerNonCloud, 
TestReplicaProperties, TestHdfsUpdateLog, XmlUpdateRequestHandlerTest, 
TestFieldCacheVsDocValues, AlternateDirectoryTest, DirectUpdateHandlerTest, 
RankQueryTest, DisMaxRequestHandlerTest, TestHdfsCloudBackupRestore, 
TestClassicSimilarityFactory, OutputWriterTest, PingRequestHandlerTest, 
StandardRequestHandlerTest, TestFilteredDocIdSet, TestTolerantSearch, 
TestTolerantUpdateProcessorRandomCloud, DeleteStatusTest, 
TestExtendedDismaxParser, TestScoreJoinQPScore, SolrPluginUtilsTest, 
TestDynamicFieldCollectionResource, SOLR749Test, FastVectorHighlighterTest, 
TestSolrCloudWithDelegationTokens, TestUseDocValuesAsStored, 
SuggestComponentTest, DistributedSuggestComponentTest, 
XsltUpdateRequestHandlerTest, ShardSplitTest, 
DistributedQueryElevationComponentTest, TimeZoneUtilsTest, 
DirectSolrSpellCheckerTest, PrimitiveFieldTypeTest, TestQuerySenderNoQuery, 
CloudExitableDirectoryReaderTest, AnalysisAfterCoreReloadTest, 
TestCloudManagedSchema, DocumentBuilderTest, BaseCdcrDistributedZkTest, 
TestSort, SolrCLIZkUtilsTest, PathHierarchyTokenizerFactoryTest, 
TestFunctionQuery, TestRandomRequestDistribution, TestImplicitCoreProperties, 
QueryElevationComponentTest, GraphQueryTest, DistributedFacetPivotLongTailTest, 
IndexSchemaRuntimeFieldTest, DocValuesTest, SpatialHeatmapFacetsTest, 
SuggesterFSTTest, TestMergePolicyConfig, TestConfigReload, 
TestCSVResponseWriter, TestManagedResourceStorage, 
TestSolrCloudWithSecureImpersonation, OverseerTaskQueueTest, 
TestSurroundQueryParser, TestExpandComponent, DeleteReplicaTest, 
ShardRoutingTest, HdfsCollectionsAPIDistributedZkTest, 
DistributedQueryComponentCustomSortTest, LeaderFailoverAfterPartitionTest, 
DOMUtilTest, TestXIncludeConfig, TestOnReconnectListenerSupport, 
ZkControllerTest, HLLUtilTest, TestSolrCLIRunExample, TestExactStatsCache, 
ResponseHeaderTest, RestartWhileUpdatingTest, TestSchemaNameResource, 
TestCloudSchemaless, WrapperMergePolicyFactoryTest, TestMacros, SyncSliceTest, 
TestRemoteStreaming, TestFastOutputStream, CustomCollectionTest, 
DistributedDebugComponentTest, ChangedSchemaMergeTest, TestLRUCache, 
AddBlockUpdateTest, SearchHandlerTest, CdcrRequestHandlerTest, 
BigEndianAscendingWordDeserializerTest, TestSolrConfigHandlerConcurrent, 
TestElisionMultitermQuery, OutOfBoxZkACLAndCredentialsProvidersTest, 
CdcrUpdateLogTest, FullHLLTest, ZkCLITest, TestRandomDVFaceting, 
TestJmxIntegration, TestLockTree, SSLMigrationTest, PolyFieldTest, 
TestSimpleQParserPlugin, TestManagedStopFilterFactory, TestFaceting, 
CurrencyFieldXmlFileTest, TestCustomSort, TestSolr4Spatial2, 
TestJettySolrRunner, SampleTest, TestCollationField, TestIBSimilarityFactory, 
TestObjectReleaseTracker, ExitableDirectoryReaderTest, TestLegacyFieldCache, 
CloudMLTQParserTest, TestTrackingShardHandlerFactory, 
TestRequestStatusCollectionAPI, TestCharFilters, TestJsonFacets, 
OverseerRolesTest, TestManagedSchema, TestRuleBasedAuthorizationPlugin, 
TestPerFieldSimilarity, ZkStateReaderTest, OverseerTest, TestReplicationHandler]
   [junit4] Completed [329/638 (2!)] on J0 in 69.75s, 15 tests, 1 failure, 1 
skipped <<< FAILURES!

[...truncated 53662 lines...]


---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org