You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2020/06/15 07:25:37 UTC
[JENKINS-EA] Lucene-Solr-8.x-Windows (64bit/jdk-15-ea+24) - Build #
1269 - Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Windows/1269/
Java: 64bit/jdk-15-ea+24 -XX:-UseCompressedOops -XX:+UseSerialGC
1 tests failed.
FAILED: org.apache.solr.handler.TestReplicationHandler.doTestStressReplication
Error Message:
expected:<3> but was:<0>
Stack Trace:
java.lang.AssertionError: expected:<3> but was:<0>
at __randomizedtesting.SeedInfo.seed([3C1C9D1F19EC2954:E7B79DD91CC440E7]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.failNotEquals(Assert.java:834)
at org.junit.Assert.assertEquals(Assert.java:645)
at org.junit.Assert.assertEquals(Assert.java:631)
at org.apache.solr.handler.TestReplicationHandler.doTestStressReplication(TestReplicationHandler.java:955)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:64)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
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 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:832)
Build Log:
[...truncated 15863 lines...]
[junit4] Suite: org.apache.solr.handler.TestReplicationHandler
[junit4] 2> 1428575 INFO (SUITE-TestReplicationHandler-seed#[3C1C9D1F19EC2954]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of 'C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\server\solr\configsets\_default\conf'
[junit4] 2> 1428575 INFO (SUITE-TestReplicationHandler-seed#[3C1C9D1F19EC2954]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1428575 INFO (SUITE-TestReplicationHandler-seed#[3C1C9D1F19EC2954]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.handler.TestReplicationHandler_3C1C9D1F19EC2954-001\data-dir-199-001
[junit4] 2> 1428575 INFO (SUITE-TestReplicationHandler-seed#[3C1C9D1F19EC2954]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 1428575 INFO (SUITE-TestReplicationHandler-seed#[3C1C9D1F19EC2954]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl="None")
[junit4] 2> 1428578 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.SolrTestCaseJ4 ###Starting doTestIndexFetchOnMasterRestart
[junit4] 2> 1428578 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.handler.TestReplicationHandler_3C1C9D1F19EC2954-001\solr-instance-001\collection1
[junit4] 2> 1428591 WARN (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 1428591 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1428591 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1428591 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 15-ea+24-1168
[junit4] 2> 1428591 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1428591 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1428591 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1428592 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5489570f{/solr,null,AVAILABLE}
[junit4] 2> 1428593 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@2e76b358{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:63236}
[junit4] 2> 1428593 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.Server Started @1428377ms
[junit4] 2> 1428593 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.handler.TestReplicationHandler_3C1C9D1F19EC2954-001\solr-instance-001\collection1\data, hostPort=63236}
[junit4] 2> 1428593 ERROR (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1428593 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1428593 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.6.0
[junit4] 2> 1428593 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 1428593 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr
[junit4] 2> 1428593 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-06-15T07:03:07.141511Z
[junit4] 2> 1428593 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.handler.TestReplicationHandler_3C1C9D1F19EC2954-001\solr-instance-001\solr.xml
[junit4] 2> 1428596 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1428596 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1428597 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@4741a9a4, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1428759 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1428760 WARN (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@7ea1cea[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1428760 WARN (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@7ea1cea[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1428762 WARN (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@586e53ce[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1428762 WARN (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@586e53ce[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1428764 WARN (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 1428782 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1428782 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1428802 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4741a9a4
[junit4] 2> 1428809 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4741a9a4
[junit4] 2> 1428809 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4741a9a4
[junit4] 2> 1428810 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.handler.TestReplicationHandler_3C1C9D1F19EC2954-001\solr-instance-001
[junit4] 2> 1428810 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1428820 INFO (coreLoadExecutor-12607-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.6.0
[junit4] 2> 1428835 INFO (coreLoadExecutor-12607-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 1428837 INFO (coreLoadExecutor-12607-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 1428837 INFO (coreLoadExecutor-12607-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.handler.TestReplicationHandler_3C1C9D1F19EC2954-001\solr-instance-001\collection1, trusted=true
[junit4] 2> 1428837 INFO (coreLoadExecutor-12607-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@4741a9a4
[junit4] 2> 1428837 INFO (coreLoadExecutor-12607-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.handler.TestReplicationHandler_3C1C9D1F19EC2954-001\solr-instance-001\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.handler.TestReplicationHandler_3C1C9D1F19EC2954-001\solr-instance-001\collection1\data\]
[junit4] 2> 1428838 INFO (coreLoadExecutor-12607-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=17, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=10.2919921875, floorSegmentMB=0.521484375, forceMergeDeletesPctAllowed=17.503139648383776, segmentsPerTier=22.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6730019026004948, deletesPctAllowed=42.45490294730047
[junit4] 2> 1428897 INFO (coreLoadExecutor-12607-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1428897 INFO (coreLoadExecutor-12607-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1428897 INFO (coreLoadExecutor-12607-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=34.392578125, floorSegmentMB=1.462890625, forceMergeDeletesPctAllowed=11.22632205655636, segmentsPerTier=46.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, deletesPctAllowed=45.787867625726534
[junit4] 2> 1428898 INFO (coreLoadExecutor-12607-thread-1) [ x:collection1 ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.handler.TestReplicationHandler_3C1C9D1F19EC2954-001\solr-instance-001\collection1\conf
[junit4] 2> 1428898 INFO (coreLoadExecutor-12607-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 1428898 INFO (coreLoadExecutor-12607-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 1428899 INFO (searcherExecutor-12609-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1428900 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.handler.TestReplicationHandler_3C1C9D1F19EC2954-001\solr-instance-002\collection1
[junit4] 2> 1428908 WARN (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 1428908 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1428908 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1428908 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 15-ea+24-1168
[junit4] 2> 1428908 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1428908 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1428908 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1428908 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6978c1f4{/solr,null,AVAILABLE}
[junit4] 2> 1428910 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@6515f64f{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:63258}
[junit4] 2> 1428910 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.Server Started @1428694ms
[junit4] 2> 1428910 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.handler.TestReplicationHandler_3C1C9D1F19EC2954-001\solr-instance-002\collection1\data, hostPort=63258}
[junit4] 2> 1428910 ERROR (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1428910 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1428910 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.6.0
[junit4] 2> 1428910 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 1428910 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr
[junit4] 2> 1428910 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-06-15T07:03:07.458086700Z
[junit4] 2> 1428910 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.handler.TestReplicationHandler_3C1C9D1F19EC2954-001\solr-instance-002\solr.xml
[junit4] 2> 1428913 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1428913 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1428914 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@4741a9a4, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1429036 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1429037 WARN (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@6ecaa59[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1429037 WARN (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@6ecaa59[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1429039 WARN (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@2f4811e7[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1429039 WARN (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@2f4811e7[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1429039 WARN (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 1429066 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1429066 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1429085 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4741a9a4
[junit4] 2> 1429092 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4741a9a4
[junit4] 2> 1429092 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4741a9a4
[junit4] 2> 1429095 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.handler.TestReplicationHandler_3C1C9D1F19EC2954-001\solr-instance-002
[junit4] 2> 1429095 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1429100 INFO (coreLoadExecutor-12625-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.6.0
[junit4] 2> 1429108 INFO (coreLoadExecutor-12625-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 1429109 INFO (coreLoadExecutor-12625-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 1429109 INFO (coreLoadExecutor-12625-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.handler.TestReplicationHandler_3C1C9D1F19EC2954-001\solr-instance-002\collection1, trusted=true
[junit4] 2> 1429109 INFO (coreLoadExecutor-12625-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@4741a9a4
[junit4] 2> 1429109 INFO (coreLoadExecutor-12625-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.handler.TestReplicationHandler_3C1C9D1F19EC2954-001\solr-instance-002\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.handler.TestReplicationHandler_3C1C9D1F19EC2954-001\solr-instance-002\collection1\data\]
[junit4] 2> 1429111 INFO (coreLoadExecutor-12625-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=17, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=10.2919921875, floorSegmentMB=0.521484375, forceMergeDeletesPctAllowed=17.503139648383776, segmentsPerTier=22.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6730019026004948, deletesPctAllowed=42.45490294730047
[junit4] 2> 1429171 INFO (coreLoadExecutor-12625-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1429171 INFO (coreLoadExecutor-12625-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1429171 INFO (coreLoadExecutor-12625-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=34.392578125, floorSegmentMB=1.462890625, forceMergeDeletesPctAllowed=11.22632205655636, segmentsPerTier=46.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, deletesPctAllowed=45.787867625726534
[junit4] 2> 1429172 INFO (coreLoadExecutor-12625-thread-1) [ x:collection1 ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.handler.TestReplicationHandler_3C1C9D1F19EC2954-001\solr-instance-002\collection1\conf
[junit4] 2> 1429173 INFO (coreLoadExecutor-12625-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
[junit4] 2> 1429173 INFO (coreLoadExecutor-12625-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 1429173 INFO (searcherExecutor-12627-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1429174 INFO (qtp1298023818-19717) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
[junit4] 2> 1429174 INFO (indexFetcher-12631-thread-1) [ ] o.a.s.h.IndexFetcher Master's generation: 1
[junit4] 2> 1429174 INFO (indexFetcher-12631-thread-1) [ ] o.a.s.h.IndexFetcher Master's version: 0
[junit4] 2> 1429174 INFO (indexFetcher-12631-thread-1) [ ] o.a.s.h.IndexFetcher Slave's generation: 1
[junit4] 2> 1429174 INFO (indexFetcher-12631-thread-1) [ ] o.a.s.h.IndexFetcher Slave's version: 0
[junit4] 2> 1429174 INFO (indexFetcher-12631-thread-1) [ ] o.a.s.h.IndexFetcher New index in Master. Deleting mine...
[junit4] 2> 1429175 INFO (qtp1298023818-19719) [ x:collection1 ] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> 1429175 INFO (searcherExecutor-12627-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1429178 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=130772077
[junit4] 2> 1429178 INFO (coreCloseExecutor-12634-thread-1) [ ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@76b6c5c2
[junit4] 2> 1429178 INFO (coreCloseExecutor-12634-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1 tag=SolrCore@76b6c5c2
[junit4] 2> 1429178 INFO (coreCloseExecutor-12634-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@46ae5970: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1/com.codahale.metrics.MetricRegistry@7b3f36b2
[junit4] 2> 1429183 INFO (coreCloseExecutor-12634-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() ... SKIPPED (unnecessary).
[junit4] 2> 1429183 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
[junit4] 2> 1429183 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1b56d85a: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@381298cc
[junit4] 2> 1429186 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
[junit4] 2> 1429186 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1d70d5: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@283c8651
[junit4] 2> 1429188 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
[junit4] 2> 1429188 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@48d61ec9: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@38f9df62
[junit4] 2> 1429190 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@2e76b358{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 1429190 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@5489570f{/solr,null,UNAVAILABLE}
[junit4] 2> 1429190 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1429190 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=63236)
[junit4] 2> 1429190 WARN (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 1429190 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 63236 try number 2 ...
[junit4] 2> 1429190 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 15-ea+24-1168
[junit4] 2> 1429191 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1429191 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1429191 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1429192 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@53f04f15{/solr,null,AVAILABLE}
[junit4] 2> 1429193 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@4a9c8f1c{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:63236}
[junit4] 2> 1429193 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.Server Started @1428977ms
[junit4] 2> 1429193 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.handler.TestReplicationHandler_3C1C9D1F19EC2954-001\solr-instance-001\collection1\data, hostPort=63236}
[junit4] 2> 1429193 ERROR (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1429193 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1429193 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.6.0
[junit4] 2> 1429193 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 1429193 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr
[junit4] 2> 1429193 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-06-15T07:03:07.741002100Z
[junit4] 2> 1429193 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.handler.TestReplicationHandler_3C1C9D1F19EC2954-001\solr-instance-001\solr.xml
[junit4] 2> 1429196 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1429196 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1429197 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@4741a9a4, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1429360 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1429362 WARN (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@513cea1a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1429362 WARN (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@513cea1a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1429364 WARN (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@70f471ec[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1429364 WARN (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@70f471ec[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1429365 WARN (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 1429385 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1429385 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1429402 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4741a9a4
[junit4] 2> 1429410 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4741a9a4
[junit4] 2> 1429410 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4741a9a4
[junit4] 2> 1429413 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.handler.TestReplicationHandler_3C1C9D1F19EC2954-001\solr-instance-001
[junit4] 2> 1429413 INFO (TEST-TestReplicationHandler.doTestIndexFetchOnMasterRestart-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1429419 INFO (coreLoadExecutor-12648-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.6.0
[junit4] 2> 1429434 INFO (coreLoadExecutor-12648-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 1429435 INFO (coreLoadExecutor-12648-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 1429435 INFO (coreLoadExecutor-12648-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.handler.TestReplicationHandler_3C1C9D1F19EC2954-001\solr-instance-001\collection1, trusted=true
[junit4] 2> 1429436 INFO (coreLoadExecutor-12648-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@4741a9a4
[junit4] 2> 1429436 INFO (coreLoadExecutor-12648-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.handler.TestReplicationHandler_3C1C9D1F19EC2954-001\solr-instance-001\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.handler.TestReplicationHandler_3C1C9D1F19EC2954-001\solr-instance-001\collection1\data\]
[junit4] 2> 1429440 INFO (coreLoadExecutor-12648-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=12, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 1429530 INFO (coreLoadExecutor-12648-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1429530 INFO (coreLoadExecutor-12648-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1429532 INFO (coreLoadExecutor-12648-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=19, maxMergeAtOnceExplicit=15, maxMergedSegmentMB=58.181640625, floorSegmentMB=1.0537109375, forceMergeDeletesPctAllowed=13.364085648651225, segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.2289016040854043, deletesPctAllowed=20.074931169448135
[junit4] 2> 1429534 INFO (coreLoadExecutor-12648-thread-1) [ x:collection1 ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.handler.TestReplicationHandler_3C1C9D1F19EC2954-001\solr-instance-001\collection1\conf
[junit4] 2> 1429535 INFO (coreLoadExecutor-12648-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml
[junit4] 2> 1429535 INFO (coreLoadExecutor-12648-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 1429538 INFO (searcherExecutor-12650-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1429546 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[0]} 0 2
[junit4] 2> 1429547 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[1]} 0 0
[junit4] 2> 1429547 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[2]} 0 0
[junit4] 2> 1429548 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[3]} 0 0
[junit4] 2> 1429548 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[4]} 0 0
[junit4] 2> 1429548 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[5]} 0 0
[junit4] 2> 1429548 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[6]} 0 0
[junit4] 2> 1429549 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[7]} 0 0
[junit4] 2> 1429549 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[8]} 0 0
[junit4] 2> 1429549 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[9]} 0 0
[junit4] 2> 1429550 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[10]} 0 0
[junit4] 2> 1429550 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[11]} 0 0
[junit4] 2> 1429551 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[12]} 0 0
[junit4] 2> 1429551 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[13]} 0 0
[junit4] 2> 1429551 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[14]} 0 0
[junit4] 2> 1429552 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[15]} 0 0
[junit4] 2> 1429552 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[16]} 0 0
[junit4] 2> 1429552 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[17]} 0 0
[junit4] 2> 1429553 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[18]} 0 0
[junit4] 2> 1429553 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[19]} 0 0
[junit4] 2> 1429553 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[20]} 0 0
[junit4] 2> 1429554 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[21]} 0 0
[junit4] 2> 1429554 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[22]} 0 0
[junit4] 2> 1429557 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[23]} 0 0
[junit4] 2> 1429559 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[24]} 0 0
[junit4] 2> 1429559 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[25]} 0 0
[junit4] 2> 1429559 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[26]} 0 0
[junit4] 2> 1429560 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[27]} 0 0
[junit4] 2> 1429560 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[28]} 0 0
[junit4] 2> 1429560 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[29]} 0 0
[junit4] 2> 1429560 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[30]} 0 0
[junit4] 2> 1429560 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[31]} 0 0
[junit4] 2> 1429560 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[32]} 0 0
[junit4] 2> 1429560 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[33]} 0 0
[junit4] 2> 1429560 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[34]} 0 0
[junit4] 2> 1429560 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[35]} 0 0
[junit4] 2> 1429560 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[36]} 0 0
[junit4] 2> 1429560 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[37]} 0 0
[junit4] 2> 1429560 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[38]} 0 0
[junit4] 2> 1429560 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[39]} 0 0
[junit4] 2> 1429560 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[40]} 0 0
[junit4] 2> 1429560 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[41]} 0 0
[junit4] 2> 1429560 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[42]} 0 0
[junit4] 2> 1429560 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[43]} 0 0
[junit4] 2> 1429560 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[44]} 0 0
[junit4] 2> 1429560 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[45]} 0 0
[junit4] 2> 1429560 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[46]} 0 0
[junit4] 2> 1429565 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[47]} 0 0
[junit4] 2> 1429565 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[48]} 0 0
[junit4] 2> 1429565 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[49]} 0 0
[junit4] 2> 1429566 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[50]} 0 0
[junit4] 2> 1429566 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[51]} 0 0
[junit4] 2> 1429566 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[52]} 0 0
[junit4] 2> 1429566 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[53]} 0 0
[junit4] 2> 1429566 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[54]} 0 0
[junit4] 2> 1429567 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[55]} 0 0
[junit4] 2> 1429567 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[56]} 0 0
[junit4] 2> 1429567 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[57]} 0 0
[junit4] 2> 1429567 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[58]} 0 0
[junit4] 2> 1429567 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[59]} 0 0
[junit4] 2> 1429568 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[60]} 0 0
[junit4] 2> 1429568 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[61]} 0 0
[junit4] 2> 1429569 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[62]} 0 0
[junit4] 2> 1429569 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[63]} 0 0
[junit4] 2> 1429569 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[64]} 0 0
[junit4] 2> 1429569 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[65]} 0 0
[junit4] 2> 1429570 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[66]} 0 0
[junit4] 2> 1429570 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[67]} 0 0
[junit4] 2> 1429570 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[68]} 0 0
[junit4] 2> 1429570 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[69]} 0 0
[junit4] 2> 1429570 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[70]} 0 0
[junit4] 2> 1429571 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[71]} 0 0
[junit4] 2> 1429571 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[72]} 0 0
[junit4] 2> 1429571 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[73]} 0 0
[junit4] 2> 1429571 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[74]} 0 0
[junit4] 2> 1429571 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[75]} 0 0
[junit4] 2> 1429572 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[76]} 0 0
[junit4] 2> 1429572 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[77]} 0 0
[junit4] 2> 1429572 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[78]} 0 0
[junit4] 2> 1429572 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[79]} 0 0
[junit4] 2> 1429572 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[80]} 0 0
[junit4] 2> 1429573 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[81]} 0 0
[junit4] 2> 1429573 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[82]} 0 0
[junit4] 2> 1429573 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[83]} 0 0
[junit4] 2> 1429573 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[84]} 0 0
[junit4] 2> 1429573 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[85]} 0 0
[junit4] 2> 1429574 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[86]} 0 0
[junit4] 2> 1429574 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[87]} 0 0
[junit4] 2> 1429574 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[88]} 0 0
[junit4] 2> 1429574 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[89]} 0 0
[junit4] 2> 1429574 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[90]} 0 0
[junit4] 2> 1429575 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[91]} 0 0
[junit4] 2> 1429575 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[92]} 0 0
[junit4] 2> 1429575 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[93]} 0 0
[junit4] 2> 1429575 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[94]} 0 0
[junit4] 2> 1429575 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[95]} 0 0
[junit4] 2> 1429576 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[96]} 0 0
[junit4] 2> 1429576 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[97]} 0 0
[junit4] 2> 1429576 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[98]} 0 0
[junit4] 2> 1429576 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[99]} 0 0
[junit4] 2> 1429576 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[100]} 0 0
[junit4] 2> 1429577 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[101]} 0 0
[junit4] 2> 1429577 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[102]} 0 0
[junit4] 2> 1429577 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[103]} 0 0
[junit4] 2> 1429577 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[104]} 0 0
[junit4] 2> 1429577 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[105]} 0 0
[junit4] 2> 1429578 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[106]} 0 0
[junit4] 2> 1429578 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[107]} 0 0
[junit4] 2> 1429578 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[108]} 0 0
[junit4] 2> 1429578 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[109]} 0 0
[junit4] 2> 1429578 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[110]} 0 0
[junit4] 2> 1429579 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[111]} 0 0
[junit4] 2> 1429579 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[112]} 0 0
[junit4] 2> 1429579 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[113]} 0 0
[junit4] 2> 1429580 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[114]} 0 0
[junit4] 2> 1429580 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[115]} 0 0
[junit4] 2> 1429580 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[116]} 0 0
[junit4] 2> 1429580 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[117]} 0 0
[junit4] 2> 1429580 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[118]} 0 0
[junit4] 2> 1429580 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[119]} 0 0
[junit4] 2> 1429580 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[120]} 0 0
[junit4] 2> 1429580 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[121]} 0 0
[junit4] 2> 1429581 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[122]} 0 0
[junit4] 2> 1429581 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[123]} 0 0
[junit4] 2> 1429582 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[124]} 0 0
[junit4] 2> 1429582 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[125]} 0 0
[junit4] 2> 1429582 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[126]} 0 0
[junit4] 2> 1429582 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[127]} 0 0
[junit4] 2> 1429583 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[128]} 0 0
[junit4] 2> 1429583 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[129]} 0 0
[junit4] 2> 1429583 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[130]} 0 0
[junit4] 2> 1429583 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[131]} 0 0
[junit4] 2> 1429583 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[132]} 0 0
[junit4] 2> 1429583 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[133]} 0 0
[junit4] 2> 1429584 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[134]} 0 0
[junit4] 2> 1429584 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[135]} 0 0
[junit4] 2> 1429584 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[136]} 0 0
[junit4] 2> 1429584 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[137]} 0 0
[junit4] 2> 1429584 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[138]} 0 0
[junit4] 2> 1429585 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[139]} 0 0
[junit4] 2> 1429585 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[140]} 0 0
[junit4] 2> 1429585 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[141]} 0 0
[junit4] 2> 1429585 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[142]} 0 0
[junit4] 2> 1429586 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[143]} 0 0
[junit4] 2> 1429586 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[144]} 0 0
[junit4] 2> 1429586 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[145]} 0 0
[junit4] 2> 1429586 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[146]} 0 0
[junit4] 2> 1429586 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[147]} 0 0
[junit4] 2> 1429587 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[148]} 0 0
[junit4] 2> 1429587 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[149]} 0 0
[junit4] 2> 1429587 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[150]} 0 0
[junit4] 2> 1429587 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[151]} 0 0
[junit4] 2> 1429587 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[152]} 0 0
[junit4] 2> 1429587 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[153]} 0 0
[junit4] 2> 1429587 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[154]} 0 0
[junit4] 2> 1429588 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[155]} 0 0
[junit4] 2> 1429588 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[156]} 0 0
[junit4] 2> 1429588 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[157]} 0 0
[junit4] 2> 1429589 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[158]} 0 0
[junit4] 2> 1429589 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[159]} 0 0
[junit4] 2> 1429589 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[160]} 0 0
[junit4] 2> 1429589 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[161]} 0 0
[junit4] 2> 1429589 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[162]} 0 0
[junit4] 2> 1429589 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[163]} 0 0
[junit4] 2> 1429589 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[164]} 0 0
[junit4] 2> 1429590 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[165]} 0 0
[junit4] 2> 1429590 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[166]} 0 0
[junit4] 2> 1429590 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[167]} 0 0
[junit4] 2> 1429590 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[168]} 0 0
[junit4] 2> 1429591 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[169]} 0 0
[junit4] 2> 1429591 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[170]} 0 0
[junit4] 2> 1429591 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[171]} 0 0
[junit4] 2> 1429592 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[172]} 0 0
[junit4] 2> 1429592 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[173]} 0 0
[junit4] 2> 1429592 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[174]} 0 0
[junit4] 2> 1429592 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[175]} 0 0
[junit4] 2> 1429593 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[176]} 0 0
[junit4] 2> 1429593 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[177]} 0 0
[junit4] 2> 1429593 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[178]} 0 0
[junit4] 2> 1429593 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[179]} 0 0
[junit4] 2> 1429593 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[180]} 0 0
[junit4] 2> 1429594 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[181]} 0 0
[junit4] 2> 1429594 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[182]} 0 0
[junit4] 2> 1429594 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[183]} 0 0
[junit4] 2> 1429594 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[184]} 0 0
[junit4] 2> 1429594 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[185]} 0 0
[junit4] 2> 1429594 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[186]} 0 0
[junit4] 2> 1429594 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[187]} 0 0
[junit4] 2> 1429594 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[188]} 0 0
[junit4] 2> 1429594 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[189]} 0 0
[junit4] 2> 1429594 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[190]} 0 0
[junit4] 2> 1429594 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[191]} 0 0
[junit4] 2> 1429594 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[192]} 0 0
[junit4] 2> 1429594 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[193]} 0 0
[junit4] 2> 1429594 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[194]} 0 0
[junit4] 2> 1429594 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[195]} 0 0
[junit4] 2> 1429594 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[196]} 0 0
[junit4] 2> 1429594 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[197]} 0 0
[junit4] 2> 1429594 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[198]} 0 0
[junit4] 2> 1429594 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[199]} 0 0
[junit4] 2> 1429594 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[200]} 0 0
[junit4] 2> 1429594 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[201]} 0 0
[junit4] 2> 1429594 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[202]} 0 0
[junit4] 2> 1429594 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[203]} 0 0
[junit4] 2> 1429594 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[204]} 0 0
[junit4] 2> 1429598 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[205]} 0 0
[junit4] 2> 1429598 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[206]} 0 0
[junit4] 2> 1429599 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[207]} 0 0
[junit4] 2> 1429599 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[208]} 0 0
[junit4] 2> 1429599 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[209]} 0 0
[junit4] 2> 1429599 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[210]} 0 0
[junit4] 2> 1429599 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[211]} 0 0
[junit4] 2> 1429600 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[212]} 0 0
[junit4] 2> 1429600 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[213]} 0 0
[junit4] 2> 1429600 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[214]} 0 0
[junit4] 2> 1429600 INFO (qtp976472505-19766) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[215]} 0 0
[junit4] 2> 1429600 INFO (qtp976472505-19765) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[216]} 0 0
[junit4] 2> 1429601 INFO (qtp976472505-19767) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[217]} 0 0
[junit4] 2> 1429601 INFO (qtp976472505-19764) [ x:collection1 ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&v
[...truncated too long message...]
cRegistry@58be2611
[junit4] 2> 1533426 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
[junit4] 2> 1533426 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@c41d6ed: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@283c8651
[junit4] 2> 1533426 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
[junit4] 2> 1533426 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@7c79cf83: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@38f9df62
[junit4] 2> 1533429 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@637252ed{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 1533429 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@46dd3b77{/solr,null,UNAVAILABLE}
[junit4] 2> 1533429 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1533430 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=202815102
[junit4] 2> 1533431 INFO (coreCloseExecutor-14094-thread-1) [ ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@63fde251
[junit4] 2> 1533431 INFO (coreCloseExecutor-14094-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1 tag=SolrCore@63fde251
[junit4] 2> 1533431 INFO (coreCloseExecutor-14094-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1fcbeb85: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1/com.codahale.metrics.MetricRegistry@7732d1ee
[junit4] 2> 1533439 INFO (coreCloseExecutor-14094-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() ... SKIPPED (unnecessary).
[junit4] 2> 1533441 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
[junit4] 2> 1533441 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@e44235d: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@1860c035
[junit4] 2> 1533444 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
[junit4] 2> 1533444 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@78c1f02b: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@283c8651
[junit4] 2> 1533446 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
[junit4] 2> 1533446 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[3C1C9D1F19EC2954]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@14d89afc: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@38f9df62
[junit4] 2> 1533450 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@641b3c25{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 1533451 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@716bb1cb{/solr,null,UNAVAILABLE}
[junit4] 2> 1533451 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[3C1C9D1F19EC2954]) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J4\temp\solr.handler.TestReplicationHandler_3C1C9D1F19EC2954-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene86): {name=PostingsFormat(name=LuceneFixedGap), id=PostingsFormat(name=LuceneFixedGap), newname=PostingsFormat(name=LuceneFixedGap)}, docValues:{}, maxPointsInLeafNode=1977, maxMBSortInHeap=5.99017867642784, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@2cc99fdf), locale=en-US, timezone=Australia/Melbourne
[junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 15-ea (64-bit)/cpus=6,threads=1,free=194930656,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [HealthCheckHandlerTest, TestQueryUtils, TestUniqueKeyFieldResource, TestCollapseQParserPlugin, SegmentsInfoRequestHandlerTest, PeerSyncWithLeaderTest, TestSearchPerf, TestDynamicFieldResource, TestScoreJoinQPScore, SolrJmxReporterCloudTest, DisMaxRequestHandlerTest, RollingRestartTest, TestIBSimilarityFactory, TestTlogReplayVsRecovery, MetricsHistoryWithAuthIntegrationTest, TestConfigSetsAPI, AnalysisErrorHandlingTest, HdfsTlogReplayBufferedWhileIndexingTest, ShardRoutingTest, DateFieldTest, HLLUtilTest, TestTestInjection, HttpPartitionWithTlogReplicasTest, TestManagedSchema, DistributedFacetPivotLargeTest, TestHashPartitioner, TestRandomFlRTGCloud, ZkNodePropsTest, XmlUpdateRequestHandlerTest, TestSegmentSorting, TestTrieFacet, TestGraphMLResponseWriter, CategoryRoutedAliasUpdateProcessorTest, TestEmbeddedSolrServerSchemaAPI, ComputePlanActionTest, SolrPluginUtilsTest, CollectionReloadTest, TestReloadAndDeleteDocs, CleanupOldIndexTest, CdcrReplicationHandlerTest, EnumFieldTest, VersionInfoTest, TestHttpShardHandlerFactory, SolrIndexMetricsTest, TestSchemaField, BadIndexSchemaTest, ConcurrentDeleteAndCreateCollectionTest, TestSolrDeletionPolicy2, TriggerSetPropertiesIntegrationTest, ExitableDirectoryReaderTest, UninvertDocValuesMergePolicyTest, TestCloudManagedSchema, SuggesterFSTTest, ProtectedTermFilterFactoryTest, UniqFieldsUpdateProcessorFactoryTest, TestCloudPseudoReturnFields, TestPartialUpdateDeduplication, RemoteQueryErrorTest, TestSortByMinMaxFunction, RequestLoggingTest, ZookeeperReadAPITest, TestRTimerTree, TestJsonFacetErrors, ConnectionManagerTest, TestUseDocValuesAsStored, NodeAddedTriggerTest, TestMaxScoreQueryParser, DirectSolrConnectionTest, TestCorePropertiesReload, TestSolrCoreProperties, SmileWriterTest, NotRequiredUniqueKeyTest, DefaultValueUpdateProcessorTest, TestCoreBackup, PreAnalyzedFieldTest, TestWaitForStateWithJettyShutdowns, OutOfBoxZkACLAndCredentialsProvidersTest, QueryEqualityTest, CollectionPropsTest, TestFacetMethods, TestDistribIDF, TestRawTransformer, SimpleMLTQParserTest, DOMUtilTest, TestInPlaceUpdateWithRouteField, SolrXmlInZkTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest, ZkCollectionPropsCachingTest, DistributedIntervalFacetingTest, EchoParamsTest, MinimalSchemaTest, OutputWriterTest, SampleTest, SolrInfoBeanTest, SolrTestCaseJ4Test, TestCrossCoreJoin, TestCursorMarkWithoutUniqueKey, TestDistributedGrouping, TestDistributedMissingSort, TestDistributedSearch, BasicZkTest, ChaosMonkeyNothingIsSafeTest, DistribCursorPagingTest, DistributedVersionInfoTest, LeaderFailoverAfterPartitionTest, OverriddenZkACLAndCredentialsProvidersTest, SyncSliceTest, TestOnReconnectListenerSupport, TestSolrCloudWithKerberosAlt, TestZkChroot, HdfsCollectionsAPIDistributedZkTest, ShardSplitTest, BlobRepositoryCloudTest, TestConfig, TestConfigOverlay, TestCustomStream, TestSolrCoreSnapshots, CSVRequestHandlerTest, TestHdfsBackupRestoreCore, TestReplicationHandler]
[junit4] Completed [682/910 (1!)] on J4 in 105.09s, 21 tests, 1 failure <<< FAILURES!
[...truncated 45549 lines...]
[repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Windows/1269/consoleText
[repro] Revision: c8bb3bdb524ea609d20ce566944d54a2a648b7ce
[repro] Ant options: "-Dargs=-XX:-UseCompressedOops -XX:+UseSerialGC"
[repro] JUnit rest result XML files will be moved to: ./repro-reports
[repro] ant clean
[...truncated 6 lines...]
[repro] Test suites by module:
[repro] solr\core
[repro] TestReplicationHandler
[repro] ant compile-test
[...truncated 3472 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.TestReplicationHandler" -Dtests.showOutput=onerror "-Dargs=-XX:-UseCompressedOops -XX:+UseSerialGC" -Dtests.seed=3C1C9D1F19EC2954 -Dtests.slow=true -Dtests.locale=en-US -Dtests.timezone=Australia/Melbourne -Dtests.asserts=true -Dtests.file.encoding=Cp1252
[...truncated 182 lines...]
[repro] Failures w/original seeds:
[repro] 0/5 failed: org.apache.solr.handler.TestReplicationHandler
[repro] Exiting with code 0
[...truncated 78 lines...]
[JENKINS] Lucene-Solr-8.x-Windows (64bit/jdk-12.0.2) - Build # 1270
- Still Unstable!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Windows/1270/
Java: 64bit/jdk-12.0.2 -XX:+UseCompressedOops -XX:+UseSerialGC
1 tests failed.
FAILED: org.apache.solr.cloud.ActionThrottleTest.testBasics
Error Message:
994ms
Stack Trace:
java.lang.AssertionError: 994ms
at __randomizedtesting.SeedInfo.seed([E7DA0D4C95EC9364:DA02A360AD02CD14]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.assertTrue(Assert.java:41)
at org.apache.solr.cloud.ActionThrottleTest.testBasics(ActionThrottleTest.java:87)
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:567)
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 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:835)
Build Log:
[...truncated 15017 lines...]
[junit4] Suite: org.apache.solr.cloud.ActionThrottleTest
[junit4] 2> 1067990 INFO (SUITE-ActionThrottleTest-seed#[E7DA0D4C95EC9364]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of 'C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\server\solr\configsets\_default\conf'
[junit4] 2> 1067990 INFO (SUITE-ActionThrottleTest-seed#[E7DA0D4C95EC9364]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1067992 INFO (SUITE-ActionThrottleTest-seed#[E7DA0D4C95EC9364]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J2\temp\solr.cloud.ActionThrottleTest_E7DA0D4C95EC9364-001\data-dir-89-001
[junit4] 2> 1067992 WARN (SUITE-ActionThrottleTest-seed#[E7DA0D4C95EC9364]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
[junit4] 2> 1067993 INFO (SUITE-ActionThrottleTest-seed#[E7DA0D4C95EC9364]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 1067994 INFO (SUITE-ActionThrottleTest-seed#[E7DA0D4C95EC9364]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, clientAuth=0.0/0.0)
[junit4] 2> 1067995 INFO (TEST-ActionThrottleTest.testAZeroNanoTimeReturnInWait-seed#[E7DA0D4C95EC9364]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testAZeroNanoTimeReturnInWait
[junit4] 2> 1067995 INFO (TEST-ActionThrottleTest.testAZeroNanoTimeReturnInWait-seed#[E7DA0D4C95EC9364]) [ ] o.a.s.c.ActionThrottle Throttling test attempts - waiting for 1000ms
[junit4] 2> 1068997 INFO (TEST-ActionThrottleTest.testAZeroNanoTimeReturnInWait-seed#[E7DA0D4C95EC9364]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testAZeroNanoTimeReturnInWait
[junit4] 2> 1068997 INFO (TEST-ActionThrottleTest.testBasics-seed#[E7DA0D4C95EC9364]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testBasics
[junit4] 2> 1068997 INFO (TEST-ActionThrottleTest.testBasics-seed#[E7DA0D4C95EC9364]) [ ] o.a.s.c.ActionThrottle Throttling test attempts - waiting for 1000ms
[junit4] 2> 1069997 INFO (TEST-ActionThrottleTest.testBasics-seed#[E7DA0D4C95EC9364]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testBasics
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ActionThrottleTest -Dtests.method=testBasics -Dtests.seed=E7DA0D4C95EC9364 -Dtests.slow=true -Dtests.locale=en-JM -Dtests.timezone=Eire -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 1.00s J2 | ActionThrottleTest.testBasics <<<
[junit4] > Throwable #1: java.lang.AssertionError: 994ms
[junit4] > at __randomizedtesting.SeedInfo.seed([E7DA0D4C95EC9364:DA02A360AD02CD14]:0)
[junit4] > at org.apache.solr.cloud.ActionThrottleTest.testBasics(ActionThrottleTest.java:87)
[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:567)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:835)
[junit4] 2> 1070001 INFO (TEST-ActionThrottleTest.testCreateNewThrottleWithLastValue-seed#[E7DA0D4C95EC9364]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testCreateNewThrottleWithLastValue
[junit4] 2> 1070001 INFO (TEST-ActionThrottleTest.testCreateNewThrottleWithLastValue-seed#[E7DA0D4C95EC9364]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testCreateNewThrottleWithLastValue
[junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J2\temp\solr.cloud.ActionThrottleTest_E7DA0D4C95EC9364-001
[junit4] 2> NOTE: test params are: codec=Lucene86, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@bdf41d4), locale=en-JM, timezone=Eire
[junit4] 2> NOTE: Windows 10 10.0 amd64/AdoptOpenJDK 12.0.2 (64-bit)/cpus=6,threads=1,free=209964880,total=464089088
[junit4] 2> NOTE: All tests run in this JVM: [DistributedVersionInfoTest, TestNestedDocsSort, TestTolerantUpdateProcessorRandomCloud, TestManagedSynonymGraphFilterFactory, TestSimLargeCluster, HttpPartitionOnCommitTest, CopyFieldTest, RecoveryZkTest, TestExceedMaxTermLength, SchemaApiFailureTest, FullHLLTest, BasicDistributedZkTest, TestJsonRequest, CollectionsAPIDistributedZkTest, TestDocTermOrdsUninvertLimit, TestTrie, LegacyCloudClusterPropTest, TestQuerySenderListener, ImplicitSnitchTest, MetricTriggerTest, TestMinMaxOnMultiValuedField, TestLuceneMatchVersion, TestPushWriter, SolrMetricsIntegrationTest, SuggestComponentContextFilterQueryTest, OverseerModifyCollectionTest, IndexBasedSpellCheckerTest, TestDocumentBuilder, QueryResultKeyTest, ClusterStateTest, CoreSorterTest, ConvertedLegacyTest, AutoAddReplicasPlanActionTest, TestConfig, PolyFieldTest, TestRandomFaceting, SaslZkACLProviderTest, TestAddFieldRealTimeGet, TestUninvertingReader, LoggingHandlerTest, ResponseHeaderTest, ReplicationFactorTest, TestJsonFacetsStatsParsing, TestMultiValuedNumericRangeQuery, TestSubQueryTransformerDistrib, OverseerTaskQueueTest, MinimalSchemaTest, TestSimTriggerIntegration, AtomicUpdateRemovalJavabinTest, ScriptEngineTest, SimplePostToolTest, LeaderElectionTest, TestXmlQParserPlugin, TestZkAclsWithHadoopAuth, NodeMarkersRegistrationTest, SearchRateTriggerIntegrationTest, TestSmileRequest, TestLockTree, TestMaxTokenLenTokenizer, TestMacros, TestRequestForwarding, DeleteInactiveReplicaTest, CdcrWithNodesRestartsTest, SuggesterWFSTTest, HdfsSyncSliceTest, TestFreeTextSuggestions, SolrCmdDistributorTest, TestChildDocTransformer, CdcrBootstrapTest, TestInPlaceUpdatesStandalone, HttpTriggerListenerTest, BlockDirectoryTest, CoreMergeIndexesAdminHandlerTest, CloudReplicaSourceTest, DistributedFacetPivotSmallTest, LargeFieldTest, TestOmitPositions, MoreLikeThisHandlerTest, TestSurroundQueryParser, TestComponentsName, ClassificationUpdateProcessorTest, BinaryUpdateRequestHandlerTest, ResponseLogComponentTest, MetricUtilsTest, TestUnifiedSolrHighlighterWithoutStoredId, TestLRUStatsCache, TestCollationFieldDocValues, DirectUpdateHandlerTest, TokenizerChainTest, TestLuceneIndexBackCompat, TestEmbeddedSolrServerAdminHandler, TestEmbeddedSolrServerConstructors, TestEmbeddedSolrServerSchemaAPI, TestJettySolrRunner, ConnectionReuseTest, ActionThrottleTest]
[junit4] Completed [454/910 (1!)] on J2 in 2.27s, 3 tests, 1 failure <<< FAILURES!
[...truncated 49020 lines...]
[repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Windows/1270/consoleText
[repro] Revision: c8bb3bdb524ea609d20ce566944d54a2a648b7ce
[repro] Ant options: "-Dargs=-XX:+UseCompressedOops -XX:+UseSerialGC"
[repro] JUnit rest result XML files will be moved to: ./repro-reports
[repro] ant clean
[...truncated 6 lines...]
[repro] Test suites by module:
[repro] solr\core
[repro] ActionThrottleTest
[repro] ant compile-test
[...truncated 3472 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.ActionThrottleTest" -Dtests.showOutput=onerror "-Dargs=-XX:+UseCompressedOops -XX:+UseSerialGC" -Dtests.seed=E7DA0D4C95EC9364 -Dtests.slow=true -Dtests.locale=en-JM -Dtests.timezone=Eire -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[...truncated 92 lines...]
[repro] Failures w/original seeds:
[repro] 0/5 failed: org.apache.solr.cloud.ActionThrottleTest
[repro] Exiting with code 0
[...truncated 78 lines...]