lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Policeman Jenkins Server <jenk...@thetaphi.de>
Subject [JENKINS] Lucene-Solr-7.2-Windows (32bit/jdk1.8.0_144) - Build # 12 - Still Unstable!
Date Tue, 12 Dec 2017 01:57:58 GMT
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.2-Windows/12/
Java: 32bit/jdk1.8.0_144 -server -XX:+UseSerialGC

2 tests failed.
FAILED:  junit.framework.TestSuite.org.apache.solr.TestDistributedGrouping

Error Message:
Could not remove the following files (in the order of attempts):    C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.TestDistributedGrouping_81D4D968453127E1-001\tempDir-001\shard2\configsets\cdcr-target: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.TestDistributedGrouping_81D4D968453127E1-001\tempDir-001\shard2\configsets\cdcr-target    C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.TestDistributedGrouping_81D4D968453127E1-001\tempDir-001\shard2\configsets: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.TestDistributedGrouping_81D4D968453127E1-001\tempDir-001\shard2\configsets    C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.TestDistributedGrouping_81D4D968453127E1-001\tempDir-001\shard2: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.TestDistributedGrouping_81D4D968453127E1-001\tempDir-001\shard2    C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.TestDistributedGrouping_81D4D968453127E1-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.TestDistributedGrouping_81D4D968453127E1-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-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.TestDistributedGrouping_81D4D968453127E1-001\tempDir-001\shard2\configsets\cdcr-target: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.TestDistributedGrouping_81D4D968453127E1-001\tempDir-001\shard2\configsets\cdcr-target
   C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.TestDistributedGrouping_81D4D968453127E1-001\tempDir-001\shard2\configsets: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.TestDistributedGrouping_81D4D968453127E1-001\tempDir-001\shard2\configsets
   C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.TestDistributedGrouping_81D4D968453127E1-001\tempDir-001\shard2: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.TestDistributedGrouping_81D4D968453127E1-001\tempDir-001\shard2
   C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.TestDistributedGrouping_81D4D968453127E1-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.TestDistributedGrouping_81D4D968453127E1-001\tempDir-001

	at __randomizedtesting.SeedInfo.seed([81D4D968453127E1]:0)
	at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
	at org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:216)
	at com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterAlways(TestRuleAdapter.java:31)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
	at java.lang.Thread.run(Thread.java:748)


FAILED:  junit.framework.TestSuite.org.apache.solr.cloud.ShardRoutingTest

Error Message:
Could not remove the following files (in the order of attempts):    C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest_81D4D968453127E1-001\shard-2-001\configsets\upload\dih-script-transformer: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest_81D4D968453127E1-001\shard-2-001\configsets\upload\dih-script-transformer    C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest_81D4D968453127E1-001\shard-2-001\configsets\upload: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest_81D4D968453127E1-001\shard-2-001\configsets\upload    C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest_81D4D968453127E1-001\shard-2-001\configsets: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest_81D4D968453127E1-001\shard-2-001\configsets    C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest_81D4D968453127E1-001\shard-2-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest_81D4D968453127E1-001\shard-2-001 

Stack Trace:
java.io.IOException: Could not remove the following files (in the order of attempts):
   C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest_81D4D968453127E1-001\shard-2-001\configsets\upload\dih-script-transformer: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest_81D4D968453127E1-001\shard-2-001\configsets\upload\dih-script-transformer
   C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest_81D4D968453127E1-001\shard-2-001\configsets\upload: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest_81D4D968453127E1-001\shard-2-001\configsets\upload
   C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest_81D4D968453127E1-001\shard-2-001\configsets: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest_81D4D968453127E1-001\shard-2-001\configsets
   C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest_81D4D968453127E1-001\shard-2-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest_81D4D968453127E1-001\shard-2-001

	at __randomizedtesting.SeedInfo.seed([81D4D968453127E1]:0)
	at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
	at org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:216)
	at com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterAlways(TestRuleAdapter.java:31)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
	at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 11735 lines...]
   [junit4] Suite: org.apache.solr.TestDistributedGrouping
   [junit4]   2> 207689 INFO  (SUITE-TestDistributedGrouping-seed#[81D4D968453127E1]-worker) [    ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.TestDistributedGrouping_81D4D968453127E1-001\init-core-data-001
   [junit4]   2> 207691 WARN  (SUITE-TestDistributedGrouping-seed#[81D4D968453127E1]-worker) [    ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=9 numCloses=9
   [junit4]   2> 207691 INFO  (SUITE-TestDistributedGrouping-seed#[81D4D968453127E1]-worker) [    ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 207695 INFO  (SUITE-TestDistributedGrouping-seed#[81D4D968453127E1]-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> 207695 INFO  (SUITE-TestDistributedGrouping-seed#[81D4D968453127E1]-worker) [    ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
   [junit4]   2> 208148 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.TestDistributedGrouping_81D4D968453127E1-001\tempDir-001\control\cores\collection1
   [junit4]   2> 208153 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 208153 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1dfbe6{/,null,AVAILABLE}
   [junit4]   2> 208155 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@1fd0fd4{SSL,[ssl, http/1.1]}{127.0.0.1:50144}
   [junit4]   2> 208155 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.e.j.s.Server Started @216489ms
   [junit4]   2> 208155 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=50144, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.TestDistributedGrouping_81D4D968453127E1-001\tempDir-001\control\cores}
   [junit4]   2> 208155 ERROR (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 208155 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 7.2.0
   [junit4]   2> 208155 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 208155 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 208156 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2017-12-12T00:48:25.259Z
   [junit4]   2> 208156 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.TestDistributedGrouping_81D4D968453127E1-001\tempDir-001\control\solr.xml
   [junit4]   2> 208164 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 208164 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 208166 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@bf7b6d, but no JMX reporters were configured - adding default JMX reporter.
   [junit4]   2> 208302 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@bf7b6d
   [junit4]   2> 208307 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@bf7b6d
   [junit4]   2> 208307 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@bf7b6d
   [junit4]   2> 208310 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.TestDistributedGrouping_81D4D968453127E1-001\tempDir-001\control\cores
   [junit4]   2> 208310 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 208319 INFO  (coreLoadExecutor-843-thread-1) [    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
   [junit4]   2> 208321 INFO  (coreLoadExecutor-843-thread-1) [    x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-7.2-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-7.2-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 208384 INFO  (coreLoadExecutor-843-thread-1) [    x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0
   [junit4]   2> 208397 INFO  (coreLoadExecutor-843-thread-1) [    x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 208476 INFO  (coreLoadExecutor-843-thread-1) [    x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 208485 INFO  (coreLoadExecutor-843-thread-1) [    x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\core\src\test-files\solr\collection1, trusted=true
   [junit4]   2> 208485 INFO  (coreLoadExecutor-843-thread-1) [    x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@bf7b6d
   [junit4]   2> 208485 INFO  (coreLoadExecutor-843-thread-1) [    x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 208485 INFO  (coreLoadExecutor-843-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\core\src\test-files\solr\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.TestDistributedGrouping_81D4D968453127E1-001\tempDir-001\control\cores\collection1\data\]
   [junit4]   2> 208489 INFO  (coreLoadExecutor-843-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=36, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
   [junit4]   2> 208575 INFO  (coreLoadExecutor-843-thread-1) [    x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 208575 INFO  (coreLoadExecutor-843-thread-1) [    x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 208577 INFO  (coreLoadExecutor-843-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 208577 INFO  (coreLoadExecutor-843-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 208578 INFO  (coreLoadExecutor-843-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=48, maxMergeAtOnceExplicit=42, maxMergedSegmentMB=16.69140625, floorSegmentMB=0.2978515625, forceMergeDeletesPctAllowed=16.615579535407576, segmentsPerTier=36.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.24033865354206638
   [junit4]   2> 208578 INFO  (coreLoadExecutor-843-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@133a255[collection1] main]
   [junit4]   2> 208579 INFO  (coreLoadExecutor-843-thread-1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 208587 INFO  (coreLoadExecutor-843-thread-1) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 208623 INFO  (coreLoadExecutor-843-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 208623 INFO  (searcherExecutor-844-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 208623 INFO  (coreLoadExecutor-843-thread-1) [    x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1586537122472394752
   [junit4]   2> 208623 INFO  (searcherExecutor-844-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 208623 INFO  (searcherExecutor-844-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 208623 INFO  (searcherExecutor-844-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 208623 INFO  (searcherExecutor-844-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 208623 INFO  (searcherExecutor-844-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 208623 INFO  (searcherExecutor-844-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 208623 INFO  (searcherExecutor-844-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 208624 INFO  (searcherExecutor-844-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 208625 INFO  (searcherExecutor-844-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@133a255[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 209131 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.TestDistributedGrouping_81D4D968453127E1-001\tempDir-001\shard0\cores\collection1
   [junit4]   2> 209136 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 209136 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@10da189{/,null,AVAILABLE}
   [junit4]   2> 209138 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@126907c{SSL,[ssl, http/1.1]}{127.0.0.1:50165}
   [junit4]   2> 209138 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.e.j.s.Server Started @217472ms
   [junit4]   2> 209138 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=50165, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.TestDistributedGrouping_81D4D968453127E1-001\tempDir-001\shard0\cores}
   [junit4]   2> 209138 ERROR (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 209138 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 7.2.0
   [junit4]   2> 209138 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 209138 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 209138 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2017-12-12T00:48:26.242Z
   [junit4]   2> 209138 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.TestDistributedGrouping_81D4D968453127E1-001\tempDir-001\shard0\solr.xml
   [junit4]   2> 209154 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 209154 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 209165 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@bf7b6d, but no JMX reporters were configured - adding default JMX reporter.
   [junit4]   2> 209241 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@bf7b6d
   [junit4]   2> 209247 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@bf7b6d
   [junit4]   2> 209247 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@bf7b6d
   [junit4]   2> 209250 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.TestDistributedGrouping_81D4D968453127E1-001\tempDir-001\shard0\cores
   [junit4]   2> 209250 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 209251 INFO  (coreLoadExecutor-854-thread-1) [    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
   [junit4]   2> 209252 INFO  (coreLoadExecutor-854-thread-1) [    x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-7.2-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-7.2-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 209330 INFO  (coreLoadExecutor-854-thread-1) [    x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0
   [junit4]   2> 209345 INFO  (coreLoadExecutor-854-thread-1) [    x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 209424 INFO  (coreLoadExecutor-854-thread-1) [    x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 209434 INFO  (coreLoadExecutor-854-thread-1) [    x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\core\src\test-files\solr\collection1, trusted=true
   [junit4]   2> 209434 INFO  (coreLoadExecutor-854-thread-1) [    x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@bf7b6d
   [junit4]   2> 209434 INFO  (coreLoadExecutor-854-thread-1) [    x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 209434 INFO  (coreLoadExecutor-854-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\core\src\test-files\solr\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.TestDistributedGrouping_81D4D968453127E1-001\tempDir-001\shard0\cores\collection1\data\]
   [junit4]   2> 209437 INFO  (coreLoadExecutor-854-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=36, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
   [junit4]   2> 209530 INFO  (coreLoadExecutor-854-thread-1) [    x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 209530 INFO  (coreLoadExecutor-854-thread-1) [    x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 209531 INFO  (coreLoadExecutor-854-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 209531 INFO  (coreLoadExecutor-854-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 209533 INFO  (coreLoadExecutor-854-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=48, maxMergeAtOnceExplicit=42, maxMergedSegmentMB=16.69140625, floorSegmentMB=0.2978515625, forceMergeDeletesPctAllowed=16.615579535407576, segmentsPerTier=36.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.24033865354206638
   [junit4]   2> 209533 INFO  (coreLoadExecutor-854-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@943447[collection1] main]
   [junit4]   2> 209534 INFO  (coreLoadExecutor-854-thread-1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 209541 INFO  (coreLoadExecutor-854-thread-1) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 209572 INFO  (coreLoadExecutor-854-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 209572 INFO  (coreLoadExecutor-854-thread-1) [    x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1586537123467493376
   [junit4]   2> 209574 INFO  (searcherExecutor-855-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 209574 INFO  (searcherExecutor-855-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 209574 INFO  (searcherExecutor-855-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 209574 INFO  (searcherExecutor-855-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 209574 INFO  (searcherExecutor-855-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 209575 INFO  (searcherExecutor-855-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 209575 INFO  (searcherExecutor-855-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 209575 INFO  (searcherExecutor-855-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 209575 INFO  (searcherExecutor-855-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 209576 INFO  (searcherExecutor-855-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@943447[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 209577 INFO  (TEST-TestDistributedGrouping.test-seed#[81D4D968453127E1]) [    ] o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 209611 INFO  (qtp23273507-2146) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1586537123505242112)} 0 2
   [junit4]   2> 209650 INFO  (qtp18859287-2169) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1586537123545088000)} 0 3
   [junit4]   2> 209651 INFO  (qtp23273507-2145) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1586537123550330880,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 209651 INFO  (qtp23273507-2145) [    x:collection1] o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 209661 INFO  (qtp23273507-2145) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 209661 INFO  (qtp23273507-2145) [    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 10
   [junit4]   2> 209663 INFO  (qtp18859287-2168) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1586537123562913792,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 209663 INFO  (qtp18859287-2168) [    x:collection1] o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 209663 INFO  (qtp18859287-2168) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 209663 INFO  (qtp18859287-2168) [    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 0
   [junit4]   2> 209689 INFO  (qtp23273507-2144) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&rows=100&wt=javabin&version=2&group.field=a_i1&group=true} hits=0 status=0 QTime=25
   [junit4]   2> 209727 INFO  (qtp18859287-2161) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=text&group.distributed.first=true&distrib=false&fl=id&group.limit=-1&shards.purpose=2048&start=0&sort=a_i1+asc,+id+asc&shard.url=[ff01::114]:33332/|https://127.0.0.1:50165//collection1&rows=100&version=2&q=*:*&NOW=1513039706798&isShard=true&wt=javabin&group.field=a_i1&group=true} status=0 QTime=24
   [junit4]   2> 209751 INFO  (qtp18859287-2166) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=[ff01::114]:33332/|https://127.0.0.1:50165//collection1&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&rows=100&wt=javabin&version=2&group.field=a_i1&group=true} status=0 QTime=57
   [junit4]   2> 209759 INFO  (qtp23273507-2143) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&hl=true&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&hl.fl=a_t&rows=100&wt=javabin&version=2&group.field=a_i1&group=true} hits=0 status=0 QTime=5
   [junit4]   2> 209760 INFO  (qtp18859287-2170) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=text&group.distributed.first=true&distrib=false&hl=false&fl=id&group.limit=-1&shards.purpose=2048&start=0&sort=a_i1+asc,+id+asc&shard.url=[ff01::083]:33332/|https://127.0.0.1:50165//collection1&rows=100&version=2&q=*:*&NOW=1513039706863&isShard=true&hl.fl=a_t&wt=javabin&group.field=a_i1&group=true} status=0 QTime=0
   [junit4]   2> 209760 INFO  (qtp18859287-2159) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=[ff01::083]:33332/|https://127.0.0.1:50165//collection1&hl=true&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&hl.fl=a_t&rows=100&wt=javabin&version=2&group.field=a_i1&group=true} status=0 QTime=1
   [junit4]   2> 209763 INFO  (qtp23273507-2142) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&facet.field=a_t&distrib=false&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&rows=100&facet=true&wt=javabin&version=2&group.field=a_i1&group=true} hits=0 status=0 QTime=1
   [junit4]   2> 209768 INFO  (qtp18859287-2169) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={facet.field=a_t&df=text&group.distributed.first=true&distrib=false&fl=id&group.limit=-1&shards.purpose=2048&start=0&sort=a_i1+asc,+id+asc&shard.url=[ff01::114]:33332/|https://127.0.0.1:50165//collection1&rows=100&version=2&q=*:*&NOW=1513039706869&isShard=true&facet=false&wt=javabin&group.field=a_i1&group=true} status=0 QTime=0
   [junit4]   2> 209776 INFO  (qtp18859287-2169) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={facet.field=a_t&df=text&distrib=false&fl=id&group.limit=-1&shards.purpose=20&start=0&f.a_t.facet.mincount=0&sort=a_i1+asc,+id+asc&shard.url=[ff01::114]:33332/|https://127.0.0.1:50165//collection1&rows=100&version=2&group.distributed.second=true&q=*:*&f.a_t.facet.limit=160&NOW=1513039706869&isShard=true&facet=true&wt=javabin&group.field=a_i1&group=true} status=0 QTime=7
   [junit4]   2> 209784 INFO  (qtp18859287-2170) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=[ff01::114]:33332/|https://127.0.0.1:50165//collection1&facet.field=a_t&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&rows=100&facet=true&wt=javabin&version=2&group.field=a_i1&group=true} status=0 QTime=19
   [junit4]   2> 209786 INFO  (qtp23273507-2142) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&distrib=false&stats=true&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&rows=100&wt=javabin&version=2&group.field=a_i1&group=true&stats.field=a_i1} hits=0 status=0 QTime=0
   [junit4]   2> 209798 INFO  (qtp18859287-2163) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=text&group.distributed.first=true&distrib=false&fl=id&group.limit=-1&shards.purpose=2048&start=0&sort=a_i1+asc,+id+asc&shard.url=[ff01::213]:33332/|https://127.0.0.1:50165//collection1|[ff01::114]:33332/&rows=100&version=2&q=*:*&stats=false&NOW=1513039706890&isShard=true&wt=javabin&group.field=a_i1&group=true&stats.field=a_i1} status=0 QTime=0
   [junit4]   2> 209800 INFO  (qtp18859287-2163) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=text&distrib=false&fl=id&group.limit=-1&shards.purpose=516&start=0&sort=a_i1+asc,+id+asc&shard.url=[ff01::213]:33332/|https://127.0.0.1:50165//collection1|[ff01::114]:33332/&rows=100&version=2&group.distributed.second=true&q=*:*&stats=true&NOW=1513039706890&isShard=true&wt=javabin&group.field=a_i1&group=true&stats.field=a_i1} status=0 QTime=0
   [junit4]   2> 209800 INFO  (qtp18859287-2164) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={q=*:*&shards=[ff01::213]:33332/|https://127.0.0.1:50165//collection1|[ff01::114]:33332/&stats=true&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&rows=100&wt=javabin&version=2&group.field=a_i1&group=true&stats.field=a_i1} status=0 QTime=13
   [junit4]   2> 209801 INFO  (qtp23273507-2142) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=subject&distrib=false&qt=spellCheckCompRH&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&rows=100&version=2&spellcheck.build=true&q=kings&spellcheck=true&wt=javabin&group.field=a_i1&group=true} hits=0 status=0 QTime=0
   [junit4]   2> 209802 INFO  (qtp18859287-2161) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=subject&group.distributed.first=true&distrib=false&qt=spellCheckCompRH&fl=id&group.limit=-1&shards.purpose=2048&start=0&sort=a_i1+asc,+id+asc&shard.url=https://127.0.0.1:50165//collection1|[ff01::114]:33332/&rows=100&version=2&spellcheck.build=true&q=kings&spellcheck=true&NOW=1513039706905&isShard=true&wt=javabin&group.field=a_i1&group=true} status=0 QTime=0
   [junit4]   2> 209803 INFO  (qtp18859287-2163) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={df=subject&qt=spellCheckCompRH&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&rows=100&version=2&spellcheck.build=true&q=kings&shards=https://127.0.0.1:50165//collection1|[ff01::114]:33332/&spellcheck=true&wt=javabin&group.field=a_i1&group=true} status=0 QTime=1
   [junit4]   2> 209814 INFO  (qtp23273507-2142) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={facet.field=a_t&distrib=false&fl=id,a_i1&group.limit=-1&fq=a_s:a&sort=a_i1+asc,+id+asc&rows=100&version=2&q=*:*&group.truncate=true&facet=true&wt=javabin&group.field=a_i1&group=true} hits=0 status=0 QTime=11
   [junit4]   2> 209817 INFO  (qtp18859287-2166) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={facet.field=a_t&df=text&group.distributed.first=true&distrib=false&fl=id&group.limit=-1&shards.purpose=2048&start=0&fq=a_s:a&sort=a_i1+asc,+id+asc&shard.url=[ff01::213]:33332/|https://127.0.0.1:50165//collection1|[ff01::083]:33332/&rows=100&version=2&q=*:*&group.truncate=true&NOW=1513039706919&isShard=true&facet=false&wt=javabin&group.field=a_i1&group=true} status=0 QTime=0
   [junit4]   2> 209818 INFO  (qtp18859287-2166) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={facet.field=a_t&df=text&distrib=false&fl=id&group.limit=-1&shards.purpose=20&start=0&f.a_t.facet.mincount=0&fq=a_s:a&sort=a_i1+asc,+id+asc&shard.url=[ff01::213]:33332/|https://127.0.0.1:50165//collection1|[ff01::083]:33332/&rows=100&version=2&group.distributed.second=true&q=*:*&f.a_t.facet.limit=160&group.truncate=true&NOW=1513039706919&isShard=true&facet=true&wt=javabin&group.field=a_i1&group=true} status=0 QTime=0
   [junit4]   2> 209818 INFO  (qtp18859287-2161) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp= path=/select params={facet.field=a_t&fl=id,a_i1&group.limit=-1&fq=a_s:a&sort=a_i1+asc,+id+asc&rows=100&version=2&q=*:*&shards=[ff01::213]:33332/|https://127.0.0.1:50165//collection1|[ff01::083]:33332/&group.truncate=true&facet=true&wt=javabin&group.field=a_i1&group=true} status=0 QTime=3
   [junit4]   2> 209825 INFO  (qtp23273507-2139) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[1 (1586537123726491648)]} 0 5
   [junit4]   2> 209833 INFO  (qtp18859287-2166) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[1 (1586537123733831680)]} 0 7
   [junit4]   2> 209835 INFO  (qtp23273507-2149) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[2 (1586537123742220288)]} 0 1
   [junit4]   2> 209837 INFO  (qtp18859287-2169) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[2 (1586537123744317440)]} 0 1
   [junit4]   2> 209839 INFO  (qtp23273507-2146) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[3 (1586537123746414592)]} 0 0
   [junit4]   2> 209840 INFO  (qtp18859287-2170) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[3 (1586537123747463168)]} 0 0
   [junit4]   2> 209841 INFO  (qtp23273507-2146) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[4 (1586537123748511744)]} 0 0
   [junit4]   2> 209841 INFO  (qtp18859287-2170) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[4 (1586537123749560320)]} 0 0
   [junit4]   2> 209843 INFO  (qtp23273507-2145) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[5 (1586537123751657472)]} 0 0
   [junit4]   2> 209844 INFO  (qtp18859287-2170) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[5 (1586537123751657472)]} 0 0
   [junit4]   2> 209845 INFO  (qtp23273507-2145) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[6 (1586537123752706048)]} 0 0
   [junit4]   2> 209845 INFO  (qtp18859287-2170) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[6 (1586537123753754624)]} 0 0
   [junit4]   2> 209846 INFO  (qtp23273507-2145) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[7 (1586537123754803200)]} 0 0
   [junit4]   2> 209848 INFO  (qtp18859287-2170) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[7 (1586537123756900352)]} 0 0
   [junit4]   2> 209848 INFO  (qtp23273507-2145) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[8 (1586537123756900352)]} 0 0
   [junit4]   2> 209849 INFO  (qtp18859287-2170) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[8 (1586537123757948928)]} 0 0
   [junit4]   2> 209850 INFO  (qtp23273507-2144) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[9 (1586537123758997504)]} 0 0
   [junit4]   2> 209851 INFO  (qtp18859287-2170) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[9 (1586537123760046080)]} 0 0
   [junit4]   2> 209853 INFO  (qtp23273507-2144) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[10 (1586537123762143232)]} 0 0
   [junit4]   2> 209853 INFO  (qtp18859287-2170) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[10 (1586537123762143232)]} 0 0
   [junit4]   2> 209854 INFO  (qtp23273507-2144) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[11 (1586537123763191808)]} 0 0
   [junit4]   2> 209855 INFO  (qtp18859287-2170) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[11 (1586537123764240384)]} 0 0
   [junit4]   2> 209856 INFO  (qtp23273507-2143) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[12 (1586537123765288960)]} 0 0
   [junit4]   2> 209857 INFO  (qtp18859287-2170) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[12 (1586537123766337536)]} 0 0
   [junit4]   2> 209859 INFO  (qtp23273507-2143) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[14 (1586537123767386112)]} 0 0
   [junit4]   2> 209860 INFO  (qtp18859287-2168) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[14 (1586537123768434688)]} 0 0
   [junit4]   2> 209861 INFO  (qtp23273507-2150) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[15 (1586537123770531840)]} 0 0
   [junit4]   2> 209862 INFO  (qtp18859287-2161) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[15 (1586537123771580416)]} 0 0
   [junit4]   2> 209863 INFO  (qtp23273507-2142) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[16 (1586537123772628992)]} 0 0
   [junit4]   2> 209864 INFO  (qtp18859287-2165) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[16 (1586537123773677568)]} 0 0
   [junit4]   2> 209865 INFO  (qtp23273507-2139) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[17 (1586537123773677568)]} 0 0
   [junit4]   2> 209866 INFO  (qtp18859287-2166) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[17 (1586537123774726144)]} 0 0
   [junit4]   2> 209866 INFO  (qtp23273507-2149) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[18 (1586537123775774720)]} 0 0
   [junit4]   2> 209868 INFO  (qtp18859287-2169) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[18 (1586537123777871872)]} 0 0
   [junit4]   2> 209869 INFO  (qtp23273507-2146) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[19 (1586537123777871872)]} 0 0
   [junit4]   2> 209870 INFO  (qtp18859287-2164) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[19 (1586537123778920448)]} 0 0
   [junit4]   2> 209871 INFO  (qtp23273507-2146) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[20 (1586537123779969024)]} 0 0
   [junit4]   2> 209872 INFO  (qtp18859287-2163) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[20 (1586537123781017600)]} 0 0
   [junit4]   2> 209873 INFO  (qtp23273507-2144) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[21 (1586537123782066176)]} 0 0
   [junit4]   2> 209874 INFO  (qtp18859287-2159) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[21 (1586537123783114752)]} 0 0
   [junit4]   2> 209875 INFO  (qtp23273507-2141) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[22 (1586537123784163328)]} 0 0
   [junit4]   2> 209876 INFO  (qtp18859287-2170) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[22 (1586537123785211904)]} 0 0
   [junit4]   2> 209876 INFO  (qtp23273507-2143) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[23 (1586537123786260480)]} 0 0
   [junit4]   2> 209877 INFO  (qtp18859287-2168) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[23 (1586537123787309056)]} 0 0
   [junit4]   2> 209878 INFO  (qtp23273507-2150) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[100 (1586537123788357632)]} 0 0
   [junit4]   2> 209879 INFO  (qtp18859287-2161) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[100 (1586537123789406208)]} 0 0
   [junit4]   2> 209880 INFO  (qtp23273507-2142) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[101 (1586537123790454784)]} 0 0
   [junit4]   2> 209881 INFO  (qtp18859287-2165) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[101 (1586537123791503360)]} 0 0
   [junit4]   2> 209882 INFO  (qtp23273507-2139) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[102 (1586537123792551936)]} 0 0
   [junit4]   2> 209883 INFO  (qtp18859287-2165) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[102 (1586537123792551936)]} 0 0
   [junit4]   2> 209884 INFO  (qtp23273507-2139) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[103 (1586537123793600512)]} 0 0
   [junit4]   2> 209884 INFO  (qtp18859287-2165) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[103 (1586537123794649088)]} 0 0
   [junit4]   2> 209885 INFO  (qtp23273507-2139) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[104 (1586537123795697664)]} 0 0
   [junit4]   2> 209886 INFO  (qtp18859287-2165) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[104 (1586537123796746240)]} 0 0
   [junit4]   2> 209887 INFO  (qtp23273507-2139) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[105 (1586537123796746240)]} 0 0
   [junit4]   2> 209888 INFO  (qtp18859287-2165) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[105 (1586537123797794816)]} 0 0
   [junit4]   2> 209889 INFO  (qtp23273507-2144) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[106 (1586537123798843392)]} 0 0
   [junit4]   2> 209889 INFO  (qtp18859287-2159) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[106 (1586537123799891968)]} 0 0
   [junit4]   2> 209890 INFO  (qtp23273507-2141) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[107 (1586537123800940544)]} 0 0
   [junit4]   2> 209891 INFO  (qtp18859287-2170) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[107 (1586537123801989120)]} 0 0
   [junit4]   2> 209892 INFO  (qtp23273507-2143) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[108 (1586537123801989120)]} 0 0
   [junit4]   2> 209893 INFO  (qtp18859287-2168) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[108 (1586537123803037696)]} 0 0
   [junit4]   2> 209894 INFO  (qtp23273507-2150) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[109 (1586537123804086272)]} 0 0
   [junit4]   2> 209895 INFO  (qtp18859287-2161) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[109 (1586537123805134848)]} 0 0
   [junit4]   2> 209896 INFO  (qtp23273507-2142) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[110 (1586537123806183424)]} 0 0
   [junit4]   2> 209896 INFO  (qtp18859287-2161) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[110 (1586537123807232000)]} 0 0
   [junit4]   2> 209897 INFO  (qtp23273507-2149) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[111 (1586537123808280576)]} 0 0
   [junit4]   2> 209898 INFO  (qtp18859287-2169) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[111 (1586537123809329152)]} 0 0
   [junit4]   2> 209899 INFO  (qtp23273507-2145) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[112 (1586537123810377728)]} 0 0
   [junit4]   2> 209900 INFO  (qtp18859287-2164) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[112 (1586537123811426304)]} 0 0
   [junit4]   2> 209901 INFO  (qtp23273507-2146) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[113 (1586537123811426304)]} 0 0
   [junit4]   2> 209901 INFO  (qtp18859287-2163) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[113 (1586537123812474880)]} 0 0
   [junit4]   2> 209902 INFO  (qtp23273507-2139) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[114 (1586537123813523456)]} 0 0
   [junit4]   2> 209903 INFO  (qtp18859287-2165) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[114 (1586537123814572032)]} 0 0
   [junit4]   2> 209904 INFO  (qtp23273507-2139) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[115 (1586537123815620608)]} 0 0
   [junit4]   2> 209905 INFO  (qtp18859287-2159) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[115 (1586537123816669184)]} 0 0
   [junit4]   2> 209906 INFO  (qtp23273507-2141) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[116 (1586537123817717760)]} 0 0
   [junit4]   2> 209907 INFO  (qtp18859287-2170) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[116 (1586537123818766336)]} 0 0
   [junit4]   2> 209908 INFO  (qtp23273507-2143) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[117 (1586537123818766336)]} 0 0
   [junit4]   2> 209909 INFO  (qtp18859287-2168) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[117 (1586537123819814912)]} 0 0
   [junit4]   2> 209910 INFO  (qtp23273507-2143) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[118 (1586537123820863488)]} 0 0
   [junit4]   2> 209910 INFO  (qtp18859287-2168) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[118 (1586537123821912064)]} 0 0
   [junit4]   2> 209911 INFO  (qtp23273507-2142) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[119 (1586537123822960640)]} 0 0
   [junit4]   2> 209912 INFO  (qtp18859287-2161) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[119 (1586537123824009216)]} 0 0
   [junit4]   2> 209913 INFO  (qtp23273507-2149) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[120 (1586537123825057792)]} 0 0
   [junit4]   2> 209914 INFO  (qtp18859287-2169) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[120 (1586537123825057792)]} 0 0
   [junit4]   2> 209915 INFO  (qtp23273507-2145) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[121 (1586537123826106368)]} 0 0
   [junit4]   2> 209915 INFO  (qtp18859287-2164) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[121 (1586537123827154944)]} 0 0
   [junit4]   2> 209916 INFO  (qtp23273507-2146) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[122 (1586537123828203520)]} 0 0
   [junit4]   2> 209917 INFO  (qtp18859287-2163) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[122 (1586537123829252096)]} 0 0
   [junit4]   2> 209918 INFO  (qtp23273507-2144) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[123 (1586537123830300672)]} 0 0
   [junit4]   2> 209919 INFO  (qtp18859287-2165) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[123 (1586537123831349248)]} 0 0
   [junit4]   2> 209920 INFO  (qtp23273507-2139) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[124 (1586537123832397824)]} 0 0
   [junit4]   2> 209921 INFO  (qtp18859287-2159) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[124 (1586537123833446400)]} 0 0
   [junit4]   2> 209922 INFO  (qtp23273507-2141) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[125 (1586537123834494976)]} 0 0
   [junit4]   2> 209923 INFO  (qtp18859287-2170) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[125 (1586537123835543552)]} 0 0
   [junit4]   2> 209924 INFO  (qtp23273507-2150) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[126 (1586537123836592128)]} 0 0
   [junit4]   2> 209925 INFO  (qtp18859287-2166) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[126 (1586537123837640704)]} 0 0
   [junit4]   2> 209926 INFO  (qtp23273507-2143) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[127 (1586537123838689280)]} 0 0
   [junit4]   2> 209927 INFO  (qtp18859287-2168) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[127 (1586537123839737856)]} 0 0
   [junit4]   2> 209929 INFO  (qtp23273507-2142) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[128 (1586537123840786432)]} 0 0
   [junit4]   2> 209930 INFO  (qtp18859287-2161) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[128 (1586537123841835008)]} 0 0
   [junit4]   2> 209931 INFO  (qtp23273507-2149) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[129 (1586537123842883584)]} 0 0
   [junit4]   2> 209931 INFO  (qtp18859287-2161) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[129 (1586537123843932160)]} 0 0
   [junit4]   2> 209933 INFO  (qtp23273507-2149) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[130 (1586537123846029312)]} 0 0
   [junit4]   2> 209933 INFO  (qtp18859287-2161) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[130 (1586537123846029312)]} 0 0
   [junit4]   2> 209934 INFO  (qtp23273507-2149) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[131 (1586537123847077888)]} 0 0
   [junit4]   2> 209935 INFO  (qtp18859287-2161) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[131 (1586537123847077888)]} 0 0
   [junit4]   2> 209936 INFO  (qtp23273507-2149) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[132 (1586537123848126464)]} 0 0
   [junit4]   2> 209937 INFO  (qtp18859287-2165) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[132 (1586537123849175040)]} 0 0
   [junit4]   2> 209938 INFO  (qtp23273507-2149) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[133 (1586537123850223616)]} 0 0
   [junit4]   2> 209939 INFO  (qtp18859287-2159) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[133 (1586537123852320768)]} 0 0
   [junit4]   2> 209940 INFO  (qtp23273507-2141) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[134 (1586537123853369344)]} 0 0
   [junit4]   2> 209941 INFO  (qtp18859287-2170) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[134 (1586537123854417920)]} 0 0
   [junit4]   2> 209942 INFO  (qtp23273507-2150) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[135 (1586537123855466496)]} 0 0
   [junit4]   2> 209943 INFO  (qtp18859287-2166) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[135 (1586537123856515072)]} 0 0
   [junit4]   2> 209944 INFO  (qtp23273507-2143) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[136 (1586537123856515072)]} 0 0
   [junit4]   2> 209944 INFO  (qtp18859287-2168) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[136 (1586537123857563648)]} 0 0
   [junit4]   2> 209945 INFO  (qtp23273507-2142) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[137 (1586537123858612224)]} 0 0
   [junit4]   2> 209946 INFO  (qtp18859287-2169) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[137 (1586537123859660800)]} 0 0
   [junit4]   2> 209946 INFO  (qtp23273507-2145) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[138 (1586537123859660800)]} 0 0
   [junit4]   2> 209947 INFO  (qtp18859287-2164) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[138 (1586537123860709376)]} 0 0
   [junit4]   2> 209948 INFO  (qtp23273507-2145) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[139 (1586537123861757952)]} 0 0
   [junit4]   2> 209949 INFO  (qtp18859287-2163) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[139 (1586537123861757952)]} 0 0
   [junit4]   2> 209949 INFO  (qtp23273507-2144) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[140 (1586537123862806528)]} 0 0
   [junit4]   2> 209950 INFO  (qtp18859287-2161) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[140 (1586537123863855104)]} 0 0
   [junit4]   2> 209951 INFO  (qtp23273507-2139) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[141 (1586537123864903680)]} 0 0
   [junit4]   2> 209952 INFO  (qtp18859287-2165) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[141 (1586537123865952256)]} 0 0
   [junit4]   2> 209953 INFO  (qtp23273507-2149) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[142 (1586537123867000832)]} 0 0
   [junit4]   2> 209954 INFO  (qtp18859287-2165) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[142 (1586537123867000832)]} 0 0
   [junit4]   2> 209955 INFO  (qtp23273507-2149) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[143 (1586537123868049408)]} 0 0
   [junit4]   2> 209955 INFO  (qtp18859287-2170) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[143 (1586537123869097984)]} 0 0
   [junit4]   2> 209956 INFO  (qtp23273507-2150) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[144 (1586537123870146560)]} 0 0
   [junit4]   2> 209957 INFO  (qtp18859287-2166) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[144 (1586537123871195136)]} 0 0
   [junit4]   2> 209958 INFO  (qtp23273507-2143) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[145 (1586537123872243712)]} 0 0
   [junit4]   2> 209959 INFO  (qtp18859287-2168) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[145 (1586537123872243712)]} 0 0
   [junit4]   2> 209959 INFO  (qtp23273507-2142) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[146 (1586537123873292288)]} 0 0
   [junit4]   2> 209960 INFO  (qtp18859287-2169) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[146 (1586537123874340864)]} 0 0
   [junit4]   2> 209961 INFO  (qtp23273507-2146) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[147 (1586537123874340864)]} 0 0
   [junit4]   2> 209961 INFO  (qtp18859287-2164) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[147 (1586537123875389440)]} 0 0
   [junit4]   2> 209962 INFO  (qtp23273507-2146) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[148 (1586537123876438016)]} 0 0
   [junit4]   2> 209963 INFO  (qtp18859287-2163) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[148 (1586537123877486592)]} 0 0
   [junit4]   2> 209964 INFO  (qtp23273507-2144) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[149 (1586537123878535168)]} 0 0
   [junit4]   2> 209965 INFO  (qtp18859287-2161) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[149 (1586537123879583744)]} 0 0
   [junit4]   2> 209966 INFO  (qtp23273507-2139) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[500 (1586537123879583744)]} 0 0
   [junit4]   2> 209966 INFO  (qtp18859287-2159) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[500 (1586537123880632320)]} 0 0
   [junit4]   2> 209967 INFO  (qtp23273507-2141) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[501 (1586537123881680896)]} 0 0
   [junit4]   2> 209968 INFO  (qtp18859287-2165) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[501 (1586537123882729472)]} 0 0
   [junit4]   2> 209969 INFO  (qtp23273507-2149) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[502 (1586537123882729472)]} 0 0
   [junit4]   2> 209969 INFO  (qtp18859287-2170) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[502 (1586537123883778048)]} 0 0
   [junit4]   2> 209970 INFO  (qtp23273507-2150) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[503 (1586537123884826624)]} 0 0
   [junit4]   2> 209971 INFO  (qtp18859287-2166) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[503 (1586537123884826624)]} 0 0
   [junit4]   2> 209984 INFO  (qtp23273507-2143) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[504 (1586537123899506688)]} 0 13
   [junit4]   2> 209985 INFO  (qtp18859287-2166) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[504 (1586537123900555264)]} 0 0
   [junit4]   2> 209986 INFO  (qtp23273507-2143) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[505 (1586537123901603840)]} 0 0
   [junit4]   2> 209987 INFO  (qtp18859287-2169) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[505 (1586537123902652416)]} 0 0
   [junit4]   2> 209988 INFO  (qtp23273507-2145) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[506 (1586537123903700992)]} 0 0
   [junit4]   2> 209988 INFO  (qtp18859287-2164) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[506 (1586537123903700992)]} 0 0
   [junit4]   2> 209989 INFO  (qtp23273507-2146) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[507 (1586537123904749568)]} 0 0
   [junit4]   2> 209990 INFO  (qtp18859287-2163) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[507 (1586537123905798144)]} 0 0
   [junit4]   2> 209990 INFO  (qtp23273507-2144) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[508 (1586537123905798144)]} 0 0
   [junit4]   2> 209991 INFO  (qtp18859287-2161) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[508 (1586537123906846720)]} 0 0
   [junit4]   2> 209992 INFO  (qtp23273507-2139) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[509 (1586537123906846720)]} 0 0
   [junit4]   2> 209992 INFO  (qtp18859287-2159) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[509 (1586537123907895296)]} 0 0
   [junit4]   2> 209993 INFO  (qtp23273507-2141) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[510 (1586537123908943872)]} 0 0
   [junit4]   2> 209994 INFO  (qtp18859287-2165) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[510 (1586537123909992448)]} 0 0
   [junit4]   2> 209994 INFO  (qtp23273507-2149) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[511 (1586537123909992448)]} 0 0
   [junit4]   2> 209995 INFO  (qtp18859287-2170) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[511 (1586537123911041024)]} 0 0
   [junit4]   2> 209996 INFO  (qtp23273507-2150) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[512 (1586537123912089600)]} 0 0
   [junit4]   2> 209996 INFO  (qtp18859287-2168) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[512 (1586537123912089600)]} 0 0
   [junit4]   2> 209997 INFO  (qtp23273507-2142) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[513 (1586537123913138176)]} 0 0
   [junit4]   2> 209997 INFO  (qtp18859287-2166) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[513 (1586537123913138176)]} 0 0
   [junit4]   2> 209998 INFO  (qtp23273507-2143) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[514 (1586537123914186752)]} 0 0
   [junit4]   2> 209999 INFO  (qtp18859287-2169) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[514 (1586537123915235328)]} 0 0
   [junit4]   2> 209999 INFO  (qtp23273507-2145) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[515 (1586537123915235328)]} 0 0
   [junit4]   2> 210000 INFO  (qtp18859287-2164) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[515 (1586537123916283904)]} 0 0
   [junit4]   2> 210001 INFO  (qtp23273507-2146) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[516 (1586537123916283904)]} 0 0
   [junit4]   2> 210001 INFO  (qtp18859287-2163) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[516 (1586537123917332480)]} 0 0
   [junit4]   2> 210002 INFO  (qtp23273507-2144) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[517 (1586537123918381056)]} 0 0
   [junit4]   2> 210002 INFO  (qtp18859287-2161) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[517 (1586537123918381056)]} 0 0
   [junit4]   2> 210003 INFO  (qtp23273507-2139) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[518 (1586537123919429632)]} 0 0
   [junit4]   2> 210004 INFO  (qtp18859287-2159) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[518 (1586537123919429632)]} 0 0
   [junit4]   2> 210004 INFO  (qtp23273507-2141) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[519 (1586537123920478208)]} 0 0
   [junit4]   2> 210005 INFO  (qtp18859287-2165) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[519 (1586537123921526784)]} 0 0
   [junit4]   2> 210005 INFO  (qtp23273507-2149) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[520 (1586537123921526784)]} 0 0
   [junit4]   2> 210006 INFO  (qtp18859287-2170) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[520 (1586537123922575360)]} 0 0
   [junit4]   2> 210006 INFO  (qtp23273507-2150) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[521 (1586537123922575360)]} 0 0
   [junit4]   2> 210007 INFO  (qtp18859287-2168) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[521 (1586537123923623936)]} 0 0
   [junit4]   2> 210007 INFO  (qtp23273507-2142) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[522 (1586537123923623936)]} 0 0
   [junit4]   2> 210008 INFO  (qtp18859287-2166) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[522 (1586537123924672512)]} 0 0
   [junit4]   2> 210008 INFO  (qtp23273507-2143) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[523 (1586537123924672512)]} 0 0
   [junit4]   2> 210009 INFO  (qtp18859287-2169) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[523 (1586537123925721088)]} 0 0
   [junit4]   2> 210010 INFO  (qtp23273507-2145) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[524 (1586537123925721088)]} 0 0
   [junit4]   2> 210010 INFO  (qtp18859287-2164) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[524 (1586537123926769664)]} 0 0
   [junit4]   2> 210011 INFO  (qtp23273507-2146) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[525 (1586537123927818240)]} 0 0
   [junit4]   2> 210011 INFO  (qtp18859287-2163) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[525 (1586537123927818240)]} 0 0
   [junit4]   2> 210012 INFO  (qtp23273507-2144) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[526 (1586537123928866816)]} 0 0
   [junit4]   2> 210012 INFO  (qtp18859287-2161) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[526 (1586537123928866816)]} 0 0
   [junit4]   2> 210013 INFO  (qtp23273507-2139) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[527 (1586537123929915392)]} 0 0
   [junit4]   2> 210013 INFO  (qtp18859287-2159) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[527 (1586537123929915392)]} 0 0
   [junit4]   2> 210014 INFO  (qtp23273507-2141) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[528 (1586537123930963968)]} 0 0
   [junit4]   2> 210015 INFO  (qtp18859287-2165) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[528 (1586537123930963968)]} 0 0
   [junit4]   2> 210015 INFO  (qtp23273507-2149) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[529 (1586537123932012544)]} 0 0
   [junit4]   2> 210015 INFO  (qtp18859287-2170) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[529 (1586537123932012544)]} 0 0
   [junit4]   2> 210016 INFO  (qtp23273507-2150) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[530 (1586537123933061120)]} 0 0
   [junit4]   2> 210017 INFO  (qtp18859287-2168) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[530 (1586537123933061120)]} 0 0
   [junit4]   2> 210017 INFO  (qtp23273507-2142) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[531 (1586537123934109696)]} 0 0
   [junit4]   2> 210018 INFO  (qtp18859287-2166) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[531 (1586537123935158272)]} 0 0
   [junit4]   2> 210018 INFO  (qtp23273507-2143) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[532 (1586537123935158272)]} 0 0
   [junit4]   2> 210019 INFO  (qtp18859287-2169) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[532 (1586537123936206848)]} 0 0
   [junit4]   2> 210019 INFO  (qtp23273507-2145) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[533 (1586537123936206848)]} 0 0
   [junit4]   2> 210020 INFO  (qtp18859287-2164) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[533 (1586537123937255424)]} 0 0
   [junit4]   2> 210020 INFO  (qtp23273507-2146) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[534 (1586537123937255424)]} 0 0
   [junit4]   2> 210021 INFO  (qtp18859287-2163) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[534 (1586537123938304000)]} 0 0
   [junit4]   2> 210021 INFO  (qtp23273507-2144) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[535 (1586537123938304000)]} 0 0
   [junit4]   2> 210022 INFO  (qtp18859287-2161) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[535 (1586537123939352576)]} 0 0
   [junit4]   2> 210022 INFO  (qtp23273507-2139) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[536 (1586537123939352576)]} 0 0
   [junit4]   2> 210023 INFO  (qtp18859287-2159) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[536 (1586537123940401152)]} 0 0
   [junit4]   2> 210024 INFO  (qtp23273507-2141) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[537 (1586537123940401152)]} 0 0
   [junit4]   2> 210024 INFO  (qtp18859287-2165) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[537 (1586537123941449728)]} 0 0
   [junit4]   2> 210025 INFO  (qtp23273507-2149) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[538 (1586537123941449728)]} 0 0
   [junit4]   2> 210025 INFO  (qtp18859287-2170) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[538 (1586537123942498304)]} 0 0
   [junit4]   2> 210026 INFO  (qtp23273507-2150) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[539 (1586537123942498304)]} 0 0
   [junit4]   2> 210026 INFO  (qtp18859287-2168) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[539 (1586537123943546880)]} 0 0
   [junit4]   2> 210027 INFO  (qtp23273507-2142) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[540 (1586537123943546880)]} 0 0
   [junit4]   2> 210027 INFO  (qtp18859287-2166) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[540 (1586537123944595456)]} 0 0
   [junit4]   2> 210028 INFO  (qtp23273507-2143) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[541 (1586537123944595456)]} 0 0
   [junit4]   2> 210028 INFO  (qtp18859287-2169) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[541 (1586537123945644032)]} 0 0
   [junit4]   2> 210029 INFO  (qtp23273507-2145) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update params={wt=javabin&version=2}{add=[542 (1586537123946692608)]} 0 0
   [junit4]   2> 210030 INFO  (qtp18859

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

ame = null, domain = solr.core.collection1.shard1.replica_n95, service url = null, agent id = null] for registry solr.core.collection1.shard1.replica_n95 / com.codahale.metrics.MetricRegistry@5709a4
   [junit4]   2> 1523617 INFO  (zkCallback-6658-thread-1-processing-n:127.0.0.1:64296_) [n:127.0.0.1:64296_ c:collection1 s:shard1 r:core_node96 x:collection1_shard1_replica_n95] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.collection1.shard1.leader, tag=12984979
   [junit4]   2> 1523617 INFO  (zkCallback-6658-thread-1-processing-n:127.0.0.1:64296_) [n:127.0.0.1:64296_ c:collection1 s:shard1 r:core_node96 x:collection1_shard1_replica_n95] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
   [junit4]   2> 1523617 INFO  (zkCallback-6658-thread-1-processing-n:127.0.0.1:64296_) [n:127.0.0.1:64296_ c:collection1 s:shard1 r:core_node96 x:collection1_shard1_replica_n95] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4ba186 commitCommandVersion:0
   [junit4]   2> 1523632 INFO  (TEST-ShardRoutingTest.test-seed#[81D4D968453127E1]) [    ] o.e.j.s.AbstractConnector Stopped ServerConnector@156911b{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1523632 INFO  (TEST-ShardRoutingTest.test-seed#[81D4D968453127E1]) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@a5a77d{/,null,UNAVAILABLE}
   [junit4]   2> 1523636 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from client sessionid 0x160484560580006, likely client has closed socket
   [junit4]   2> 	at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
   [junit4]   2> 	at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 1523655 INFO  (TEST-ShardRoutingTest.test-seed#[81D4D968453127E1]) [    ] o.a.s.c.ChaosMonkey monkey: stop jetty! 64178
   [junit4]   2> 1523655 ERROR (TEST-ShardRoutingTest.test-seed#[81D4D968453127E1]) [    ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
   [junit4]   2> 1523657 INFO  (TEST-ShardRoutingTest.test-seed#[81D4D968453127E1]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:64171 64171
   [junit4]   2> 1523658 INFO  (Thread-3546) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:64171 64171
   [junit4]   2> 1523659 WARN  (Thread-3546) [    ] o.a.s.c.ZkTestServer Watch limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2> 	11	/solr/aliases.json
   [junit4]   2> 	9	/solr/security.json
   [junit4]   2> 	9	/solr/configs/conf1
   [junit4]   2> 	8	/solr/collections/collection1/state.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2> 	11	/solr/clusterprops.json
   [junit4]   2> 	11	/solr/clusterstate.json
   [junit4]   2> 	8	/solr/autoscaling.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2> 	11	/solr/live_nodes
   [junit4]   2> 	11	/solr/collections
   [junit4]   2> 	8	/solr/autoscaling/events/.auto_add_replicas
   [junit4]   2> 	8	/solr/overseer/collection-queue-work
   [junit4]   2> 	8	/solr/overseer/queue-work
   [junit4]   2> 	7	/solr/overseer/queue
   [junit4]   2> 
   [junit4]   2> 1523660 INFO  (SUITE-ShardRoutingTest-seed#[81D4D968453127E1]-worker) [    ] o.a.s.SolrTestCaseJ4 ------------------------------------------------------- Done waiting for tracked resources to be released
   [junit4]   2> NOTE: test params are: codec=CheapBastard, sim=RandomSimilarity(queryNorm=true): {}, locale=hi, timezone=Asia/Beirut
   [junit4]   2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_144 (32-bit)/cpus=3,threads=1,free=221599520,total=495005696
   [junit4]   2> NOTE: All tests run in this JVM: [TestLegacyFieldReuse, FacetPivotSmallTest, SuggesterTest, BooleanFieldTest, TestRTimerTree, TestCoreAdminApis, ClassificationUpdateProcessorFactoryTest, SyncSliceTest, TestEmbeddedSolrServerSchemaAPI, TestCustomSort, CollectionsAPISolrJTest, TestTrieFacet, TestConfigSetImmutable, ConnectionReuseTest, TestConfigSets, OverseerStatusTest, TestRecoveryHdfs, HdfsThreadLeakTest, TestHdfsUpdateLog, HdfsDirectoryFactoryTest, CdcrBidirectionalTest, PathHierarchyTokenizerFactoryTest, TestTolerantUpdateProcessorRandomCloud, TestSolrCloudWithDelegationTokens, TestPHPSerializedResponseWriter, TestLocalFSCloudBackupRestore, TestManagedStopFilterFactory, AtomicUpdateProcessorFactoryTest, TestScoreJoinQPScore, BasicAuthIntegrationTest, SaslZkACLProviderTest, TestOrdValues, TestSurroundQueryParser, CollectionTooManyReplicasTest, DistributedQueryComponentOptimizationTest, CoreAdminCreateDiscoverTest, XmlUpdateRequestHandlerTest, DistributedFacetPivotWhiteBoxTest, TestGraphMLResponseWriter, TestPivotHelperCode, TestStressInPlaceUpdates, TestCSVResponseWriter, CdcrReplicationDistributedZkTest, TestClassicSimilarityFactory, TestPayloadCheckQParserPlugin, TestRandomRequestDistribution, HdfsLockFactoryTest, TestCodecSupport, DefaultValueUpdateProcessorTest, HighlighterTest, RAMDirectoryFactoryTest, NodeLostTriggerTest, TestManagedSchemaAPI, OverriddenZkACLAndCredentialsProvidersTest, TestRandomDVFaceting, SortByFunctionTest, TestIntervalFaceting, RequestHandlersTest, OverseerTest, TestSolrConfigHandlerCloud, DirectUpdateHandlerOptimizeTest, DisMaxRequestHandlerTest, VMParamsZkACLAndCredentialsProvidersTest, TestCloudSchemaless, BufferStoreTest, ForceLeaderTest, TestExpandComponent, LeaderInitiatedRecoveryOnShardRestartTest, TestStandardQParsers, BlockCacheTest, TestCollectionAPI, TestRangeQuery, SolrXmlInZkTest, TestImpersonationWithHadoopAuth, TestJoin, PKIAuthenticationIntegrationTest, DeleteNodeTest, SolrRequestParserTest, TestComplexPhraseLeadingWildcard, TestSubQueryTransformer, SpatialHeatmapFacetsTest, TestLazyCores, DistributedSpellCheckComponentTest, TestHighlightDedupGrouping, MultiTermTest, TestSQLHandler, TolerantUpdateProcessorTest, TestWriterPerf, TestLegacyNumericRangeQueryBuilder, TestDistribIDF, AutoScalingHandlerTest, ImplicitSnitchTest, RemoteQueryErrorTest, BasicDistributedZkTest, TestRequestStatusCollectionAPI, AlternateDirectoryTest, TestQueryWrapperFilter, TestDownShardTolerantSearch, TestJsonFacets, SolrCLIZkUtilsTest, ClusterStateUpdateTest, OutputWriterTest, JavabinLoaderTest, TestSearcherReuse, TestJmxIntegration, UniqFieldsUpdateProcessorFactoryTest, AsyncCallRequestStatusResponseTest, TestInitParams, SliceStateTest, TestNestedDocsSort, StatsComponentTest, TestDistributedSearch, TestFieldTypeCollectionResource, TestRealTimeGet, HdfsChaosMonkeyNothingIsSafeTest, TestSegmentSorting, CircularListTest, SuggestComponentTest, TestCloudSearcherWarming, BlockJoinFacetRandomTest, ReturnFieldsTest, ParsingFieldUpdateProcessorsTest, TestFieldCacheSort, NumericFieldsTest, CdcrUpdateLogTest, SuggesterTSTTest, PeerSyncWithIndexFingerprintCachingTest, TestSerializedLuceneMatchVersion, XsltUpdateRequestHandlerTest, TestNumericTerms64, RecoveryZkTest, SharedFSAutoReplicaFailoverTest, MetricsHandlerTest, TestPushWriter, TestBulkSchemaConcurrent, TestPullReplicaErrorHandling, TestTolerantSearch, TestConfigSetsAPI, SolrShardReporterTest, ReplicationFactorTest, TestDFRSimilarityFactory, TestSolrCoreProperties, TestQuerySenderNoQuery, URLClassifyProcessorTest, JSONWriterTest, MinimalSchemaTest, ShardRoutingTest]
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=ShardRoutingTest -Dtests.seed=81D4D968453127E1 -Dtests.slow=true -Dtests.locale=hi -Dtests.timezone=Asia/Beirut -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.00s J0 | ShardRoutingTest (suite) <<<
   [junit4]    > Throwable #1: java.io.IOException: Could not remove the following files (in the order of attempts):
   [junit4]    >    C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest_81D4D968453127E1-001\shard-2-001\configsets\upload\dih-script-transformer: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest_81D4D968453127E1-001\shard-2-001\configsets\upload\dih-script-transformer
   [junit4]    >    C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest_81D4D968453127E1-001\shard-2-001\configsets\upload: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest_81D4D968453127E1-001\shard-2-001\configsets\upload
   [junit4]    >    C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest_81D4D968453127E1-001\shard-2-001\configsets: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest_81D4D968453127E1-001\shard-2-001\configsets
   [junit4]    >    C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest_81D4D968453127E1-001\shard-2-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest_81D4D968453127E1-001\shard-2-001
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([81D4D968453127E1]:0)
   [junit4]    > 	at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:748)
   [junit4] Completed [344/751 (2!)] on J0 in 28.04s, 1 test, 1 error <<< FAILURES!

[...truncated 44587 lines...]

Mime
View raw message