Build: https://jenkins.thetaphi.de/job/Lucene-Solr-BadApples-master-Linux/184/ Java: 64bit/jdk-11 -XX:-UseCompressedOops -XX:+UseSerialGC
1 tests failed. FAILED: org.apache.solr.handler.component.TestDistributedStatsComponentCardinality.test Error Message: .responseHeader.status:200!=0 Stack Trace: junit.framework.AssertionFailedError: .responseHeader.status:200!=0 at __randomizedtesting.SeedInfo.seed([6879376B74FB0557:E02D08B1DA0768AF]:0) at junit.framework.Assert.fail(Assert.java:57) at org.apache.solr.BaseDistributedSearchTestCase.compareSolrResponses(BaseDistributedSearchTestCase.java:999) at org.apache.solr.BaseDistributedSearchTestCase.compareResponses(BaseDistributedSearchTestCase.java:1026) at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:680) at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:643) at org.apache.solr.handler.component.TestDistributedStatsComponentCardinality.test(TestDistributedStatsComponentCardinality.java:143) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:566) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1082) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1054) 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:947) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.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 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.base/java.lang.Thread.run(Thread.java:834) Build Log: [...truncated 14911 lines...] [junit4] Suite: org.apache.solr.handler.component.TestDistributedStatsComponentCardinality [junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_6879376B74FB0557-001/init-core-data-001 [junit4] 2> 2186958 INFO (SUITE-TestDistributedStatsComponentCardinality-seed#[6879376B74FB0557]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /zhz/o [junit4] 2> 2187168 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 2187168 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 2187168 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 2187168 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 11+28 [junit4] 2> 2187272 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 2187272 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 2187272 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 2187275 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4ef6153a{/zhz/o,null,AVAILABLE} [junit4] 2> 2187275 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@21be543a{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:35367} [junit4] 2> 2187275 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.Server Started @2187334ms [junit4] 2> 2187275 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/zhz/o, hostPort=35367, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_6879376B74FB0557-001/tempDir-001/control/cores} [junit4] 2> 2187275 ERROR (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2187275 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 2187276 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 9.0.0 [junit4] 2> 2187276 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 2187276 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2187276 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-03-28T04:53:45.402057Z [junit4] 2> 2187276 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_6879376B74FB0557-001/tempDir-001/control/solr.xml [junit4] 2> 2187278 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 2187278 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 2187279 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@2a2ce554, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 2187964 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false] [junit4] 2> 2187965 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@60de3d11[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2188006 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@553ec895[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2188044 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 2188044 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 2188060 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2a2ce554 [junit4] 2> 2188070 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2a2ce554 [junit4] 2> 2188070 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2a2ce554 [junit4] 2> 2188071 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_6879376B74FB0557-001/tempDir-001/control/cores [junit4] 2> 2188071 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 2188085 INFO (coreLoadExecutor-11045-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 2188131 INFO (coreLoadExecutor-11045-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0 [junit4] 2> 2188177 INFO (coreLoadExecutor-11045-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 2188282 INFO (coreLoadExecutor-11045-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 2188306 INFO (coreLoadExecutor-11045-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 2188306 INFO (coreLoadExecutor-11045-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2a2ce554 [junit4] 2> 2188306 INFO (coreLoadExecutor-11045-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_6879376B74FB0557-001/tempDir-001/control/cores/collection1/data/] [junit4] 2> 2188308 INFO (coreLoadExecutor-11045-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=17, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.857701141256633] [junit4] 2> 2188373 INFO (coreLoadExecutor-11045-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2188373 INFO (coreLoadExecutor-11045-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 2188376 INFO (coreLoadExecutor-11045-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 2188376 INFO (coreLoadExecutor-11045-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2188377 INFO (coreLoadExecutor-11045-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=11, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 2188401 INFO (coreLoadExecutor-11045-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@63c8e84f[collection1] main] [junit4] 2> 2188401 INFO (coreLoadExecutor-11045-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 2188515 INFO (coreLoadExecutor-11045-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 2189064 INFO (coreLoadExecutor-11045-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 2189064 INFO (coreLoadExecutor-11045-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1629223730219581440 [junit4] 2> 2189066 INFO (searcherExecutor-11046-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 2189067 INFO (searcherExecutor-11046-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 2189067 INFO (searcherExecutor-11046-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 2189067 INFO (searcherExecutor-11046-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 2189068 INFO (searcherExecutor-11046-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 2189068 INFO (searcherExecutor-11046-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 2189068 INFO (searcherExecutor-11046-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 2189068 INFO (searcherExecutor-11046-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 2189068 INFO (searcherExecutor-11046-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 2189069 INFO (searcherExecutor-11046-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@63c8e84f[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2189208 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 2189208 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 2189208 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 2189208 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 11+28 [junit4] 2> 2189273 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 2189273 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 2189273 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 2189273 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6ecb756{/zhz/o,null,AVAILABLE} [junit4] 2> 2189273 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@d615ed8{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:43545} [junit4] 2> 2189273 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.Server Started @2189332ms [junit4] 2> 2189273 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/zhz/o, hostPort=43545, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_6879376B74FB0557-001/tempDir-001/shard0/cores} [junit4] 2> 2189274 ERROR (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2189274 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 2189274 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 9.0.0 [junit4] 2> 2189274 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 2189274 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2189274 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-03-28T04:53:47.400273Z [junit4] 2> 2189274 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_6879376B74FB0557-001/tempDir-001/shard0/solr.xml [junit4] 2> 2189276 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 2189276 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 2189277 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@2a2ce554, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 2189383 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false] [junit4] 2> 2189384 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@3e7c848c[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2189401 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@3f751837[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2189445 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 2189445 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 2189459 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2a2ce554 [junit4] 2> 2189470 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2a2ce554 [junit4] 2> 2189470 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2a2ce554 [junit4] 2> 2189471 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_6879376B74FB0557-001/tempDir-001/shard0/cores [junit4] 2> 2189471 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 2189477 INFO (coreLoadExecutor-11059-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 2189535 INFO (coreLoadExecutor-11059-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0 [junit4] 2> 2189557 INFO (coreLoadExecutor-11059-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 2189662 INFO (coreLoadExecutor-11059-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 2189675 INFO (coreLoadExecutor-11059-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 2189676 INFO (coreLoadExecutor-11059-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2a2ce554 [junit4] 2> 2189676 INFO (coreLoadExecutor-11059-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_6879376B74FB0557-001/tempDir-001/shard0/cores/collection1/data/] [junit4] 2> 2189677 INFO (coreLoadExecutor-11059-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=17, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.857701141256633] [junit4] 2> 2189765 INFO (coreLoadExecutor-11059-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2189765 INFO (coreLoadExecutor-11059-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 2189768 INFO (coreLoadExecutor-11059-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 2189768 INFO (coreLoadExecutor-11059-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2189768 INFO (coreLoadExecutor-11059-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=11, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 2189769 INFO (coreLoadExecutor-11059-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6e8d340[collection1] main] [junit4] 2> 2189769 INFO (coreLoadExecutor-11059-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 2189854 INFO (coreLoadExecutor-11059-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 2190449 INFO (coreLoadExecutor-11059-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 2190449 INFO (coreLoadExecutor-11059-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1629223731671859200 [junit4] 2> 2190456 INFO (searcherExecutor-11060-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 2190458 INFO (searcherExecutor-11060-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 2190460 INFO (searcherExecutor-11060-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 2190460 INFO (searcherExecutor-11060-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 2190465 INFO (searcherExecutor-11060-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 2190465 INFO (searcherExecutor-11060-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 2190465 INFO (searcherExecutor-11060-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 2190465 INFO (searcherExecutor-11060-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 2190465 INFO (searcherExecutor-11060-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 2190466 INFO (searcherExecutor-11060-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6e8d340[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2190597 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 2190597 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 2190597 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 2190597 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 11+28 [junit4] 2> 2190685 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 2190685 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 2190685 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 2190692 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2dc1c2cf{/zhz/o,null,AVAILABLE} [junit4] 2> 2190693 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@15303763{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:39877} [junit4] 2> 2190693 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.Server Started @2190752ms [junit4] 2> 2190693 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/zhz/o, hostPort=39877, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_6879376B74FB0557-001/tempDir-001/shard1/cores} [junit4] 2> 2190693 ERROR (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2190693 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 2190693 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 9.0.0 [junit4] 2> 2190693 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 2190693 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2190693 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-03-28T04:53:48.819596Z [junit4] 2> 2190693 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_6879376B74FB0557-001/tempDir-001/shard1/solr.xml [junit4] 2> 2190695 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 2190695 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 2190696 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@2a2ce554, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 2190753 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false] [junit4] 2> 2190769 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@40a3b1c3[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2190802 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@1fd81780[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2190844 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 2190844 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 2190867 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2a2ce554 [junit4] 2> 2190877 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2a2ce554 [junit4] 2> 2190877 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2a2ce554 [junit4] 2> 2190879 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_6879376B74FB0557-001/tempDir-001/shard1/cores [junit4] 2> 2190879 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 2190909 INFO (coreLoadExecutor-11073-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 2190971 INFO (coreLoadExecutor-11073-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0 [junit4] 2> 2191018 INFO (coreLoadExecutor-11073-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 2191128 INFO (coreLoadExecutor-11073-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 2191135 INFO (coreLoadExecutor-11073-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 2191135 INFO (coreLoadExecutor-11073-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2a2ce554 [junit4] 2> 2191135 INFO (coreLoadExecutor-11073-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_6879376B74FB0557-001/tempDir-001/shard1/cores/collection1/data/] [junit4] 2> 2191137 INFO (coreLoadExecutor-11073-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=17, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.857701141256633] [junit4] 2> 2191241 INFO (coreLoadExecutor-11073-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2191241 INFO (coreLoadExecutor-11073-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 2191243 INFO (coreLoadExecutor-11073-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 2191243 INFO (coreLoadExecutor-11073-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2191244 INFO (coreLoadExecutor-11073-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=11, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 2191244 INFO (coreLoadExecutor-11073-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@e937619[collection1] main] [junit4] 2> 2191244 INFO (coreLoadExecutor-11073-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 2191313 INFO (coreLoadExecutor-11073-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 2191609 INFO (coreLoadExecutor-11073-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 2191609 INFO (coreLoadExecutor-11073-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1629223732888207360 [junit4] 2> 2191611 INFO (searcherExecutor-11074-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 2191611 INFO (searcherExecutor-11074-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 2191611 INFO (searcherExecutor-11074-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 2191611 INFO (searcherExecutor-11074-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 2191612 INFO (searcherExecutor-11074-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 2191612 INFO (searcherExecutor-11074-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 2191612 INFO (searcherExecutor-11074-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 2191612 INFO (searcherExecutor-11074-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 2191612 INFO (searcherExecutor-11074-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 2191613 INFO (searcherExecutor-11074-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@e937619[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2191728 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 2191728 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 2191728 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 2191728 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 11+28 [junit4] 2> 2191749 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 2191749 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 2191749 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 2191753 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6dd1e16b{/zhz/o,null,AVAILABLE} [junit4] 2> 2191769 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@347ad9d{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:44469} [junit4] 2> 2191769 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.s.Server Started @2191828ms [junit4] 2> 2191769 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/zhz/o, hostPort=44469, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_6879376B74FB0557-001/tempDir-001/shard2/cores} [junit4] 2> 2191770 ERROR (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2191770 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 2191770 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 9.0.0 [junit4] 2> 2191770 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 2191770 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2191770 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-03-28T04:53:49.896293Z [junit4] 2> 2191770 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_6879376B74FB0557-001/tempDir-001/shard2/solr.xml [junit4] 2> 2191772 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 2191772 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 2191792 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@2a2ce554, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 2192113 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false] [junit4] 2> 2192133 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@43d84b9f[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2192193 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@4a1f2a98[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2192224 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 2192225 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 2192243 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2a2ce554 [junit4] 2> 2192261 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2a2ce554 [junit4] 2> 2192262 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2a2ce554 [junit4] 2> 2192263 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_6879376B74FB0557-001/tempDir-001/shard2/cores [junit4] 2> 2192263 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 2192288 INFO (coreLoadExecutor-11087-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 2192340 INFO (coreLoadExecutor-11087-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0 [junit4] 2> 2192370 INFO (coreLoadExecutor-11087-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 2192582 INFO (coreLoadExecutor-11087-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 2192588 INFO (coreLoadExecutor-11087-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 2192589 INFO (coreLoadExecutor-11087-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2a2ce554 [junit4] 2> 2192589 INFO (coreLoadExecutor-11087-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_6879376B74FB0557-001/tempDir-001/shard2/cores/collection1/data/] [junit4] 2> 2192601 INFO (coreLoadExecutor-11087-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=17, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.857701141256633] [junit4] 2> 2192662 INFO (coreLoadExecutor-11087-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2192662 INFO (coreLoadExecutor-11087-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 2192694 INFO (coreLoadExecutor-11087-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 2192694 INFO (coreLoadExecutor-11087-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2192695 INFO (coreLoadExecutor-11087-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=11, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 2192695 INFO (coreLoadExecutor-11087-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@34d3da06[collection1] main] [junit4] 2> 2192696 INFO (coreLoadExecutor-11087-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 2192833 INFO (coreLoadExecutor-11087-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 2193160 INFO (coreLoadExecutor-11087-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 2193160 INFO (coreLoadExecutor-11087-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1629223734514548736 [junit4] 2> 2193161 INFO (searcherExecutor-11088-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 2193162 INFO (searcherExecutor-11088-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 2193162 INFO (searcherExecutor-11088-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 2193162 INFO (searcherExecutor-11088-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 2193162 INFO (searcherExecutor-11088-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 2193162 INFO (searcherExecutor-11088-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 2193162 INFO (searcherExecutor-11088-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 2193162 INFO (searcherExecutor-11088-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 2193162 INFO (searcherExecutor-11088-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 2193163 INFO (searcherExecutor-11088-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@34d3da06[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2193165 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[6879376B74FB0557]) [ ] o.a.s.h.c.TestDistributedStatsComponentCardinality Building an index of 13932 docs [junit4] 2> 2193183 INFO (qtp945999503-36834) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[1 (1629223734537617408)]} 0 1 [junit4] 2> 2193195 INFO (qtp847510730-36854) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[1 (1629223734549151744)]} 0 1 [junit4] 2> 2193195 INFO (qtp945999503-36835) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[2 (1629223734551248896)]} 0 0 [junit4] 2> 2193202 INFO (qtp1297947521-36876) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[2 (1629223734557540352)]} 0 0 [junit4] 2> 2193213 INFO (qtp945999503-36833) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[3 (1629223734570123264)]} 0 0 [junit4] 2> 2193226 INFO (qtp1605456666-36898) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[3 (1629223734582706176)]} 0 1 [junit4] 2> 2193227 INFO (qtp945999503-36834) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[4 (1629223734584803328)]} 0 0 [junit4] 2> 2193227 INFO (qtp847510730-36856) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[4 (1629223734584803328)]} 0 0 [junit4] 2> 2193227 INFO (qtp945999503-36835) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[5 (1629223734584803329)]} 0 0 [junit4] 2> 2193228 INFO (qtp1297947521-36877) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[5 (1629223734585851904)]} 0 0 [junit4] 2> 2193228 INFO (qtp945999503-36833) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[6 (1629223734585851904)]} 0 0 [junit4] 2> 2193228 INFO (qtp1605456666-36894) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[6 (1629223734585851904)]} 0 0 [junit4] 2> 2193229 INFO (qtp945999503-36834) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[7 (1629223734586900480)]} 0 0 [junit4] 2> 2193229 INFO (qtp847510730-36855) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[7 (1629223734586900480)]} 0 0 [junit4] 2> 2193230 INFO (qtp945999503-36835) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[8 (1629223734587949056)]} 0 0 [junit4] 2> 2193230 INFO (qtp1297947521-36875) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[8 (1629223734587949056)]} 0 0 [junit4] 2> 2193230 INFO (qtp945999503-36833) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[9 (1629223734587949057)]} 0 0 [junit4] 2> 2193231 INFO (qtp1605456666-36897) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[9 (1629223734588997632)]} 0 0 [junit4] 2> 2193235 INFO (qtp945999503-36834) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[10 (1629223734593191936)]} 0 0 [junit4] 2> 2193235 INFO (qtp847510730-36854) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[10 (1629223734593191936)]} 0 0 [junit4] 2> 2193236 INFO (qtp945999503-36835) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[11 (1629223734594240512)]} 0 0 [junit4] 2> 2193236 INFO (qtp1297947521-36876) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[11 (1629223734594240512)]} 0 0 [junit4] 2> 2193236 INFO (qtp945999503-36833) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[12 (1629223734594240513)]} 0 0 [junit4] 2> 2193237 INFO (qtp1605456666-36898) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[12 (1629223734595289088)]} 0 0 [junit4] 2> 2193237 INFO (qtp945999503-36834) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[13 (1629223734595289088)]} 0 0 [junit4] 2> 2193237 INFO (qtp847510730-36856) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[13 (1629223734595289088)]} 0 0 [junit4] 2> 2193238 INFO (qtp945999503-36835) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[14 (1629223734596337664)]} 0 0 [junit4] 2> 2193238 INFO (qtp1297947521-36877) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[14 (1629223734596337664)]} 0 0 [junit4] 2> 2193238 INFO (qtp945999503-36833) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[15 (1629223734596337665)]} 0 0 [junit4] 2> 2193239 INFO (qtp1605456666-36894) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[15 (1629223734597386240)]} 0 0 [junit4] 2> 2193239 INFO (qtp945999503-36834) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[16 (1629223734597386240)]} 0 0 [junit4] 2> 2193239 INFO (qtp847510730-36855) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[16 (1629223734597386240)]} 0 0 [junit4] 2> 2193240 INFO (qtp945999503-36835) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[17 (1629223734598434816)]} 0 0 [junit4] 2> 2193240 INFO (qtp1297947521-36875) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[17 (1629223734598434816)]} 0 0 [junit4] 2> 2193240 INFO (qtp945999503-36833) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[18 (1629223734598434817)]} 0 0 [junit4] 2> 2193241 INFO (qtp1605456666-36897) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[18 (1629223734598434816)]} 0 0 [junit4] 2> 2193241 INFO (qtp945999503-36834) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[19 (1629223734599483392)]} 0 0 [junit4] 2> 2193241 INFO (qtp847510730-36854) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[19 (1629223734599483392)]} 0 0 [junit4] 2> 2193241 INFO (qtp945999503-36835) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[20 (1629223734599483393)]} 0 0 [junit4] 2> 2193242 INFO (qtp1297947521-36876) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[20 (1629223734600531968)]} 0 0 [junit4] 2> 2193242 INFO (qtp945999503-36833) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[21 (1629223734600531968)]} 0 0 [junit4] 2> 2193242 INFO (qtp1605456666-36898) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[21 (1629223734600531968)]} 0 0 [junit4] 2> 2193243 INFO (qtp945999503-36834) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[22 (1629223734601580544)]} 0 0 [junit4] 2> 2193243 INFO (qtp847510730-36856) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[22 (1629223734601580544)]} 0 0 [junit4] 2> 2193243 INFO (qtp945999503-36835) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[23 (1629223734601580545)]} 0 0 [junit4] 2> 2193244 INFO (qtp1297947521-36877) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[23 (1629223734602629120)]} 0 0 [junit4] 2> 2193244 INFO (qtp945999503-36833) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[24 (1629223734602629120)]} 0 0 [junit4] 2> 2193244 INFO (qtp1605456666-36894) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[24 (1629223734602629120)]} 0 0 [junit4] 2> 2193245 INFO (qtp945999503-36834) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[25 (1629223734603677696)]} 0 0 [junit4] 2> 2193245 INFO (qtp847510730-36855) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[25 (1629223734603677696)]} 0 0 [junit4] 2> 2193245 INFO (qtp945999503-36835) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[26 (1629223734603677697)]} 0 0 [junit4] 2> 2193246 INFO (qtp1297947521-36875) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[26 (1629223734604726272)]} 0 0 [junit4] 2> 2193246 INFO (qtp945999503-36833) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[27 (1629223734604726272)]} 0 0 [junit4] 2> 2193246 INFO (qtp1605456666-36897) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[27 (1629223734604726272)]} 0 0 [junit4] 2> 2193247 INFO (qtp945999503-36834) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[28 (1629223734605774848)]} 0 0 [junit4] 2> 2193247 INFO (qtp847510730-36854) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[28 (1629223734605774848)]} 0 0 [junit4] 2> 2193247 INFO (qtp945999503-36835) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[29 (1629223734605774849)]} 0 0 [junit4] 2> 2193248 INFO (qtp1297947521-36876) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[29 (1629223734605774848)]} 0 0 [junit4] 2> 2193248 INFO (qtp945999503-36833) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[30 (1629223734606823424)]} 0 0 [junit4] 2> 2193248 INFO (qtp1605456666-36898) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[30 (1629223734606823424)]} 0 0 [junit4] 2> 2193249 INFO (qtp945999503-36834) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[31 (1629223734606823425)]} 0 0 [junit4] 2> 2193249 INFO (qtp847510730-36856) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[31 (1629223734607872000)]} 0 0 [junit4] 2> 2193249 INFO (qtp945999503-36835) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[32 (1629223734607872000)]} 0 0 [junit4] 2> 2193249 INFO (qtp1297947521-36877) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[32 (1629223734607872000)]} 0 0 [junit4] 2> 2193250 INFO (qtp945999503-36833) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[33 (1629223734608920576)]} 0 0 [junit4] 2> 2193250 INFO (qtp1605456666-36894) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[33 (1629223734608920576)]} 0 0 [junit4] 2> 2193250 INFO (qtp945999503-36834) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[34 (1629223734608920577)]} 0 0 [junit4] 2> 2193251 INFO (qtp847510730-36855) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[34 (1629223734609969152)]} 0 0 [junit4] 2> 2193251 INFO (qtp945999503-36835) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[35 (1629223734609969152)]} 0 0 [junit4] 2> 2193251 INFO (qtp1297947521-36875) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[35 (1629223734609969152)]} 0 0 [junit4] 2> 2193252 INFO (qtp945999503-36833) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[36 (1629223734611017728)]} 0 0 [junit4] 2> 2193253 INFO (qtp1605456666-36897) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[36 (1629223734612066304)]} 0 0 [junit4] 2> 2193253 INFO (qtp945999503-36834) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[37 (1629223734612066304)]} 0 0 [junit4] 2> 2193254 INFO (qtp847510730-36854) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[37 (1629223734613114880)]} 0 0 [junit4] 2> 2193254 INFO (qtp945999503-36835) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[38 (1629223734613114880)]} 0 0 [junit4] 2> 2193254 INFO (qtp1297947521-36876) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[38 (1629223734613114880)]} 0 0 [junit4] 2> 2193255 INFO (qtp945999503-36833) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[39 (1629223734614163456)]} 0 0 [junit4] 2> 2193255 INFO (qtp1605456666-36898) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[39 (1629223734614163456)]} 0 0 [junit4] 2> 2193255 INFO (qtp945999503-36834) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[40 (1629223734614163457)]} 0 0 [junit4] 2> 2193256 INFO (qtp847510730-36856) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[40 (1629223734615212032)]} 0 0 [junit4] 2> 2193256 INFO (qtp945999503-36835) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[41 (1629223734615212032)]} 0 0 [junit4] 2> 2193256 INFO (qtp1297947521-36877) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[41 (1629223734615212032)]} 0 0 [junit4] 2> 2193257 INFO (qtp945999503-36833) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[42 (1629223734616260608)]} 0 0 [junit4] 2> 2193257 INFO (qtp1605456666-36894) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[42 (1629223734616260608)]} 0 0 [junit4] 2> 2193258 INFO (qtp945999503-36834) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[43 (1629223734617309184)]} 0 0 [junit4] 2> 2193258 INFO (qtp847510730-36855) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[43 (1629223734617309184)]} 0 0 [junit4] 2> 2193259 INFO (qtp945999503-36835) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[44 (1629223734617309185)]} 0 0 [junit4] 2> 2193259 INFO (qtp1297947521-36875) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[44 (1629223734618357760)]} 0 0 [junit4] 2> 2193259 INFO (qtp945999503-36833) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[45 (1629223734618357760)]} 0 0 [junit4] 2> 2193260 INFO (qtp1605456666-36897) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[45 (1629223734619406336)]} 0 0 [junit4] 2> 2193261 INFO (qtp945999503-36834) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[46 (1629223734620454912)]} 0 0 [junit4] 2> 2193262 INFO (qtp847510730-36854) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[46 (1629223734621503488)]} 0 0 [junit4] 2> 2193262 INFO (qtp945999503-36835) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[47 (1629223734621503488)]} 0 0 [junit4] 2> 2193263 INFO (qtp1297947521-36876) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[47 (1629223734621503488)]} 0 0 [junit4] 2> 2193263 INFO (qtp945999503-36833) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[48 (1629223734622552064)]} 0 0 [junit4] 2> 2193263 INFO (qtp1605456666-36898) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[48 (1629223734622552064)]} 0 0 [junit4] 2> 2193264 INFO (qtp945999503-36834) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[49 (1629223734623600640)]} 0 0 [junit4] 2> 2193264 INFO (qtp847510730-36856) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[49 (1629223734623600640)]} 0 0 [junit4] 2> 2193265 INFO (qtp945999503-36835) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[50 (1629223734624649216)]} 0 0 [junit4] 2> 2193266 INFO (qtp1297947521-36877) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[50 (1629223734625697792)]} 0 0 [junit4] 2> 2193267 INFO (qtp945999503-36833) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[51 (1629223734625697792)]} 0 0 [junit4] 2> 2193267 INFO (qtp1605456666-36894) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[51 (1629223734626746368)]} 0 0 [junit4] 2> 2193267 INFO (qtp945999503-36834) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[52 (1629223734626746368)]} 0 0 [junit4] 2> 2193268 INFO (qtp847510730-36855) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[52 (1629223734627794944)]} 0 0 [junit4] 2> 2193268 INFO (qtp945999503-36835) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[53 (1629223734627794944)]} 0 0 [junit4] 2> 2193268 INFO (qtp1297947521-36875) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[53 (1629223734627794944)]} 0 0 [junit4] 2> 2193270 INFO (qtp945999503-36833) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[54 (1629223734629892096)]} 0 0 [junit4] 2> 2193271 INFO (qtp1605456666-36897) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[54 (1629223734630940672)]} 0 0 [junit4] 2> 2193271 INFO (qtp945999503-36834) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[55 (1629223734630940672)]} 0 0 [junit4] 2> 2193271 INFO (qtp847510730-36854) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[55 (1629223734630940672)]} 0 0 [junit4] 2> 2193272 INFO (qtp945999503-36835) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[56 (1629223734631989248)]} 0 0 [junit4] 2> 2193272 INFO (qtp1297947521-36876) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[56 (1629223734631989248)]} 0 0 [junit4] 2> 2193273 INFO (qtp945999503-36833) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[57 (1629223734633037824)]} 0 0 [junit4] 2> 2193273 INFO (qtp1605456666-36898) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[57 (1629223734633037824)]} 0 0 [junit4] 2> 2193273 INFO (qtp945999503-36834) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[58 (1629223734633037825)]} 0 0 [junit4] 2> 2193275 INFO (qtp847510730-36856) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[58 (1629223734635134976)]} 0 0 [junit4] 2> 2193276 INFO (qtp945999503-36835) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[59 (1629223734636183552)]} 0 0 [junit4] 2> 2193276 INFO (qtp1297947521-36877) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[59 (1629223734636183552)]} 0 0 [junit4] 2> 2193277 INFO (qtp945999503-36833) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[60 (1629223734637232128)]} 0 0 [junit4] 2> 2193278 INFO (qtp1605456666-36894) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[60 (1629223734638280704)]} 0 0 [junit4] 2> 2193279 INFO (qtp945999503-36834) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[61 (1629223734638280704)]} 0 0 [junit4] 2> 2193279 INFO (qtp847510730-36855) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[61 (1629223734639329280)]} 0 0 [junit4] 2> 2193279 INFO (qtp945999503-36835) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[62 (1629223734639329280)]} 0 0 [junit4] 2> 2193280 INFO (qtp1297947521-36875) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[62 (1629223734640377856)]} 0 0 [junit4] 2> 2193280 INFO (qtp945999503-36833) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[63 (1629223734640377856)]} 0 0 [junit4] 2> 2193281 INFO (qtp1605456666-36897) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[63 (1629223734641426432)]} 0 0 [junit4] 2> 2193282 INFO (qtp945999503-36834) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[64 (1629223734642475008)]} 0 0 [junit4] 2> 2193283 INFO (qtp847510730-36854) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[64 (1629223734643523584)]} 0 0 [junit4] 2> 2193284 INFO (qtp945999503-36835) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[65 (1629223734643523584)]} 0 0 [junit4] 2> 2193284 INFO (qtp1297947521-36876) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[65 (1629223734644572160)]} 0 0 [junit4] 2> 2193284 INFO (qtp945999503-36833) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[66 (1629223734644572160)]} 0 0 [junit4] 2> 2193285 INFO (qtp1605456666-36898) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[66 (1629223734645620736)]} 0 0 [junit4] 2> 2193286 INFO (qtp945999503-36834) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[67 (1629223734645620736)]} 0 0 [junit4] 2> 2193286 INFO (qtp847510730-36856) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[67 (1629223734646669312)]} 0 0 [junit4] 2> 2193287 INFO (qtp945999503-36835) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[68 (1629223734647717888)]} 0 0 [junit4] 2> 2193288 INFO (qtp1297947521-36877) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[68 (1629223734648766464)]} 0 0 [junit4] 2> 2193288 INFO (qtp945999503-36833) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[69 (1629223734648766464)]} 0 0 [junit4] 2> 2193289 INFO (qtp1605456666-36894) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[69 (1629223734649815040)]} 0 0 [junit4] 2> 2193291 INFO (qtp945999503-36834) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[70 (1629223734650863616)]} 0 1 [junit4] 2> 2193292 INFO (qtp847510730-36855) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[70 (1629223734651912192)]} 0 0 [junit4] 2> 2193292 INFO (qtp945999503-36835) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[71 (1629223734652960768)]} 0 0 [junit4] 2> 2193292 INFO (qtp1297947521-36875) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[71 (1629223734652960768)]} 0 0 [junit4] 2> 2193293 INFO (qtp945999503-36833) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[72 (1629223734654009344)]} 0 0 [junit4] 2> 2193293 INFO (qtp1605456666-36897) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/zhz/o path=/update params={wt=javabin&version=2}{add=[72 (16 [...truncated too long message...] 557 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.badapples=true -Dtests.locale=en-TC -Dtests.timezone=Pacific/Efate -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1 [junit4] FAILURE 42.8s J1 | TestDistributedStatsComponentCardinality.test <<< [junit4] > Throwable #1: junit.framework.AssertionFailedError: .responseHeader.status:200!=0 [junit4] > at __randomizedtesting.SeedInfo.seed([6879376B74FB0557:E02D08B1DA0768AF]:0) [junit4] > at junit.framework.Assert.fail(Assert.java:57) [junit4] > at org.apache.solr.BaseDistributedSearchTestCase.compareSolrResponses(BaseDistributedSearchTestCase.java:999) [junit4] > at org.apache.solr.BaseDistributedSearchTestCase.compareResponses(BaseDistributedSearchTestCase.java:1026) [junit4] > at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:680) [junit4] > at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:643) [junit4] > at org.apache.solr.handler.component.TestDistributedStatsComponentCardinality.test(TestDistributedStatsComponentCardinality.java:143) [junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] > at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] > at java.base/java.lang.reflect.Method.invoke(Method.java:566) [junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1082) [junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1054) [junit4] > at java.base/java.lang.Thread.run(Thread.java:834) [junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-BadApples-master-Linux/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_6879376B74FB0557-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene80): {multiDefault=FSTOrd50, _root_=PostingsFormat(name=MockRandom), string_s=PostingsFormat(name=LuceneFixedGap), id=Lucene50(blocksize=128)}, docValues:{int_i=DocValuesFormat(name=Lucene80), range_facet_l_dv=DocValuesFormat(name=Lucene80), intDefault=DocValuesFormat(name=Asserting), int_i_prehashed_l=DocValuesFormat(name=Lucene80), range_facet_l=DocValuesFormat(name=Asserting), long_l_prehashed_l=DocValuesFormat(name=Lucene80), long_l=DocValuesFormat(name=Lucene80), _version_=DocValuesFormat(name=Asserting), string_s_prehashed_l=DocValuesFormat(name=Lucene80), id_i1=DocValuesFormat(name=Direct), range_facet_i_dv=DocValuesFormat(name=Asserting), intDvoDefault=DocValuesFormat(name=Lucene80), timestamp=DocValuesFormat(name=Asserting)}, maxPointsInLeafNode=1630, maxMBSortInHeap=6.669187709234681, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@794cc749), locale=en-TC, timezone=Pacific/Efate [junit4] 2> NOTE: Linux 4.18.0-15-generic amd64/Oracle Corporation 11 (64-bit)/cpus=8,threads=1,free=121208976,total=518979584 [junit4] 2> NOTE: All tests run in this JVM: [TestQuerySenderListener, TestStressLucene, SharedFSAutoReplicaFailoverTest, TestDynamicLoading, TestLegacyNumericRangeQueryBuilder, PrimUtilsTest, PeerSyncTest, TestSolrConfigHandlerCloud, TestNumericTokenStream, TestMacros, TestBlobHandler, CollectionPropsTest, TokenizerChainTest, TestDFISimilarityFactory, TestClusterProperties, DistributedSuggestComponentTest, TestNestedUpdateProcessor, SuggesterFSTTest, RestartWhileUpdatingTest, TolerantUpdateProcessorTest, TestSolrQueryParser, SolrRrdBackendFactoryTest, TestInfoStreamLogging, PeerSyncWithLeaderAndIndexFingerprintCachingTest, TestSolrCloudSnapshots, SolrMetricReporterTest, EnumFieldTest, HLLSerializationTest, TestReplicationHandlerBackup, TestCloudConsistency, CustomTermsComponentTest, SolrCloudExampleTest, CoreAdminRequestStatusTest, TestMinMaxOnMultiValuedField, TestStressUserVersions, TestSegmentSorting, QueryEqualityTest, TestSubQueryTransformerCrossCore, TestHighlightDedupGrouping, DistanceFunctionTest, DistributedUpdateProcessorTest, TestSolrCoreParser, DisMaxRequestHandlerTest, TestInitQParser, HdfsDirectoryTest, HighlighterMaxOffsetTest, TestChildDocTransformer, TestTolerantUpdateProcessorRandomCloud, TestXmlQParserPlugin, TestOverriddenPrefixQueryForCustomFieldType, MultiThreadedOCPTest, TestCollectionAPI, CategoryRoutedAliasUpdateProcessorTest, TestNonDefinedSimilarityFactory, ScriptEngineTest, DirectSolrSpellCheckerTest, LeaderVoteWaitTimeoutTest, TriggerEventQueueTest, LoggingHandlerTest, TestSweetSpotSimilarityFactory, TestReRankQParserPlugin, HdfsChaosMonkeySafeLeaderTest, TestZkChroot, LeaderFailoverAfterPartitionTest, MetricsConfigTest, BooleanFieldTest, ReplaceNodeNoTargetTest, TestRTimerTree, BaseCdcrDistributedZkTest, SpellCheckCollatorTest, TestSkipOverseerOperations, OverriddenZkACLAndCredentialsProvidersTest, DeleteShardTest, TestCloudRecovery, NodeLostTriggerIntegrationTest, DirectSolrConnectionTest, TestBlendedInfixSuggestions, RuleEngineTest, CoreAdminCreateDiscoverTest, TestCorePropertiesReload, TestConfigSetsAPIZkFailure, TestTolerantSearch, TimeZoneUtilsTest, TestSimClusterStateProvider, MoveReplicaHDFSTest, BitVectorTest, HdfsBasicDistributedZk2Test, HdfsCollectionsAPIDistributedZkTest, MigrateRouteKeyTest, InfixSuggestersTest, DistributedVersionInfoTest, TestLRUStatsCache, TestIntervalFaceting, TestUniqueKeyFieldResource, AliasIntegrationTest, CloudExitableDirectoryReaderTest, BlobRepositoryCloudTest, SpatialFilterTest, TestFuzzyAnalyzedSuggestions, UpdateLogTest, MetricTriggerTest, TestBadConfig, TestTrieFacet, TestInPlaceUpdatesRequiredField, SyncSliceTest, TestMissingGroups, V2ApiIntegrationTest, TestLeaderElectionZkExpiry, TestSolrDeletionPolicy1, BasicDistributedZk2Test, TestExceedMaxTermLength, TestDocTermOrdsUninvertLimit, TestSolrCloudWithSecureImpersonation, TestSearchPerf, ZkStateReaderTest, ConcurrentCreateRoutedAliasTest, DistributedExpandComponentTest, HdfsWriteToMultipleCollectionsTest, SolrIndexMetricsTest, TestLMDirichletSimilarityFactory, MetricUtilsTest, TestCloudPhrasesIdentificationComponent, TestRestoreCore, CdcrOpsAndBoundariesTest, TestEmbeddedSolrServerConstructors, OverseerTest, TestPHPSerializedResponseWriter, ClassificationUpdateProcessorTest, DistribDocExpirationUpdateProcessorTest, ZkControllerTest, TestRecoveryHdfs, IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestUnifiedSolrHighlighter, XmlInterpolationTest, IndexSchemaTest, TestPseudoReturnFields, TestFastOutputStream, TermVectorComponentDistributedTest, StatsReloadRaceTest, TestManagedResourceStorage, ConfigSetsAPITest, CreateCollectionCleanupTest, DeleteInactiveReplicaTest, DeleteLastCustomShardedReplicaTest, DeleteStatusTest, ForceLeaderTest, ForceLeaderWithTlogReplicasTest, HealthCheckHandlerTest, HttpPartitionTest, LeaderElectionContextKeyTest, LeaderFailureAfterFreshStartTest, NodeMutatorTest, OverseerCollectionConfigSetProcessorTest, OverseerModifyCollectionTest, OverseerStatusTest, RecoveryAfterSoftCommitTest, RecoveryZkTest, ReindexCollectionTest, TestDistributedMap, TestDownShardTolerantSearch, TestLockTree, TestMiniSolrCloudClusterSSL, TestOnReconnectListenerSupport, TestRandomRequestDistribution, TestStressCloudBlindAtomicUpdates, TestTlogReplica, TlogReplayBufferedWhileIndexingTest, TriLevelCompositeIdRoutingTest, VMParamsZkACLAndCredentialsProvidersTest, ZkFailoverTest, AssignTest, CollectionReloadTest, CollectionsAPIAsyncDistributedZkTest, TestCollectionsAPIViaSolrCloudCluster, AutoAddReplicasPlanActionTest, AutoScalingHandlerTest, ComputePlanActionTest, NodeMarkersRegistrationTest, ScheduledMaintenanceTriggerTest, ScheduledTriggerIntegrationTest, ScheduledTriggerTest, SearchRateTriggerTest, TriggerIntegrationTest, HdfsRecoveryZkTest, HdfsSyncSliceTest, HdfsThreadLeakTest, StressHdfsTest, RulesTest, ConfigureRecoveryStrategyTest, CoreSorterTest, DirectoryFactoryTest, ExitableDirectoryReaderTest, HdfsDirectoryFactoryTest, SolrCoreCheckLockOnStartupTest, TestConfig, TestConfigOverlay, TestConfigSetProperties, TestCoreContainer, TestLazyCores, CSVRequestHandlerTest, PingRequestHandlerTest, XmlUpdateRequestHandlerTest, XsltUpdateRequestHandlerTest, CoreMergeIndexesAdminHandlerTest, MBeansHandlerTest, DistributedQueryComponentCustomSortTest, ReplicaListTransformerTest, SearchHandlerTest, TestDistributedStatsComponentCardinality] [junit4] Completed [658/845 (1!)] on J1 in 43.10s, 1 test, 1 failure <<< FAILURES! [...truncated 43224 lines...] [repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-BadApples-master-Linux/184/consoleText [repro] Revision: 98cadcf9f6b8181bd04c867cce85906adfde828b [repro] Repro line: ant test -Dtestcase=TestDistributedStatsComponentCardinality -Dtests.method=test -Dtests.seed=6879376B74FB0557 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.badapples=true -Dtests.locale=en-TC -Dtests.timezone=Pacific/Efate -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1 [repro] ant clean [...truncated 6 lines...] [repro] Test suites by module: [repro] solr/core [repro] TestDistributedStatsComponentCardinality [repro] ant compile-test [...truncated 3569 lines...] [repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.TestDistributedStatsComponentCardinality" -Dtests.showOutput=onerror -Dtests.seed=6879376B74FB0557 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.badapples=true -Dtests.locale=en-TC -Dtests.timezone=Pacific/Efate -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1 [...truncated 78 lines...] [repro] Failures: [repro] 0/5 failed: org.apache.solr.handler.component.TestDistributedStatsComponentCardinality [repro] Exiting with code 0 [...truncated 43 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org