You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2017/01/27 21:40:41 UTC

[JENKINS] Lucene-Solr-6.x-Solaris (64bit/jdk1.8.0) - Build # 639 - Unstable!

Build: https://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Solaris/639/
Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseSerialGC

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

Error Message:
Expected to find shardAddress in the up shard info

Stack Trace:
java.lang.AssertionError: Expected to find shardAddress in the up shard info
	at __randomizedtesting.SeedInfo.seed([C556D21BFF9ABEAE:4D02EDC15166D356]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.assertTrue(Assert.java:43)
	at org.apache.solr.TestDistributedSearch.comparePartialResponses(TestDistributedSearch.java:1174)
	at org.apache.solr.TestDistributedSearch.queryPartialResults(TestDistributedSearch.java:1115)
	at org.apache.solr.TestDistributedSearch.test(TestDistributedSearch.java:975)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:498)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:1018)
	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
	at java.lang.Thread.run(Thread.java:745)


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

Error Message:
2 threads leaked from SUITE scope at org.apache.solr.cloud.TestSolrCloudWithSecureImpersonation:     1) Thread[id=23906, name=jetty-launcher-3940-thread-1-EventThread, state=TIMED_WAITING, group=TGRP-TestSolrCloudWithSecureImpersonation]         at sun.misc.Unsafe.park(Native Method)         at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)         at java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedNanos(AbstractQueuedSynchronizer.java:1037)         at java.util.concurrent.locks.AbstractQueuedSynchronizer.tryAcquireSharedNanos(AbstractQueuedSynchronizer.java:1328)         at java.util.concurrent.CountDownLatch.await(CountDownLatch.java:277)         at org.apache.curator.CuratorZookeeperClient.internalBlockUntilConnectedOrTimedOut(CuratorZookeeperClient.java:323)         at org.apache.curator.RetryLoop.callWithRetry(RetryLoop.java:105)         at org.apache.curator.framework.imps.GetDataBuilderImpl.pathInForeground(GetDataBuilderImpl.java:288)         at org.apache.curator.framework.imps.GetDataBuilderImpl.forPath(GetDataBuilderImpl.java:279)         at org.apache.curator.framework.imps.GetDataBuilderImpl.forPath(GetDataBuilderImpl.java:41)         at org.apache.curator.framework.recipes.shared.SharedValue.readValue(SharedValue.java:244)         at org.apache.curator.framework.recipes.shared.SharedValue.access$100(SharedValue.java:44)         at org.apache.curator.framework.recipes.shared.SharedValue$1.process(SharedValue.java:61)         at org.apache.curator.framework.imps.NamespaceWatcher.process(NamespaceWatcher.java:67)         at org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:522)         at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:498)    2) Thread[id=23912, name=jetty-launcher-3940-thread-2-EventThread, state=TIMED_WAITING, group=TGRP-TestSolrCloudWithSecureImpersonation]         at sun.misc.Unsafe.park(Native Method)         at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)         at java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedNanos(AbstractQueuedSynchronizer.java:1037)         at java.util.concurrent.locks.AbstractQueuedSynchronizer.tryAcquireSharedNanos(AbstractQueuedSynchronizer.java:1328)         at java.util.concurrent.CountDownLatch.await(CountDownLatch.java:277)         at org.apache.curator.CuratorZookeeperClient.internalBlockUntilConnectedOrTimedOut(CuratorZookeeperClient.java:323)         at org.apache.curator.RetryLoop.callWithRetry(RetryLoop.java:105)         at org.apache.curator.framework.imps.GetDataBuilderImpl.pathInForeground(GetDataBuilderImpl.java:288)         at org.apache.curator.framework.imps.GetDataBuilderImpl.forPath(GetDataBuilderImpl.java:279)         at org.apache.curator.framework.imps.GetDataBuilderImpl.forPath(GetDataBuilderImpl.java:41)         at org.apache.curator.framework.recipes.shared.SharedValue.readValue(SharedValue.java:244)         at org.apache.curator.framework.recipes.shared.SharedValue.access$100(SharedValue.java:44)         at org.apache.curator.framework.recipes.shared.SharedValue$1.process(SharedValue.java:61)         at org.apache.curator.framework.imps.NamespaceWatcher.process(NamespaceWatcher.java:67)         at org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:522)         at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:498)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 2 threads leaked from SUITE scope at org.apache.solr.cloud.TestSolrCloudWithSecureImpersonation: 
   1) Thread[id=23906, name=jetty-launcher-3940-thread-1-EventThread, state=TIMED_WAITING, group=TGRP-TestSolrCloudWithSecureImpersonation]
        at sun.misc.Unsafe.park(Native Method)
        at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedNanos(AbstractQueuedSynchronizer.java:1037)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer.tryAcquireSharedNanos(AbstractQueuedSynchronizer.java:1328)
        at java.util.concurrent.CountDownLatch.await(CountDownLatch.java:277)
        at org.apache.curator.CuratorZookeeperClient.internalBlockUntilConnectedOrTimedOut(CuratorZookeeperClient.java:323)
        at org.apache.curator.RetryLoop.callWithRetry(RetryLoop.java:105)
        at org.apache.curator.framework.imps.GetDataBuilderImpl.pathInForeground(GetDataBuilderImpl.java:288)
        at org.apache.curator.framework.imps.GetDataBuilderImpl.forPath(GetDataBuilderImpl.java:279)
        at org.apache.curator.framework.imps.GetDataBuilderImpl.forPath(GetDataBuilderImpl.java:41)
        at org.apache.curator.framework.recipes.shared.SharedValue.readValue(SharedValue.java:244)
        at org.apache.curator.framework.recipes.shared.SharedValue.access$100(SharedValue.java:44)
        at org.apache.curator.framework.recipes.shared.SharedValue$1.process(SharedValue.java:61)
        at org.apache.curator.framework.imps.NamespaceWatcher.process(NamespaceWatcher.java:67)
        at org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:522)
        at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:498)
   2) Thread[id=23912, name=jetty-launcher-3940-thread-2-EventThread, state=TIMED_WAITING, group=TGRP-TestSolrCloudWithSecureImpersonation]
        at sun.misc.Unsafe.park(Native Method)
        at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedNanos(AbstractQueuedSynchronizer.java:1037)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer.tryAcquireSharedNanos(AbstractQueuedSynchronizer.java:1328)
        at java.util.concurrent.CountDownLatch.await(CountDownLatch.java:277)
        at org.apache.curator.CuratorZookeeperClient.internalBlockUntilConnectedOrTimedOut(CuratorZookeeperClient.java:323)
        at org.apache.curator.RetryLoop.callWithRetry(RetryLoop.java:105)
        at org.apache.curator.framework.imps.GetDataBuilderImpl.pathInForeground(GetDataBuilderImpl.java:288)
        at org.apache.curator.framework.imps.GetDataBuilderImpl.forPath(GetDataBuilderImpl.java:279)
        at org.apache.curator.framework.imps.GetDataBuilderImpl.forPath(GetDataBuilderImpl.java:41)
        at org.apache.curator.framework.recipes.shared.SharedValue.readValue(SharedValue.java:244)
        at org.apache.curator.framework.recipes.shared.SharedValue.access$100(SharedValue.java:44)
        at org.apache.curator.framework.recipes.shared.SharedValue$1.process(SharedValue.java:61)
        at org.apache.curator.framework.imps.NamespaceWatcher.process(NamespaceWatcher.java:67)
        at org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:522)
        at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:498)
	at __randomizedtesting.SeedInfo.seed([C556D21BFF9ABEAE]:0)


FAILED:  junit.framework.TestSuite.org.apache.solr.uninverting.TestNumericTerms64

Error Message:
The test or suite printed 8944 bytes to stdout and stderr, even though the limit was set to 8192 bytes. Increase the limit with @Limit, ignore it completely with @SuppressSysoutChecks or run with -Dtests.verbose=true

Stack Trace:
java.lang.AssertionError: The test or suite printed 8944 bytes to stdout and stderr, even though the limit was set to 8192 bytes. Increase the limit with @Limit, ignore it completely with @SuppressSysoutChecks or run with -Dtests.verbose=true
	at __randomizedtesting.SeedInfo.seed([C556D21BFF9ABEAE]:0)
	at org.apache.lucene.util.TestRuleLimitSysouts.afterIfSuccessful(TestRuleLimitSysouts.java:211)
	at com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterIfSuccessful(TestRuleAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:37)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
	at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 11446 lines...]
   [junit4] Suite: org.apache.solr.TestDistributedSearch
   [junit4]   2> Creating dataDir: /export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_C556D21BFF9ABEAE-001/init-core-data-001
   [junit4]   2> 865753 INFO  (SUITE-TestDistributedSearch-seed#[C556D21BFF9ABEAE]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=https://issues.apache.org/jira/browse/SOLR-9061)
   [junit4]   2> 865754 INFO  (SUITE-TestDistributedSearch-seed#[C556D21BFF9ABEAE]-worker) [    ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /li_jlu/x
   [junit4]   2> 865917 INFO  (TEST-TestDistributedSearch.test-seed#[C556D21BFF9ABEAE]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_C556D21BFF9ABEAE-001/tempDir-001/control/cores/collection1
   [junit4]   2> 865918 INFO  (TEST-TestDistributedSearch.test-seed#[C556D21BFF9ABEAE]) [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 865919 INFO  (TEST-TestDistributedSearch.test-seed#[C556D21BFF9ABEAE]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2cbe1724{/li_jlu/x,null,AVAILABLE}
   [junit4]   2> 865920 INFO  (TEST-TestDistributedSearch.test-seed#[C556D21BFF9ABEAE]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@fda126c{HTTP/1.1,[http/1.1]}{127.0.0.1:41874}
   [junit4]   2> 865920 INFO  (TEST-TestDistributedSearch.test-seed#[C556D21BFF9ABEAE]) [    ] o.e.j.s.Server Started @868751ms
   [junit4]   2> 865920 INFO  (TEST-TestDistributedSearch.test-seed#[C556D21BFF9ABEAE]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/li_jlu/x, hostPort=41874, coreRootDirectory=/export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_C556D21BFF9ABEAE-001/tempDir-001/control/cores}
   [junit4]   2> 865920 ERROR (TEST-TestDistributedSearch.test-seed#[C556D21BFF9ABEAE]) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 865920 INFO  (TEST-TestDistributedSearch.test-seed#[C556D21BFF9ABEAE]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 6.5.0
   [junit4]   2> 865920 INFO  (TEST-TestDistributedSearch.test-seed#[C556D21BFF9ABEAE]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 865922 INFO  (TEST-TestDistributedSearch.test-seed#[C556D21BFF9ABEAE]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 865922 INFO  (TEST-TestDistributedSearch.test-seed#[C556D21BFF9ABEAE]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2017-01-27T20:41:02.603Z
   [junit4]   2> 865922 INFO  (TEST-TestDistributedSearch.test-seed#[C556D21BFF9ABEAE]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_C556D21BFF9ABEAE-001/tempDir-001/control/solr.xml
   [junit4]   2> 865930 INFO  (TEST-TestDistributedSearch.test-seed#[C556D21BFF9ABEAE]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 865937 INFO  (TEST-TestDistributedSearch.test-seed#[C556D21BFF9ABEAE]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_C556D21BFF9ABEAE-001/tempDir-001/control/cores
   [junit4]   2> 865937 INFO  (TEST-TestDistributedSearch.test-seed#[C556D21BFF9ABEAE]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 865938 INFO  (coreLoadExecutor-4658-thread-1) [    x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 866096 INFO  (coreLoadExecutor-4658-thread-1) [    x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.5.0
   [junit4]   2> 866116 INFO  (coreLoadExecutor-4658-thread-1) [    x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 866220 WARN  (coreLoadExecutor-4658-thread-1) [    x:collection1] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 866222 INFO  (coreLoadExecutor-4658-thread-1) [    x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 866234 INFO  (coreLoadExecutor-4658-thread-1) [    x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/core/src/test-files/solr/collection1
   [junit4]   2> 866234 INFO  (coreLoadExecutor-4658-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/core/src/test-files/solr/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_C556D21BFF9ABEAE-001/tempDir-001/control/cores/collection1/data/]
   [junit4]   2> 866234 INFO  (coreLoadExecutor-4658-thread-1) [    x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@65baa79a
   [junit4]   2> 866245 INFO  (coreLoadExecutor-4658-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1309842640, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
   [junit4]   2> 866274 INFO  (coreLoadExecutor-4658-thread-1) [    x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 866274 INFO  (coreLoadExecutor-4658-thread-1) [    x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 866278 INFO  (coreLoadExecutor-4658-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 866278 INFO  (coreLoadExecutor-4658-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 866279 INFO  (coreLoadExecutor-4658-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=22, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=49.6376953125, floorSegmentMB=0.9169921875, forceMergeDeletesPctAllowed=1.6136183279454475, segmentsPerTier=43.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 866280 INFO  (coreLoadExecutor-4658-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6426f4b1[collection1] main]
   [junit4]   2> 866280 INFO  (coreLoadExecutor-4658-thread-1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 866287 INFO  (coreLoadExecutor-4658-thread-1) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 866306 INFO  (coreLoadExecutor-4658-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 866307 INFO  (searcherExecutor-4659-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 866307 INFO  (searcherExecutor-4659-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 866307 INFO  (searcherExecutor-4659-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 866308 INFO  (searcherExecutor-4659-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 866308 INFO  (searcherExecutor-4659-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 866308 INFO  (searcherExecutor-4659-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 866309 INFO  (searcherExecutor-4659-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 866309 INFO  (searcherExecutor-4659-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 866309 INFO  (searcherExecutor-4659-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 866315 INFO  (searcherExecutor-4659-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6426f4b1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 866315 INFO  (coreLoadExecutor-4658-thread-1) [    x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1557711723425693696
   [junit4]   2> 866703 INFO  (TEST-TestDistributedSearch.test-seed#[C556D21BFF9ABEAE]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_C556D21BFF9ABEAE-001/tempDir-001/shard0/cores/collection1
   [junit4]   2> 866704 INFO  (TEST-TestDistributedSearch.test-seed#[C556D21BFF9ABEAE]) [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 866705 INFO  (TEST-TestDistributedSearch.test-seed#[C556D21BFF9ABEAE]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@df3148a{/li_jlu/x,null,AVAILABLE}
   [junit4]   2> 866706 INFO  (TEST-TestDistributedSearch.test-seed#[C556D21BFF9ABEAE]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@52770528{HTTP/1.1,[http/1.1]}{127.0.0.1:37487}
   [junit4]   2> 866706 INFO  (TEST-TestDistributedSearch.test-seed#[C556D21BFF9ABEAE]) [    ] o.e.j.s.Server Started @869537ms
   [junit4]   2> 866706 INFO  (TEST-TestDistributedSearch.test-seed#[C556D21BFF9ABEAE]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/li_jlu/x, hostPort=37487, coreRootDirectory=/export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_C556D21BFF9ABEAE-001/tempDir-001/shard0/cores}
   [junit4]   2> 866706 ERROR (TEST-TestDistributedSearch.test-seed#[C556D21BFF9ABEAE]) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 866707 INFO  (TEST-TestDistributedSearch.test-seed#[C556D21BFF9ABEAE]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 6.5.0
   [junit4]   2> 866707 INFO  (TEST-TestDistributedSearch.test-seed#[C556D21BFF9ABEAE]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 866707 INFO  (TEST-TestDistributedSearch.test-seed#[C556D21BFF9ABEAE]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 866707 INFO  (TEST-TestDistributedSearch.test-seed#[C556D21BFF9ABEAE]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2017-01-27T20:41:03.388Z
   [junit4]   2> 866707 INFO  (TEST-TestDistributedSearch.test-seed#[C556D21BFF9ABEAE]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_C556D21BFF9ABEAE-001/tempDir-001/shard0/solr.xml
   [junit4]   2> 866714 INFO  (TEST-TestDistributedSearch.test-seed#[C556D21BFF9ABEAE]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 866717 INFO  (TEST-TestDistributedSearch.test-seed#[C556D21BFF9ABEAE]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_C556D21BFF9ABEAE-001/tempDir-001/shard0/cores
   [junit4]   2> 866717 INFO  (TEST-TestDistributedSearch.test-seed#[C556D21BFF9ABEAE]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 866718 INFO  (coreLoadExecutor-4669-thread-1) [    x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 866754 INFO  (coreLoadExecutor-4669-thread-1) [    x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.5.0
   [junit4]   2> 866871 INFO  (coreLoadExecutor-4669-thread-1) [    x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 866981 WARN  (coreLoadExecutor-4669-thread-1) [    x:collection1] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 866984 INFO  (coreLoadExecutor-4669-thread-1) [    x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 866991 INFO  (coreLoadExecutor-4669-thread-1) [    x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/core/src/test-files/solr/collection1
   [junit4]   2> 866991 INFO  (coreLoadExecutor-4669-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/core/src/test-files/solr/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_C556D21BFF9ABEAE-001/tempDir-001/shard0/cores/collection1/data/]
   [junit4]   2> 866991 INFO  (coreLoadExecutor-4669-thread-1) [    x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@65baa79a
   [junit4]   2> 867004 INFO  (coreLoadExecutor-4669-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1309842640, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
   [junit4]   2> 867032 INFO  (coreLoadExecutor-4669-thread-1) [    x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 867032 INFO  (coreLoadExecutor-4669-thread-1) [    x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 867033 INFO  (coreLoadExecutor-4669-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 867033 INFO  (coreLoadExecutor-4669-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 867034 INFO  (coreLoadExecutor-4669-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=22, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=49.6376953125, floorSegmentMB=0.9169921875, forceMergeDeletesPctAllowed=1.6136183279454475, segmentsPerTier=43.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 867034 INFO  (coreLoadExecutor-4669-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@446bd8b5[collection1] main]
   [junit4]   2> 867035 INFO  (coreLoadExecutor-4669-thread-1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 867038 INFO  (coreLoadExecutor-4669-thread-1) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 867053 INFO  (coreLoadExecutor-4669-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 867054 INFO  (searcherExecutor-4670-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 867054 INFO  (searcherExecutor-4670-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 867054 INFO  (searcherExecutor-4670-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 867054 INFO  (searcherExecutor-4670-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 867054 INFO  (searcherExecutor-4670-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 867055 INFO  (searcherExecutor-4670-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 867055 INFO  (coreLoadExecutor-4669-thread-1) [    x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1557711724201639936
   [junit4]   2> 867055 INFO  (searcherExecutor-4670-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 867056 INFO  (searcherExecutor-4670-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 867056 INFO  (searcherExecutor-4670-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 867057 INFO  (searcherExecutor-4670-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@446bd8b5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 867587 INFO  (TEST-TestDistributedSearch.test-seed#[C556D21BFF9ABEAE]) [    ] o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 867591 INFO  (qtp818021416-10921) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1557711724762628096)} 0 1
   [junit4]   2> 867615 INFO  (qtp931078345-10939) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1557711724786745344)} 0 1
   [junit4]   2> 867620 INFO  (qtp818021416-10922) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[1 (1557711724791988224)]} 0 1
   [junit4]   2> 867633 INFO  (qtp931078345-10938) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[1 (1557711724806668288)]} 0 1
   [junit4]   2> 867635 INFO  (qtp818021416-10923) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[2 (1557711724809814016)]} 0 0
   [junit4]   2> 867642 INFO  (qtp931078345-10941) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[2 (1557711724816105472)]} 0 0
   [junit4]   2> 867644 INFO  (qtp818021416-10924) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[3 (1557711724819251200)]} 0 0
   [junit4]   2> 867647 INFO  (qtp931078345-10942) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[3 (1557711724821348352)]} 0 0
   [junit4]   2> 867650 INFO  (qtp818021416-10925) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[4 (1557711724824494080)]} 0 0
   [junit4]   2> 867652 INFO  (qtp931078345-10943) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[4 (1557711724827639808)]} 0 0
   [junit4]   2> 867654 INFO  (qtp818021416-10926) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[5 (1557711724829736960)]} 0 0
   [junit4]   2> 867657 INFO  (qtp931078345-10940) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[5 (1557711724831834112)]} 0 0
   [junit4]   2> 867660 INFO  (qtp818021416-10919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[6 (1557711724834979840)]} 0 0
   [junit4]   2> 867662 INFO  (qtp931078345-10936) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[6 (1557711724838125568)]} 0 0
   [junit4]   2> 867664 INFO  (qtp818021416-10921) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[7 (1557711724840222720)]} 0 0
   [junit4]   2> 867666 INFO  (qtp931078345-10939) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[7 (1557711724842319872)]} 0 0
   [junit4]   2> 867669 INFO  (qtp818021416-10922) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[8 (1557711724844417024)]} 0 0
   [junit4]   2> 867671 INFO  (qtp931078345-10938) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[8 (1557711724846514176)]} 0 0
   [junit4]   2> 867673 INFO  (qtp818021416-10923) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[9 (1557711724849659904)]} 0 0
   [junit4]   2> 867675 INFO  (qtp931078345-10938) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[9 (1557711724850708480)]} 0 0
   [junit4]   2> 867676 INFO  (qtp818021416-10924) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 867676 INFO  (qtp818021416-10924) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@648f3472
   [junit4]   2> 867704 INFO  (qtp818021416-10924) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@426b0b9a[collection1] main]
   [junit4]   2> 867704 INFO  (qtp818021416-10924) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 867705 INFO  (searcherExecutor-4659-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@426b0b9a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.5.0):c9)))}
   [junit4]   2> 867707 INFO  (qtp818021416-10924) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 30
   [junit4]   2> 867710 INFO  (qtp931078345-10942) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 867710 INFO  (qtp931078345-10942) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@2dd8b6d3
   [junit4]   2> 867735 INFO  (qtp931078345-10942) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@76c3018d[collection1] main]
   [junit4]   2> 867735 INFO  (qtp931078345-10942) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 867737 INFO  (searcherExecutor-4670-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@76c3018d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.5.0):c9)))}
   [junit4]   2> 867737 INFO  (qtp931078345-10942) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 27
   [junit4]   2> 867742 INFO  (qtp818021416-10925) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[10 (1557711724919914496)]} 0 2
   [junit4]   2> 867746 INFO  (qtp931078345-10943) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[10 (1557711724924108800)]} 0 2
   [junit4]   2> 867748 INFO  (qtp818021416-10926) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[11 (1557711724928303104)]} 0 0
   [junit4]   2> 867750 INFO  (qtp931078345-10940) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[11 (1557711724930400256)]} 0 0
   [junit4]   2> 867752 INFO  (qtp818021416-10919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[12 (1557711724932497408)]} 0 0
   [junit4]   2> 867755 INFO  (qtp931078345-10936) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[12 (1557711724935643136)]} 0 0
   [junit4]   2> 867757 INFO  (qtp818021416-10921) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[13 (1557711724937740288)]} 0 0
   [junit4]   2> 867759 INFO  (qtp931078345-10939) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[13 (1557711724939837440)]} 0 0
   [junit4]   2> 867762 INFO  (qtp818021416-10922) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[1001 (1557711724941934592)]} 0 0
   [junit4]   2> 867764 INFO  (qtp931078345-10941) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[1001 (1557711724944031744)]} 0 0
   [junit4]   2> 867766 INFO  (qtp818021416-10923) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[14 (1557711724946128896)]} 0 0
   [junit4]   2> 867768 INFO  (qtp931078345-10938) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[14 (1557711724948226048)]} 0 0
   [junit4]   2> 867770 INFO  (qtp818021416-10924) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[15 (1557711724950323200)]} 0 0
   [junit4]   2> 867771 INFO  (qtp931078345-10942) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[15 (1557711724952420352)]} 0 0
   [junit4]   2> 867773 INFO  (qtp818021416-10925) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[16 (1557711724954517504)]} 0 0
   [junit4]   2> 867777 INFO  (qtp931078345-10942) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[16 (1557711724957663232)]} 0 0
   [junit4]   2> 867779 INFO  (qtp818021416-10925) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[17 (1557711724959760384)]} 0 0
   [junit4]   2> 867782 INFO  (qtp931078345-10942) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[17 (1557711724963954688)]} 0 0
   [junit4]   2> 867784 INFO  (qtp818021416-10925) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[100 (1557711724966051840)]} 0 0
   [junit4]   2> 867786 INFO  (qtp931078345-10942) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[100 (1557711724968148992)]} 0 0
   [junit4]   2> 867788 INFO  (qtp818021416-10925) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[101 (1557711724969197568)]} 0 0
   [junit4]   2> 867789 INFO  (qtp931078345-10942) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[101 (1557711724971294720)]} 0 0
   [junit4]   2> 867828 INFO  (qtp818021416-10922) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[102 (1557711725012189184)]} 0 0
   [junit4]   2> 867830 INFO  (qtp931078345-10942) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[102 (1557711725014286336)]} 0 0
   [junit4]   2> 867832 INFO  (qtp818021416-10923) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[103 (1557711725016383488)]} 0 0
   [junit4]   2> 867834 INFO  (qtp931078345-10938) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[103 (1557711725018480640)]} 0 0
   [junit4]   2> 867836 INFO  (qtp818021416-10924) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[104 (1557711725020577792)]} 0 0
   [junit4]   2> 867838 INFO  (qtp931078345-10943) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[104 (1557711725022674944)]} 0 0
   [junit4]   2> 867840 INFO  (qtp818021416-10926) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[105 (1557711725024772096)]} 0 0
   [junit4]   2> 867843 INFO  (qtp931078345-10940) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[105 (1557711725026869248)]} 0 0
   [junit4]   2> 867844 INFO  (qtp818021416-10919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[106 (1557711725028966400)]} 0 0
   [junit4]   2> 867846 INFO  (qtp931078345-10936) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[106 (1557711725031063552)]} 0 0
   [junit4]   2> 867848 INFO  (qtp818021416-10921) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[107 (1557711725033160704)]} 0 0
   [junit4]   2> 867850 INFO  (qtp931078345-10939) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[107 (1557711725035257856)]} 0 0
   [junit4]   2> 867852 INFO  (qtp818021416-10925) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[108 (1557711725037355008)]} 0 0
   [junit4]   2> 867854 INFO  (qtp931078345-10941) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[108 (1557711725039452160)]} 0 0
   [junit4]   2> 867856 INFO  (qtp818021416-10925) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[109 (1557711725041549312)]} 0 0
   [junit4]   2> 867859 INFO  (qtp931078345-10941) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[109 (1557711725044695040)]} 0 0
   [junit4]   2> 867861 INFO  (qtp818021416-10923) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[110 (1557711725046792192)]} 0 0
   [junit4]   2> 867863 INFO  (qtp931078345-10938) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[110 (1557711725048889344)]} 0 0
   [junit4]   2> 867865 INFO  (qtp818021416-10924) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[111 (1557711725050986496)]} 0 0
   [junit4]   2> 867869 INFO  (qtp931078345-10943) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[111 (1557711725053083648)]} 0 2
   [junit4]   2> 867871 INFO  (qtp818021416-10926) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[112 (1557711725057277952)]} 0 0
   [junit4]   2> 867873 INFO  (qtp931078345-10940) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[112 (1557711725059375104)]} 0 0
   [junit4]   2> 867875 INFO  (qtp818021416-10919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[113 (1557711725061472256)]} 0 0
   [junit4]   2> 867877 INFO  (qtp931078345-10936) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[113 (1557711725062520832)]} 0 0
   [junit4]   2> 867878 INFO  (qtp818021416-10921) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[114 (1557711725064617984)]} 0 0
   [junit4]   2> 867880 INFO  (qtp931078345-10939) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[114 (1557711725066715136)]} 0 0
   [junit4]   2> 867882 INFO  (qtp818021416-10922) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[115 (1557711725068812288)]} 0 0
   [junit4]   2> 867884 INFO  (qtp931078345-10942) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[115 (1557711725069860864)]} 0 0
   [junit4]   2> 867886 INFO  (qtp818021416-10922) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[116 (1557711725071958016)]} 0 0
   [junit4]   2> 867887 INFO  (qtp931078345-10942) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[116 (1557711725074055168)]} 0 0
   [junit4]   2> 867889 INFO  (qtp818021416-10923) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[117 (1557711725076152320)]} 0 0
   [junit4]   2> 867891 INFO  (qtp931078345-10938) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[117 (1557711725078249472)]} 0 0
   [junit4]   2> 867893 INFO  (qtp818021416-10924) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[118 (1557711725080346624)]} 0 0
   [junit4]   2> 867895 INFO  (qtp931078345-10943) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[118 (1557711725081395200)]} 0 0
   [junit4]   2> 867896 INFO  (qtp818021416-10926) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[119 (1557711725083492352)]} 0 0
   [junit4]   2> 867898 INFO  (qtp931078345-10940) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[119 (1557711725085589504)]} 0 0
   [junit4]   2> 867900 INFO  (qtp818021416-10919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[120 (1557711725087686656)]} 0 0
   [junit4]   2> 867902 INFO  (qtp931078345-10936) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[120 (1557711725089783808)]} 0 0
   [junit4]   2> 867904 INFO  (qtp818021416-10921) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[121 (1557711725091880960)]} 0 0
   [junit4]   2> 867907 INFO  (qtp931078345-10939) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[121 (1557711725093978112)]} 0 1
   [junit4]   2> 867909 INFO  (qtp818021416-10925) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[122 (1557711725097123840)]} 0 0
   [junit4]   2> 867911 INFO  (qtp931078345-10941) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[122 (1557711725099220992)]} 0 0
   [junit4]   2> 867914 INFO  (qtp818021416-10925) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[123 (1557711725101318144)]} 0 0
   [junit4]   2> 867916 INFO  (qtp931078345-10941) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[123 (1557711725103415296)]} 0 0
   [junit4]   2> 867918 INFO  (qtp818021416-10923) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[124 (1557711725105512448)]} 0 0
   [junit4]   2> 867920 INFO  (qtp931078345-10938) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[124 (1557711725107609600)]} 0 0
   [junit4]   2> 867922 INFO  (qtp818021416-10924) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[125 (1557711725109706752)]} 0 1
   [junit4]   2> 867924 INFO  (qtp931078345-10943) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[125 (1557711725112852480)]} 0 0
   [junit4]   2> 867926 INFO  (qtp818021416-10926) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[126 (1557711725114949632)]} 0 0
   [junit4]   2> 867928 INFO  (qtp931078345-10940) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[126 (1557711725117046784)]} 0 0
   [junit4]   2> 867930 INFO  (qtp818021416-10919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[127 (1557711725119143936)]} 0 0
   [junit4]   2> 867932 INFO  (qtp931078345-10936) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[127 (1557711725121241088)]} 0 0
   [junit4]   2> 867934 INFO  (qtp818021416-10921) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[128 (1557711725123338240)]} 0 0
   [junit4]   2> 867946 INFO  (qtp931078345-10939) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[128 (1557711725134872576)]} 0 0
   [junit4]   2> 867948 INFO  (qtp818021416-10922) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[129 (1557711725138018304)]} 0 0
   [junit4]   2> 867950 INFO  (qtp931078345-10942) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[129 (1557711725139066880)]} 0 0
   [junit4]   2> 867952 INFO  (qtp818021416-10925) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[130 (1557711725141164032)]} 0 0
   [junit4]   2> 867953 INFO  (qtp931078345-10941) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[130 (1557711725143261184)]} 0 0
   [junit4]   2> 867955 INFO  (qtp818021416-10923) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[131 (1557711725145358336)]} 0 0
   [junit4]   2> 867957 INFO  (qtp931078345-10938) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[131 (1557711725147455488)]} 0 0
   [junit4]   2> 867960 INFO  (qtp818021416-10924) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[132 (1557711725150601216)]} 0 0
   [junit4]   2> 867962 INFO  (qtp931078345-10943) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[132 (1557711725152698368)]} 0 0
   [junit4]   2> 867964 INFO  (qtp818021416-10926) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[133 (1557711725154795520)]} 0 0
   [junit4]   2> 867966 INFO  (qtp931078345-10940) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[133 (1557711725156892672)]} 0 0
   [junit4]   2> 867968 INFO  (qtp818021416-10919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[134 (1557711725157941248)]} 0 0
   [junit4]   2> 867969 INFO  (qtp931078345-10936) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[134 (1557711725160038400)]} 0 0
   [junit4]   2> 867971 INFO  (qtp818021416-10921) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[135 (1557711725162135552)]} 0 0
   [junit4]   2> 867974 INFO  (qtp931078345-10939) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[135 (1557711725164232704)]} 0 0
   [junit4]   2> 867976 INFO  (qtp818021416-10922) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[136 (1557711725166329856)]} 0 0
   [junit4]   2> 867978 INFO  (qtp931078345-10942) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[136 (1557711725168427008)]} 0 0
   [junit4]   2> 867980 INFO  (qtp818021416-10925) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[137 (1557711725170524160)]} 0 0
   [junit4]   2> 867982 INFO  (qtp931078345-10941) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[137 (1557711725172621312)]} 0 0
   [junit4]   2> 867984 INFO  (qtp818021416-10923) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[138 (1557711725174718464)]} 0 0
   [junit4]   2> 867988 INFO  (qtp931078345-10938) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[138 (1557711725178912768)]} 0 0
   [junit4]   2> 867990 INFO  (qtp818021416-10924) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[139 (1557711725181009920)]} 0 0
   [junit4]   2> 867991 INFO  (qtp931078345-10943) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[139 (1557711725183107072)]} 0 0
   [junit4]   2> 867993 INFO  (qtp818021416-10926) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[140 (1557711725185204224)]} 0 0
   [junit4]   2> 867996 INFO  (qtp931078345-10940) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[140 (1557711725188349952)]} 0 0
   [junit4]   2> 867998 INFO  (qtp818021416-10919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[141 (1557711725190447104)]} 0 0
   [junit4]   2> 868000 INFO  (qtp931078345-10936) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[141 (1557711725192544256)]} 0 0
   [junit4]   2> 868002 INFO  (qtp818021416-10921) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[142 (1557711725194641408)]} 0 0
   [junit4]   2> 868004 INFO  (qtp931078345-10939) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[142 (1557711725195689984)]} 0 0
   [junit4]   2> 868005 INFO  (qtp818021416-10922) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[143 (1557711725197787136)]} 0 0
   [junit4]   2> 868008 INFO  (qtp931078345-10942) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[143 (1557711725200932864)]} 0 0
   [junit4]   2> 868010 INFO  (qtp818021416-10925) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[144 (1557711725203030016)]} 0 0
   [junit4]   2> 868011 INFO  (qtp931078345-10941) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[144 (1557711725204078592)]} 0 0
   [junit4]   2> 868013 INFO  (qtp818021416-10923) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[145 (1557711725206175744)]} 0 0
   [junit4]   2> 868015 INFO  (qtp931078345-10938) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[145 (1557711725208272896)]} 0 0
   [junit4]   2> 868017 INFO  (qtp818021416-10924) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[146 (1557711725210370048)]} 0 0
   [junit4]   2> 868020 INFO  (qtp931078345-10943) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[146 (1557711725213515776)]} 0 0
   [junit4]   2> 868022 INFO  (qtp818021416-10926) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[147 (1557711725214564352)]} 0 0
   [junit4]   2> 868023 INFO  (qtp931078345-10943) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[147 (1557711725216661504)]} 0 0
   [junit4]   2> 868026 INFO  (qtp818021416-10919) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[148 (1557711725218758656)]} 0 0
   [junit4]   2> 868027 INFO  (qtp931078345-10936) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[148 (1557711725220855808)]} 0 0
   [junit4]   2> 868029 INFO  (qtp818021416-10921) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[149 (1557711725222952960)]} 0 0
   [junit4]   2> 868032 INFO  (qtp931078345-10939) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={wt=javabin&version=2}{add=[149 (1557711725225050112)]} 0 0
   [junit4]   2> 868033 INFO  (qtp818021416-10922) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 868033 INFO  (qtp818021416-10922) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@648f3472
   [junit4]   2> 868074 INFO  (qtp818021416-10922) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@2c81c357[collection1] main]
   [junit4]   2> 868074 INFO  (qtp818021416-10922) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 868076 INFO  (searcherExecutor-4659-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2c81c357[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.5.0):c9) Uninverting(_1(6.5.0):c59)))}
   [junit4]   2> 868076 INFO  (qtp818021416-10922) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 42
   [junit4]   2> 868079 INFO  (qtp931078345-10942) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 868079 INFO  (qtp931078345-10942) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@2dd8b6d3
   [junit4]   2> 868120 INFO  (qtp931078345-10942) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@7b90bbd[collection1] main]
   [junit4]   2> 868122 INFO  (searcherExecutor-4670-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7b90bbd[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.5.0):c9) Uninverting(_1(6.5.0):c59)))}
   [junit4]   2> 868122 INFO  (qtp931078345-10942) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 868122 INFO  (qtp931078345-10942) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/li_jlu/x path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 43
   [junit4]   2> 868125 INFO  (qtp818021416-10925) [    x:collection1] o.a.s.h.RequestHandlerBase Ignoring exception matching parameter cannot be negative
   [junit4]   2> 868125 INFO  (qtp818021416-10925) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*&distrib=false&start=-1&wt=javabin&version=2} status=400 QTime=0
   [junit4]   2> 868127 INFO  (qtp818021416-10923) [    x:collection1] o.a.s.h.RequestHandlerBase Ignoring exception matching parameter cannot be negative
   [junit4]   2> 868127 INFO  (qtp818021416-10923) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*&distrib=false&start=0&rows=-1&wt=javabin&version=2} status=400 QTime=0
   [junit4]   2> 868129 INFO  (qtp818021416-10924) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&sort=n_ti1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 868152 INFO  (qtp931078345-10940) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+desc&shard.url=[ff01::213]:33332/li_jlu/x|http://127.0.0.1:37487/li_jlu/x/collection1&rows=10&version=2&q=*:*&NOW=1485549664824&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 868167 INFO  (qtp931078345-10943) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1485549664824&ids=111,101,145,3,135,147,126,115,137,128&isShard=true&shard.url=[ff01::213]:33332/li_jlu/x|http://127.0.0.1:37487/li_jlu/x/collection1&wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 868183 INFO  (qtp931078345-10941) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&shards=[ff01::213]:33332/li_jlu/x|http://127.0.0.1:37487/li_jlu/x/collection1&sort=n_ti1+desc&wt=javabin&version=2} hits=68 status=0 QTime=39
   [junit4]   2> 868185 INFO  (qtp818021416-10926) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&sort=n_ti1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 868200 INFO  (qtp931078345-10939) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+asc&shard.url=http://127.0.0.1:37487/li_jlu/x/collection1|[ff01::213]:33332/li_jlu/x|[ff01::083]:33332/li_jlu/x&rows=10&version=2&q=*:*&NOW=1485549664878&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 868215 INFO  (qtp931078345-10942) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1485549664878&ids=133,112,146,14,4,116,105,141,10,131&isShard=true&shard.url=http://127.0.0.1:37487/li_jlu/x/collection1|[ff01::213]:33332/li_jlu/x|[ff01::083]:33332/li_jlu/x&wt=javabin&version=2} status=0 QTime=2
   [junit4]   2> 868232 INFO  (qtp931078345-10936) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&shards=http://127.0.0.1:37487/li_jlu/x/collection1|[ff01::213]:33332/li_jlu/x|[ff01::083]:33332/li_jlu/x&sort=n_ti1+asc&wt=javabin&version=2} hits=68 status=0 QTime=34
   [junit4]   2> 868234 INFO  (qtp818021416-10919) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&sort=n_f1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 868248 INFO  (qtp931078345-10940) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_f1+desc&shard.url=http://127.0.0.1:37487/li_jlu/x/collection1|[ff01::114]:33332/li_jlu/x&rows=10&version=2&q=*:*&NOW=1485549664925&isShard=true&wt=javabin} hits=68 status=0 QTime=2
   [junit4]   2> 868257 INFO  (qtp931078345-10943) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1485549664925&ids=122,144,13,134,102,114,126,127,7,1001&isShard=true&shard.url=http://127.0.0.1:37487/li_jlu/x/collection1|[ff01::114]:33332/li_jlu/x&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 868285 INFO  (qtp931078345-10938) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&shards=http://127.0.0.1:37487/li_jlu/x/collection1|[ff01::114]:33332/li_jlu/x&sort=n_f1+desc&wt=javabin&version=2} hits=68 status=0 QTime=40
   [junit4]   2> 868301 INFO  (qtp818021416-10921) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&sort=n_f1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 868339 INFO  (qtp931078345-10939) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_f1+asc&shard.url=[ff01::114]:33332/li_jlu/x|http://127.0.0.1:37487/li_jlu/x/collection1&rows=10&version=2&q=*:*&NOW=1485549665013&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 868348 INFO  (qtp931078345-10942) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1485549665013&ids=132,100,133,145,103,16,115,138,17,8&isShard=true&shard.url=[ff01::114]:33332/li_jlu/x|http://127.0.0.1:37487/li_jlu/x/collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 868355 INFO  (qtp931078345-10941) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&shards=[ff01::114]:33332/li_jlu/x|http://127.0.0.1:37487/li_jlu/x/collection1&sort=n_f1+asc&wt=javabin&version=2} hits=68 status=0 QTime=23
   [junit4]   2> 868357 INFO  (qtp818021416-10922) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&sort=n_tf1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 868372 INFO  (qtp931078345-10940) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tf1+desc&shard.url=[ff01::083]:33332/li_jlu/x|http://127.0.0.1:37487/li_jlu/x/collection1&rows=10&version=2&q=*:*&NOW=1485549665046&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 868378 INFO  (qtp931078345-10943) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1485549665046&ids=121,111,2,15,103,138,17,130,141,142&isShard=true&shard.url=[ff01::083]:33332/li_jlu/x|http://127.0.0.1:37487/li_jlu/x/collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 868385 INFO  (qtp931078345-10936) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&shards=[ff01::083]:33332/li_jlu/x|http://127.0.0.1:37487/li_jlu/x/collection1&sort=n_tf1+desc&wt=javabin&version=2} hits=68 status=0 QTime=20
   [junit4]   2> 868387 INFO  (qtp818021416-10925) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&sort=n_tf1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 868400 INFO  (qtp931078345-10939) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tf1+asc&shard.url=[ff01::114]:33332/li_jlu/x|http://127.0.0.1:37487/li_jlu/x/collection1&rows=10&version=2&q=*:*&NOW=1485549665079&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 868409 INFO  (qtp931078345-10941) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1485549665079&ids=143,123,113,5,126,115,149,118,107,108&isShard=true&shard.url=[ff01::114]:33332/li_jlu/x|http://127.0.0.1:37487/li_jlu/x/collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 868418 INFO  (qtp931078345-10938) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&shards=[ff01::114]:33332/li_jlu/x|http://127.0.0.1:37487/li_jlu/x/collection1&sort=n_tf1+asc&wt=javabin&version=2} hits=68 status=0 QTime=20
   [junit4]   2> 868421 INFO  (qtp818021416-10923) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&sort=n_d1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 868426 INFO  (qtp931078345-10940) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_d1+desc&shard.url=http://127.0.0.1:37487/li_jlu/x/collection1|[ff01::083]:33332/li_jlu/x&rows=10&version=2&q=*:*&NOW=1485549665105&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 868432 INFO  (qtp931078345-10943) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1485549665105&ids=12,122,3,15,125,115,17,128,106,108&isShard=true&shard.url=http://127.0.0.1:37487/li_jlu/x/collection1|[ff01::083]:33332/li_jlu/x&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 868434 INFO  (qtp931078345-10942) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&shards=http://127.0.0.1:37487/li_jlu/x/collection1|[ff01::083]:33332/li_jlu/x&sort=n_d1+desc&wt=javabin&version=2} hits=68 status=0 QTime=9
   [junit4]   2> 868437 INFO  (qtp818021416-10924) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&sort=n_d1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 868442 INFO  (qtp931078345-10939) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_d1+asc&shard.url=http://127.0.0.1:37487/li_jlu/x/collection1&rows=10&version=2&q=*:*&NOW=1485549665120&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 868444 INFO  (qtp931078345-10941) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1485549665120&ids=134,114,126,5,127,1001,7,118,8,130&isShard=true&shard.url=http://127.0.0.1:37487/li_jlu/x/collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 868445 INFO  (qtp931078345-10936) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&shards=http://127.0.0.1:37487/li_jlu/x/collection1&sort=n_d1+asc&wt=javabin&version=2} hits=68 status=0 QTime=6
   [junit4]   2> 868447 INFO  (qtp818021416-10926) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&sort=n_td1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 868456 INFO  (qtp931078345-10940) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_td1+desc&shard.url=[ff01::114]:33332/li_jlu/x|http://127.0.0.1:37487/li_jlu/x/collection1|[ff01::213]:33332/li_jlu/x&rows=10&version=2&q=*:*&NOW=1485549665133&isShard=true&wt=javabin} hits=68 status=0 QTime=1
   [junit4]   2> 868460 INFO  (qtp931078345-10943) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1485549665133&ids=113,124,114,125,115,105,6,1001,9,130&isShard=true&shard.url=[ff01::114]:33332/li_jlu/x|http://127.0.0.1:37487/li_jlu/x/collection1|[ff01::213]:33332/li_jlu/x&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 868462 INFO  (qtp931078345-10938) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&shards=[ff01::114]:33332/li_jlu/x|http://127.0.0.1:37487/li_jlu/x/collection1|[ff01::213]:33332/li_jlu/x&sort=n_td1+desc&wt=javabin&version=2} hits=68 status=0 QTime=9
   [junit4]   2> 868471 INFO  (qtp818021416-10919) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&sort=n_td1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 868476 INFO  (qtp931078345-10939) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_td1+asc&shard.url=[ff01::213]:33332/li_jlu/x|http://127.0.0.1:37487/li_jlu/x/collection1|[ff01::083]:33332/li_jlu/x&rows=10&version=2&q=*:*&NOW=1485549665155&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 868479 INFO  (qtp931078345-10941) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1485549665155&ids=11,100,146,135,137,104,116,127,118,131&isShard=true&shard.url=[ff01::213]:33332/li_jlu/x|http://127.0.0.1:37487/li_jlu/x/collection1|[ff01::083]:33332/li_jlu/x&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 868480 INFO  (qtp931078345-10943) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&shards=[ff01::213]:33332/li_jlu/x|http://127.0.0.1:37487/li_jlu/x/collection1|[ff01::083]:33332/li_jlu/x&sort=n_td1+asc&wt=javabin&version=2} hits=68 status=0 QTime=6
   [junit4]   2> 868483 INFO  (qtp818021416-10921) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&sort=n_l1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 868487 INFO  (qtp931078345-10940) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_l1+desc&shard.url=[ff01::213]:33332/li_jlu/x|[ff01::114]:33332/li_jlu/x|http://127.0.0.1:37487/li_jlu/x/collection1&rows=10&version=2&q=*:*&NOW=1485549665166&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 868492 INFO  (qtp931078345-10942) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1485549665166&ids=12,1,15,126,16,115,106,109,130,10&isShard=true&shard.url=[ff01::213]:33332/li_jlu/x|[ff01::114]:33332/li_jlu/x|http://127.0.0.1:37487/li_jlu/x/collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 868493 INFO  (qtp931078345-10936) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&shards=[ff01::213]:33332/li_jlu/x|[ff01::114]:33332/li_jlu/x|http://127.0.0.1:37487/li_jlu/x/collection1&sort=n_l1+desc&wt=javabin&version=2} hits=68 status=0 QTime=7
   [junit4]   2> 868495 INFO  (qtp818021416-10922) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&sort=n_l1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 868541 INFO  (qtp931078345-10939) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_l1+asc&shard.url=[ff01::083]:33332/li_jlu/x|[ff01::213]:33332/li_jlu/x|http://127.0.0.1:37487/li_jlu/x/collection1&rows=10&version=2&q=*:*&NOW=1485549665220&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 868550 INFO  (qtp931078345-10941) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1485549665220&ids=101,145,102,3,137,116,17,108,119,120&isShard=true&shard.url=[ff01::083]:33332/li_jlu/x|[ff01::213]:33332/li_jlu/x|http://127.0.0.1:37487/li_jlu/x/collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 868553 INFO  (qtp931078345-10938) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&shards=[ff01::083]:33332/li_jlu/x|[ff01::213]:33332/li_jlu/x|http://127.0.0.1:37487/li_jlu/x/collection1&sort=n_l1+asc&wt=javabin&version=2} hits=68 status=0 QTime=14
   [junit4]   2> 868556 INFO  (qtp818021416-10925) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&sort=n_tl1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 868560 INFO  (qtp931078345-10940) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tl1+desc&shard.url=http://127.0.0.1:37487/li_jlu/x/collection1&rows=10&version=2&q=*:*&NOW=1485549665239&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 868562 INFO  (qtp931078345-10940) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1485549665239&ids=122,12,100,111,146,14,103,114,107,109&isShard=true&shard.url=http://127.0.0.1:37487/li_jlu/x/collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 868563 INFO  (qtp931078345-10943) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&shards=http://127.0.0.1:37487/li_jlu/x/collection1&sort=n_tl1+desc&wt=javabin&version=2} hits=68 status=0 QTime=5
   [junit4]   2> 868565 INFO  (qtp818021416-10923) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&sort=n_tl1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 868573 INFO  (qtp931078345-10939) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tl1+asc&shard.url=[ff01::213]:33332/li_jlu/x|[ff01::114]:33332/li_jlu/x|http://127.0.0.1:37487/li_jlu/x/collection1&rows=10&version=2&q=*:*&NOW=1485549665252&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 868578 INFO  (qtp931078345-10941) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1485549665252&ids=132,133,102,124,3,5,148,115,116,117&isShard=true&shard.url=[ff01::213]:33332/li_jlu/x|[ff01::114]:33332/li_jlu/x|http://127.0.0.1:37487/li_jlu/x/collection1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 868582 INFO  (qtp931078345-10936) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&shards=[ff01::213]:33332/li_jlu/x|[ff01::114]:33332/li_jlu/x|http://127.0.0.1:37487/li_jlu/x/collection1&sort=n_tl1+asc&wt=javabin&version=2} hits=68 status=0 QTime=11
   [junit4]   2> 868585 INFO  (qtp818021416-10924) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&sort=n_dt1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 868590 INFO  (qtp931078345-10942) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_dt1+desc&shard.url=http://127.0.0.1:37487/li_jlu/x/collection1|[ff01::114]:33332/li_jlu/x&rows=10&version=2&q=*:*&NOW=1485549665268&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 868592 INFO  (qtp931078345-10940) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1485549665268&ids=124,113,14,146,148,138,117,128,8,119&isShard=true&shard.url=http://127.0.0.1:37487/li_jlu/x/collection1|[ff01::114]:33332/li_jlu/x&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 868593 INFO  (qtp931078345-10941) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&shards=http://127.0.0.1:37487/li_jlu/x/collection1|[ff01::114]:33332/li_jlu/x&sort=n_dt1+desc&wt=javabin&version=2} hits=68 status=0 QTime=6
   [junit4]   2> 868595 INFO  (qtp818021416-10926) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&sort=n_dt1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 868600 INFO  (qtp931078345-10939) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_dt1+asc&shard.url=[ff01::213]:33332/li_jlu/x|http://127.0.0.1:37487/li_jlu/x/collection1|[ff01::114]:33332/li_jlu/x|[ff01::083]:33332/li_jlu/x&rows=10&version=2&q=*:*&NOW=1485549665280&isShard=true&wt=javabin} hits=68 status=0 QTime=0
   [junit4]   2> 868608 INFO  (qtp931078345-10938) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1485549665280&ids=12,100,133,1,103,15,5,149,118,120&isShard=true&shard.url=[ff01::213]:33332/li_jlu/x|http://127.0.0.1:37487/li_jlu/x/collection1|[ff01::114]:33332/li_jlu/x|[ff01::083]:33332/li_jlu/x&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 868608 INFO  (qtp931078345-10943) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&shards=[ff01::213]:33332/li_jlu/x|http://127.0.0.1:37487/li_jlu/x/collection1|[ff01::114]:33332/li_jlu/x|[ff01::083]:33332/li_jlu/x&sort=n_dt1+asc&wt=javabin&version=2} hits=68 status=0 QTime=9
   [junit4]   2> 868612 INFO  (qtp818021416-10919) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/li_jlu/x path=/select params={q=*:*&distrib=false&sort=n_tdt1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0
   [junit4]   2> 868620 INFO  (qtp931078345-109

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

t sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:717)
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:361)
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1081)
   [junit4]   2> 3024544 WARN  (jetty-launcher-3940-thread-2-SendThread(127.0.0.1:38114)) [n:127.0.0.1:55099_solr    ] o.a.z.ClientCnxn Session 0x0 for server null, unexpected error, closing socket connection and attempting reconnect
   [junit4]   2> java.net.ConnectException: Connection refused
   [junit4]   2> 	at sun.nio.ch.SocketChannelImpl.checkConnect(Native Method)
   [junit4]   2> 	at sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:717)
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:361)
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1081)
   [junit4]   2> 3025646 WARN  (jetty-launcher-3940-thread-2-SendThread(127.0.0.1:38114)) [n:127.0.0.1:55099_solr    ] o.a.z.ClientCnxn Session 0x0 for server null, unexpected error, closing socket connection and attempting reconnect
   [junit4]   2> java.net.ConnectException: Connection refused
   [junit4]   2> 	at sun.nio.ch.SocketChannelImpl.checkConnect(Native Method)
   [junit4]   2> 	at sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:717)
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:361)
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1081)
   [junit4]   2> 3026749 WARN  (jetty-launcher-3940-thread-2-SendThread(127.0.0.1:38114)) [n:127.0.0.1:55099_solr    ] o.a.z.ClientCnxn Session 0x0 for server null, unexpected error, closing socket connection and attempting reconnect
   [junit4]   2> java.net.ConnectException: Connection refused
   [junit4]   2> 	at sun.nio.ch.SocketChannelImpl.checkConnect(Native Method)
   [junit4]   2> 	at sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:717)
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:361)
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1081)
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene62), sim=RandomSimilarity(queryNorm=true,coord=no): {}, locale=it, timezone=Europe/Kaliningrad
   [junit4]   2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_121 (64-bit)/cpus=3,threads=1,free=317992824,total=518979584
   [junit4]   2> NOTE: All tests run in this JVM: [ExternalFileFieldSortTest, MinimalSchemaTest, TestDynamicFieldResource, TestFileDictionaryLookup, TestSolrDeletionPolicy2, BooleanFieldTest, ExplicitHLLTest, TestCustomStream, BlockJoinFacetDistribTest, EchoParamsTest, WordBreakSolrSpellCheckerTest, CdcrBootstrapTest, ShardSplitTest, SolrIndexConfigTest, FullSolrCloudDistribCmdsTest, TestZkChroot, ClassificationUpdateProcessorTest, SuggestComponentTest, TestPushWriter, TestWriterPerf, SuggesterTSTTest, TestSortByMinMaxFunction, TestScoreJoinQPNoScore, CoreMergeIndexesAdminHandlerTest, PreAnalyzedFieldManagedSchemaCloudTest, TestOmitPositions, TestFieldResource, IndexSchemaTest, TestExportWriter, HighlighterMaxOffsetTest, TestSolr4Spatial, SpatialHeatmapFacetsTest, TestRandomFaceting, TestConfigSetsAPIExclusivity, CollectionsAPIDistributedZkTest, UUIDFieldTest, ParsingFieldUpdateProcessorsTest, TestIndexingPerformance, OverseerRolesTest, TestSolrCloudWithKerberosAlt, TestSystemIdResolver, TestHdfsBackupRestoreCore, DistributedDebugComponentTest, TestBackupRepositoryFactory, TestFoldingMultitermQuery, TestAnalyzeInfixSuggestions, RegexBoostProcessorTest, TestSimpleQParserPlugin, PreAnalyzedFieldTest, AsyncCallRequestStatusResponseTest, URLClassifyProcessorTest, TestSolr4Spatial2, MBeansHandlerTest, TestQueryUtils, BlockJoinFacetSimpleTest, DistributedFacetExistsSmallTest, TestBulkSchemaConcurrent, HdfsWriteToMultipleCollectionsTest, TestSolrCoreSnapshots, CSVRequestHandlerTest, BasicFunctionalityTest, ScriptEngineTest, DefaultValueUpdateProcessorTest, SliceStateTest, StatsComponentTest, TestBinaryResponseWriter, RequestHandlersTest, TestSchemaManager, TestAtomicUpdateErrorCases, DistributedFacetPivotLongTailTest, BasicAuthIntegrationTest, TestReversedWildcardFilterFactory, HdfsDirectoryTest, TestCollationFieldDocValues, LukeRequestHandlerTest, TestMergePolicyConfig, TestSQLHandler, TestPerFieldSimilarityClassic, TestSubQueryTransformerCrossCore, TestSolrCloudWithHadoopAuthPlugin, TermVectorComponentDistributedTest, TestDefaultSearchFieldResource, TestUniqueKeyFieldResource, TestRequestStatusCollectionAPI, BlobRepositoryCloudTest, TestMissingGroups, LeaderElectionIntegrationTest, CopyFieldTest, ForceLeaderTest, TestManagedSchemaAPI, TestCloudRecovery, TestDistribIDF, EnumFieldTest, SignatureUpdateProcessorFactoryTest, TestConfigSets, TestSearchPerf, TestQueryTypes, TestBlobHandler, CursorMarkTest, TestRawTransformer, DistributedFacetPivotSmallTest, ResourceLoaderTest, SolrCLIZkUtilsTest, TestSolrQueryParserDefaultOperatorResource, TestFiltering, TestDelegationWithHadoopAuth, TestSolrCoreProperties, TestSolrConfigHandler, TestFieldSortValues, HdfsRecoveryZkTest, HighlighterConfigTest, SuggesterTest, TestSolrFieldCacheMBean, OpenCloseCoreStressTest, TestDFISimilarityFactory, QueryParsingTest, SpellCheckCollatorTest, TestSuggestSpellingConverter, TestSolrCLIRunExample, DeleteInactiveReplicaTest, BasicDistributedZk2Test, HdfsChaosMonkeySafeLeaderTest, TestJoin, ClassificationUpdateProcessorFactoryTest, CollectionsAPISolrJTest, TestDistribDocBasedVersion, SearchHandlerTest, TestCloudPivotFacet, CheckHdfsIndexTest, TestConfig, ConvertedLegacyTest, TestConfigSetImmutable, DirectoryFactoryTest, ConfigSetsAPITest, DocExpirationUpdateProcessorFactoryTest, HdfsDirectoryFactoryTest, SimpleMLTQParserTest, DistribJoinFromCollectionTest, TestSchemaResource, TestCryptoKeys, TestCollapseQParserPlugin, TestLockTree, ShardRoutingCustomTest, FieldAnalysisRequestHandlerTest, TestValueSourceCache, TestFieldCacheVsDocValues, ZkSolrClientTest, TestSegmentSorting, DateMathParserTest, TestManagedResource, TestReloadDeadlock, ConnectionReuseTest, SpellingQueryConverterTest, TestSimpleTrackingShardHandler, TestAuthorizationFramework, TestChildDocTransformer, TestExactStatsCache, UUIDUpdateProcessorFallbackTest, TestSolrConfigHandlerCloud, NotRequiredUniqueKeyTest, TestTrackingShardHandlerFactory, TestInitParams, CreateCollectionCleanupTest, DeleteStatusTest, DistribDocExpirationUpdateProcessorTest, DistributedQueueTest, DistributedVersionInfoTest, HttpPartitionTest, LeaderInitiatedRecoveryOnShardRestartTest, MigrateRouteKeyTest, MissingSegmentRecoveryTest, OutOfBoxZkACLAndCredentialsProvidersTest, OverseerCollectionConfigSetProcessorTest, OverseerModifyCollectionTest, OverseerTaskQueueTest, PeerSyncReplicationTest, ReplicationFactorTest, RestartWhileUpdatingTest, RollingRestartTest, SolrCloudExampleTest, TestCloudInspectUtil, TestCollectionAPI, TestLeaderElectionWithEmptyReplica, TestMiniSolrCloudCluster, TestOnReconnectListenerSupport, TestRandomRequestDistribution, TestReplicaProperties, TestRequestForwarding, TestSolrCloudWithSecureImpersonation, TestStressCloudBlindAtomicUpdates, TestTolerantUpdateProcessorRandomCloud, VMParamsZkACLAndCredentialsProvidersTest, HdfsBasicDistributedZkTest, HdfsCollectionsAPIDistributedZkTest, HdfsNNFailoverTest, HdfsRestartWhileUpdatingTest, HdfsSyncSliceTest, HdfsThreadLeakTest, HdfsTlogReplayBufferedWhileIndexingTest, TestClusterStateMutator, ZkStateWriterTest, TestConfigOverlay, TestCorePropertiesReload, TestImplicitCoreProperties, TestInfoStreamLogging, TestNRTOpen, TestReloadAndDeleteDocs, TestConfigReload, TestSQLHandlerNonCloud, TestSolrConfigHandlerConcurrent, DistributedFacetPivotWhiteBoxTest, DistributedQueryComponentCustomSortTest, ReplicaListTransformerTest, TestExpandComponent, TestSlowCompositeReaderWrapper, JvmMetricsTest, SolrCoreMetricManagerTest, SolrMetricManagerTest, SolrMetricReporterTest, SolrMetricsIntegrationTest, SolrGraphiteReporterTest, SmileWriterTest, TestIntervalFaceting, TestMacroExpander, TestMacros, JSONWriterTest, TestGraphMLResponseWriter, TestSubQueryTransformer, TestRestManager, TestBulkSchemaAPI, TestCopyFieldCollectionResource, TestDynamicFieldCollectionResource, TestFieldCollectionResource, TestFieldTypeResource, TestSchemaNameResource, TestSchemaSimilarityResource, TestSchemaVersionResource, TestSolrQueryParserResource, TestManagedSynonymFilterFactory, ChangedSchemaMergeTest, DateRangeFieldTest, DocValuesMissingTest, TestCloudSchemaless, TestReRankQParserPlugin, TestRecoveryHdfs, TestStandardQParsers, TestStressUserVersions, TestXmlQParser, TestXmlQParserPlugin, TestJsonFacetRefinement, TestJsonFacets, TestLRUStatsCache, PKIAuthenticationIntegrationTest, TestRuleBasedAuthorizationPlugin, TestSha256AuthenticationProvider, TestImpersonationWithHadoopAuth, ConjunctionSolrSpellCheckerTest, TestFreeTextSuggestions, BlockDirectoryTest, TestDocTermOrds, TestFieldCacheReopen, TestFieldCacheSanityChecker, TestFieldCacheSort, TestLegacyFieldCache, TestNumericTerms32, TestNumericTerms64]
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestNumericTerms64 -Dtests.seed=C556D21BFF9ABEAE -Dtests.slow=true -Dtests.locale=it -Dtests.timezone=Europe/Kaliningrad -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.00s J1 | TestNumericTerms64 (suite) <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: The test or suite printed 8944 bytes to stdout and stderr, even though the limit was set to 8192 bytes. Increase the limit with @Limit, ignore it completely with @SuppressSysoutChecks or run with -Dtests.verbose=true
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([C556D21BFF9ABEAE]:0)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4] Completed [655/681 (3!)] on J1 in 8.92s, 4 tests, 1 failure <<< FAILURES!

[...truncated 62616 lines...]