Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Windows/591/
Java: 64bit/jdk1.8.0_201 -XX:+UseCompressedOops -XX:+UseG1GC
2 tests failed.
FAILED:
org.apache.solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest.testConcurrentUpdate
Error Message:
Expected CUSS to send 500 but got 482
Stack Trace:
java.lang.AssertionError: Expected CUSS to send 500 but got 482
at
__randomizedtesting.SeedInfo.seed([2B5284771F7CB908:D354DD8CCB44DC43]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.assertTrue(Assert.java:41)
at
org.apache.solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest.testConcurrentUpdate(ConcurrentUpdateHttp2SolrClientTest.java:102)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java: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
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
FAILED:
org.apache.solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest.testConcurrentUpdate
Error Message:
Expected CUSS to send 500 but got 495
Stack Trace:
java.lang.AssertionError: Expected CUSS to send 500 but got 495
at
__randomizedtesting.SeedInfo.seed([2B5284771F7CB908:D354DD8CCB44DC43]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.assertTrue(Assert.java:41)
at
org.apache.solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest.testConcurrentUpdate(ConcurrentUpdateHttp2SolrClientTest.java:102)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java: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
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 16870 lines...]
[junit4] Suite:
org.apache.solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest
[junit4] 2> 38749 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.SolrTestCaseJ4 Created dataDir:
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\data-dir-3-001
[junit4] 2> 38749 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 38751 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 38808 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 39195 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 39195 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 39197 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.SolrTestCaseJ4 Writing core.properties file to
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\tempDir-002\cores\core
[junit4] 2> 39225 WARN
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 39226 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 39226 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 39226 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git:
afcf563148970e98786327af5e07c261fda175d3; jvm 1.8.0_201-b09
[junit4] 2> 39227 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 39227 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 39227 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 39228 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@5e6becd4{/solr,null,AVAILABLE}
[junit4] 2> 39233 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.e.j.s.AbstractConnector Started ServerConnector@7bc4f635{SSL,[ssl,
http/1.1]}{127.0.0.1:49919}
[junit4] 2> 39233 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.e.j.s.Server Started @39288ms
[junit4] 2> 39233 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=49919,
configSetBaseDir=C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\tempDir-001,
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\tempDir-002\cores}
[junit4] 2> 39234 ERROR
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 39234 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 39234 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
8.5.0
[junit4] 2> 39234 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on
port null
[junit4] 2> 39234 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 39234 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2019-12-12T10:58:21.936Z
[junit4] 2> 39234 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.c.SolrXmlConfig Loading container configuration from
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\tempDir-001\solr.xml
[junit4] 2> 39248 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@20082fa4, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 39487 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 39490 WARN
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport
since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 39511 WARN
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.e.j.u.s.S.config Trusting all certificates configured for
Client@3b5c799a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 39511 WARN
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@3b5c799a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 39524 WARN
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport
since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 39582 WARN
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.e.j.u.s.S.config Trusting all certificates configured for
Client@1e2300d9[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 39582 WARN
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@1e2300d9[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 39583 WARN
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] 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> 39705 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for
2147483647 transient cores
[junit4] 2> 39706 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics
history in memory.
[junit4] 2> 39773 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@20082fa4
[junit4] 2> 39787 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@20082fa4
[junit4] 2> 39787 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@20082fa4
[junit4] 2> 39808 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\tempDir-001
[junit4] 2> 39808 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 39944 WARN (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.c.SolrConfig Couldn't add files from
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\tempDir-001\collection1\..\..\..\..\contrib\extraction\lib
filtered by .*\.jar to classpath:
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\tempDir-001\collection1\..\..\..\..\contrib\extraction\lib
[junit4] 2> 39944 WARN (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.c.SolrConfig Couldn't add files from
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\tempDir-001\collection1\..\..\..\..\dist
filtered by solr-cell-\d.*\.jar to classpath:
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\tempDir-001\collection1\..\..\..\..\dist
[junit4] 2> 39944 WARN (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.c.SolrConfig Couldn't add files from
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\tempDir-001\collection1\..\..\..\..\contrib\clustering\lib
filtered by .*\.jar to classpath:
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\tempDir-001\collection1\..\..\..\..\contrib\clustering\lib
[junit4] 2> 39944 WARN (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.c.SolrConfig Couldn't add files from
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\tempDir-001\collection1\..\..\..\..\dist
filtered by solr-clustering-\d.*\.jar to classpath:
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\tempDir-001\collection1\..\..\..\..\dist
[junit4] 2> 39948 WARN (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.c.SolrConfig Couldn't add files from
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\tempDir-001\collection1\..\..\..\..\contrib\langid\lib
filtered by .*\.jar to classpath:
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\tempDir-001\collection1\..\..\..\..\contrib\langid\lib
[junit4] 2> 39948 WARN (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.c.SolrConfig Couldn't add files from
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\tempDir-001\collection1\..\..\..\..\dist
filtered by solr-langid-\d.*\.jar to classpath:
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\tempDir-001\collection1\..\..\..\..\dist
[junit4] 2> 39948 WARN (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.c.SolrConfig Couldn't add files from
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\tempDir-001\collection1\..\..\..\..\dist
filtered by solr-ltr-\d.*\.jar to classpath:
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\tempDir-001\collection1\..\..\..\..\dist
[junit4] 2> 39950 WARN (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.c.SolrConfig Couldn't add files from
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\tempDir-001\collection1\..\..\..\..\contrib\velocity\lib
filtered by .*\.jar to classpath:
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\tempDir-001\collection1\..\..\..\..\contrib\velocity\lib
[junit4] 2> 39950 WARN (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.c.SolrConfig Couldn't add files from
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\tempDir-001\collection1\..\..\..\..\dist
filtered by solr-velocity-\d.*\.jar to classpath:
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\tempDir-001\collection1\..\..\..\..\dist
[junit4] 2> 39950 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.5.0
[junit4] 2> 39978 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.SolrIndexConfig IndexWriter infoStream solr logging is enabled
[junit4] 2> 40034 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.s.IndexSchema [collection1] Schema name=example
[junit4] 2> 40338 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.r.RestManager Registered ManagedResource impl
org.apache.solr.rest.schema.analysis.ManagedWordSetResource for path
/schema/analysis/stopwords/english
[junit4] 2> 40338 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.r.RestManager Registered ManagedResource impl
org.apache.solr.rest.schema.analysis.ManagedSynonymGraphFilterFactory$SynonymManager
for path /schema/analysis/synonyms/english
[junit4] 2> 40338 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.r.RestManager Added observer of type
org.apache.solr.rest.schema.analysis.ManagedStopFilterFactory to existing
ManagedResource /schema/analysis/stopwords/english
[junit4] 2> 40338 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.r.RestManager Added observer of type
org.apache.solr.rest.schema.analysis.ManagedSynonymGraphFilterFactory to
existing ManagedResource /schema/analysis/synonyms/english
[junit4] 2> 40345 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid field id
[junit4] 2> 40345 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.r.RestManager Added observer of type
org.apache.solr.rest.schema.analysis.ManagedStopFilterFactory to existing
ManagedResource /schema/analysis/stopwords/english
[junit4] 2> 40345 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.r.RestManager Added observer of type
org.apache.solr.rest.schema.analysis.ManagedSynonymGraphFilterFactory to
existing ManagedResource /schema/analysis/synonyms/english
[junit4] 2> 40345 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.r.RestManager Added observer of type
org.apache.solr.rest.schema.analysis.ManagedStopFilterFactory to existing
ManagedResource /schema/analysis/stopwords/english
[junit4] 2> 40345 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.r.RestManager Added observer of type
org.apache.solr.rest.schema.analysis.ManagedSynonymGraphFilterFactory to
existing ManagedResource /schema/analysis/synonyms/english
[junit4] 2> 40383 INFO (coreLoadExecutor-25-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-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\tempDir-001\collection1,
trusted=true
[junit4] 2> 40383 INFO (coreLoadExecutor-25-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@20082fa4
[junit4] 2> 40383 INFO (coreLoadExecutor-25-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-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\tempDir-001\collection1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\tempDir-001\collection1\data\]
[junit4] 2> 40401 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-25-thread-1]: init: current
segments file is "segments";
deletionPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper@2a0df2be
[junit4] 2> 40401 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-25-thread-1]: now checkpoint
"" [0 segments ; isCommit = false]
[junit4] 2> 40401 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-25-thread-1]: 0 msec to
checkpoint
[junit4] 2> 40401 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]: init:
create=true reader=null
[junit4] 2> 40401 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]:
[junit4] 2> dir=MockDirectoryWrapper(RAMDirectory@7a95cc8f
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3c53944e)
[junit4] 2> index=
[junit4] 2> version=8.5.0
[junit4] 2>
analyzer=org.apache.solr.update.SolrIndexConfig$DelayedSchemaAnalyzer
[junit4] 2> ramBufferSizeMB=100.0
[junit4] 2> maxBufferedDocs=-1
[junit4] 2> mergedSegmentWarmer=null
[junit4] 2> delPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper
[junit4] 2> commit=null
[junit4] 2> openMode=CREATE
[junit4] 2>
similarity=org.apache.solr.search.similarities.SchemaSimilarityFactory$SchemaSimilarity
[junit4] 2> mergeScheduler=ConcurrentMergeScheduler: maxThreadCount=-1,
maxMergeCount=-1, ioThrottle=true
[junit4] 2> codec=Lucene84
[junit4] 2> infoStream=org.apache.solr.update.LoggingInfoStream
[junit4] 2> mergePolicy=[TieredMergePolicy: maxMergeAtOnce=10,
maxMergeAtOnceExplicit=30, maxMergedSegmentMB=5120.0, floorSegmentMB=2.0,
forceMergeDeletesPctAllowed=10.0, segmentsPerTier=10.0,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1, deletesPctAllowed=33.0
[junit4] 2>
indexerThreadPool=org.apache.lucene.index.DocumentsWriterPerThreadPool@5733955e
[junit4] 2> readerPooling=true
[junit4] 2> perThreadHardLimitMB=1945
[junit4] 2> useCompoundFile=false
[junit4] 2> commitOnClose=true
[junit4] 2> indexSort=null
[junit4] 2> checkPendingFlushOnUpdate=true
[junit4] 2> softDeletesField=null
[junit4] 2> readerAttributes={}
[junit4] 2> writer=org.apache.solr.update.SolrIndexWriter@126e0504
[junit4] 2>
[junit4] 2> 40401 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]:
MMapDirectory.UNMAP_SUPPORTED=true
[junit4] 2> 40401 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]: now flush at
close
[junit4] 2> 40401 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]: start flush:
applyAllDeletes=true
[junit4] 2> 40401 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]: index before
flush
[junit4] 2> 40401 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-25-thread-1]: startFullFlush
[junit4] 2> 40401 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-25-thread-1]:
coreLoadExecutor-25-thread-1 finishFullFlush success=true
[junit4] 2> 40401 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]: now apply all
deletes for all segments buffered updates bytesUsed=0 reader pool bytesUsed=0
[junit4] 2> 40402 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-25-thread-1]: waitApply: no
deletes to apply
[junit4] 2> 40402 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-25-thread-1]:
initDynamicDefaults spins=false maxThreadCount=2 maxMergeCount=7
[junit4] 2> 40402 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-25-thread-1]:
updateMergeThreads ioThrottle=true targetMBPerSec=10240.0 MB/sec
[junit4] 2> 40402 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-25-thread-1]: now merge
[junit4] 2> 40402 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-25-thread-1]: index:
[junit4] 2> 40402 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-25-thread-1]: no more
merges pending; now return
[junit4] 2> 40402 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]: waitForMerges
[junit4] 2> 40402 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]: waitForMerges
done
[junit4] 2> 40402 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]: commit: start
[junit4] 2> 40402 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]: commit: enter
lock
[junit4] 2> 40402 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]: commit: now
prepare
[junit4] 2> 40402 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]: prepareCommit:
flush
[junit4] 2> 40402 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]: index before
flush
[junit4] 2> 40402 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-25-thread-1]: startFullFlush
[junit4] 2> 40402 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]: now apply all
deletes for all segments buffered updates bytesUsed=0 reader pool bytesUsed=0
[junit4] 2> 40404 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-25-thread-1]: waitApply: no
deletes to apply
[junit4] 2> 40404 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-25-thread-1]:
coreLoadExecutor-25-thread-1 finishFullFlush success=true
[junit4] 2> 40404 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]: startCommit():
start
[junit4] 2> 40404 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]: startCommit
index= changeCount=2
[junit4] 2> 40415 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]: startCommit:
wrote pending segments file "pending_segments_1"
[junit4] 2> 40415 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]: done all syncs:
[]
[junit4] 2> 40415 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]: commit:
pendingCommit != null
[junit4] 2> 40415 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]: commit: done
writing segments file "segments_1"
[junit4] 2> 40415 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-25-thread-1]: now checkpoint
"" [0 segments ; isCommit = true]
[junit4] 2> 40415 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-25-thread-1]: 0 msec to
checkpoint
[junit4] 2> 40415 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]: commit: took
13.3 msec
[junit4] 2> 40415 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]: commit: done
[junit4] 2> 40415 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]: rollback
[junit4] 2> 40417 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]: all running
merges have aborted
[junit4] 2> 40417 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]: rollback: done
finish merges
[junit4] 2> 40417 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-25-thread-1]: abort
[junit4] 2> 40417 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-25-thread-1]: done abort
success=true
[junit4] 2> 40417 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]: rollback: infos=
[junit4] 2> 40417 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-25-thread-1]: now checkpoint
"" [0 segments ; isCommit = false]
[junit4] 2> 40417 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-25-thread-1]: 0 msec to
checkpoint
[junit4] 2> 40423 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5
[junit4] 2> 40577 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 40577 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 40579 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.CommitTracker Hard AutoCommit: if uncommitted for 15000ms;
[junit4] 2> 40579 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 40583 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-25-thread-1]: init: current
segments file is "segments_1";
deletionPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper@2a0df2be
[junit4] 2> 40585 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-25-thread-1]: init: load
commit "segments_1"
[junit4] 2> 40586 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-25-thread-1]: now checkpoint
"" [0 segments ; isCommit = false]
[junit4] 2> 40586 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-25-thread-1]: 0 msec to
checkpoint
[junit4] 2> 40586 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]: init:
create=false reader=null
[junit4] 2> 40586 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]:
[junit4] 2> dir=MockDirectoryWrapper(RAMDirectory@7a95cc8f
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3c53944e)
[junit4] 2> index=
[junit4] 2> version=8.5.0
[junit4] 2>
analyzer=org.apache.solr.update.SolrIndexConfig$DelayedSchemaAnalyzer
[junit4] 2> ramBufferSizeMB=100.0
[junit4] 2> maxBufferedDocs=-1
[junit4] 2> mergedSegmentWarmer=null
[junit4] 2> delPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper
[junit4] 2> commit=null
[junit4] 2> openMode=APPEND
[junit4] 2>
similarity=org.apache.solr.search.similarities.SchemaSimilarityFactory$SchemaSimilarity
[junit4] 2> mergeScheduler=ConcurrentMergeScheduler: maxThreadCount=-1,
maxMergeCount=-1, ioThrottle=true
[junit4] 2> codec=Lucene84
[junit4] 2> infoStream=org.apache.solr.update.LoggingInfoStream
[junit4] 2> mergePolicy=[TieredMergePolicy: maxMergeAtOnce=10,
maxMergeAtOnceExplicit=30, maxMergedSegmentMB=5120.0, floorSegmentMB=2.0,
forceMergeDeletesPctAllowed=10.0, segmentsPerTier=10.0,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1, deletesPctAllowed=33.0
[junit4] 2>
indexerThreadPool=org.apache.lucene.index.DocumentsWriterPerThreadPool@622474e
[junit4] 2> readerPooling=true
[junit4] 2> perThreadHardLimitMB=1945
[junit4] 2> useCompoundFile=false
[junit4] 2> commitOnClose=true
[junit4] 2> indexSort=null
[junit4] 2> checkPendingFlushOnUpdate=true
[junit4] 2> softDeletesField=null
[junit4] 2> readerAttributes={}
[junit4] 2> writer=org.apache.solr.update.SolrIndexWriter@7b2f156
[junit4] 2>
[junit4] 2> 40586 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]:
MMapDirectory.UNMAP_SUPPORTED=true
[junit4] 2> 40587 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]: flush at
getReader
[junit4] 2> 40587 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-25-thread-1]: startFullFlush
[junit4] 2> 40587 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]: now apply all
deletes for all segments buffered updates bytesUsed=0 reader pool bytesUsed=0
[junit4] 2> 40587 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-25-thread-1]: waitApply: no
deletes to apply
[junit4] 2> 40587 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]: incRefDeleter
for NRT reader version=2 segments=
[junit4] 2> 40588 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]: return reader
version=2 reader=StandardDirectoryReader(segments_1:2:nrt)
[junit4] 2> 40588 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-25-thread-1]:
coreLoadExecutor-25-thread-1 finishFullFlush success=true
[junit4] 2> 40588 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-25-thread-1]: getReader took
1 msec
[junit4] 2> 40588 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.s.SolrIndexSearcher Opening [Searcher@340c837c[collection1] main]
[junit4] 2> 40589 INFO (coreLoadExecutor-25-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-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\tempDir-001\collection1\conf
[junit4] 2> 40590 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.r.ManagedResourceStorage Loaded LinkedHashMap at path
_rest_managed.json using
file:dir=C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\tempDir-001\collection1\conf
[junit4] 2> 40590 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.r.ManagedResource Loaded initArgs {} for /rest/managed
[junit4] 2> 40594 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.r.ManagedResourceStorage Loaded LinkedHashMap at path
_schema_analysis_stopwords_english.json using
file:dir=C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\tempDir-001\collection1\conf
[junit4] 2> 40594 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.r.ManagedResource Loaded initArgs {ignoreCase=true} for
/schema/analysis/stopwords/english
[junit4] 2> 40594 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.r.s.a.ManagedWordSetResource Loaded 35 words for
/schema/analysis/stopwords/english
[junit4] 2> 40594 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.r.ManagedResource Notified 2 observers of
/schema/analysis/stopwords/english
[junit4] 2> 40596 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.r.ManagedResourceStorage Loaded LinkedHashMap at path
_schema_analysis_synonyms_english.json using
file:dir=C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\tempDir-001\collection1\conf
[junit4] 2> 40596 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.r.ManagedResource Loaded initArgs {ignoreCase=true,format=solr} for
/schema/analysis/synonyms/english
[junit4] 2> 40596 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.r.s.a.ManagedSynonymGraphFilterFactory Loaded 3 synonym mappings for
/schema/analysis/synonyms/english
[junit4] 2> 40597 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.r.ManagedResource Notified 2 observers of
/schema/analysis/synonyms/english
[junit4] 2> 40632 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 40633 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.s.DirectSolrSpellChecker init:
{name=default,field=text,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4,maxQueryFrequency=0.01}
[junit4] 2> 40633 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.h.c.SuggestComponent Initializing SuggestComponent
[junit4] 2> 40633 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.s.s.SolrSuggester init:
{name=mySuggester,lookupImpl=FuzzyLookupFactory,dictionaryImpl=DocumentDictionaryFactory,field=cat,weightField=price,suggestAnalyzerFieldType=string,buildOnStartup=false}
[junit4] 2> 40635 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.s.s.SolrSuggester Dictionary loaded with params:
{name=mySuggester,lookupImpl=FuzzyLookupFactory,dictionaryImpl=DocumentDictionaryFactory,field=cat,weightField=price,suggestAnalyzerFieldType=string,buildOnStartup=false}
[junit4] 2> 40635 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.h.c.QueryElevationComponent Loading QueryElevation from:
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001\tempDir-001\collection1\conf\elevate.xml
[junit4] 2> 40648 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 40649 INFO (coreLoadExecutor-25-thread-1) [ x:collection1
] o.a.s.u.UpdateLog Could not find max version in index or recent updates,
using new clock 1652711283334578176
[junit4] 2> 40665 INFO
(searcherExecutor-26-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.c.QuerySenderListener QuerySenderListener sending requests to
Searcher@340c837c[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 40666 INFO
(searcherExecutor-26-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=static+firstSearcher+warming+in+solrconfig.xml&distrib=false&event=firstSearcher}
hits=0 status=0 QTime=1
[junit4] 2> 40666 INFO
(searcherExecutor-26-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 40666 INFO
(searcherExecutor-26-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 40666 INFO
(searcherExecutor-26-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 40681 INFO
(searcherExecutor-26-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@340c837c[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 41166 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.SolrJettyTestBase Jetty Assigned Port#49919
[junit4] 2> 41176 INFO
(TEST-ConcurrentUpdateHttp2SolrClientTest.testConcurrentUpdate-seed#[2B5284771F7CB908])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testConcurrentUpdate
[junit4] 2> 41228 WARN
(TEST-ConcurrentUpdateHttp2SolrClientTest.testConcurrentUpdate-seed#[2B5284771F7CB908])
[ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1
transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 41241 WARN
(TEST-ConcurrentUpdateHttp2SolrClientTest.testConcurrentUpdate-seed#[2B5284771F7CB908])
[ ] o.e.j.u.s.S.config Trusting all certificates configured for
Client@6226bcb6[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 41241 WARN
(TEST-ConcurrentUpdateHttp2SolrClientTest.testConcurrentUpdate-seed#[2B5284771F7CB908])
[ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm
configured for Client@6226bcb6[provider=null,keyStore=null,trustStore=null]
[junit4] 2> java.io.IOException: Request processing has stalled for 107ms
with 100 remaining elements in the queue.
[junit4] 2> at
org.apache.solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClient.request(ConcurrentUpdateHttp2SolrClient.java:446)
[junit4] 2> at
org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1290)
[junit4] 2> at
org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrClientTest$SendDocsRunnable.run(ConcurrentUpdateSolrClientTest.java:301)
[junit4] 2> at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> java.io.IOException: Request processing has stalled for 108ms
with 100 remaining elements in the queue.
[junit4] 2> at
org.apache.solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClient.request(ConcurrentUpdateHttp2SolrClient.java:446)
[junit4] 2> at
org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1290)
[junit4] 2> at
org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrClientTest$SendDocsRunnable.run(ConcurrentUpdateSolrClientTest.java:301)
[junit4] 2> at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> java.io.IOException: Request processing has stalled for 108ms
with 100 remaining elements in the queue.
[junit4] 2> at
org.apache.solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClient.request(ConcurrentUpdateHttp2SolrClient.java:446)
[junit4] 2> at
org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1290)
[junit4] 2> at
org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrClientTest$SendDocsRunnable.run(ConcurrentUpdateSolrClientTest.java:301)
[junit4] 2> at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> java.io.IOException: Request processing has stalled for 108ms
with 100 remaining elements in the queue.
[junit4] 2> at
org.apache.solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClient.request(ConcurrentUpdateHttp2SolrClient.java:446)
[junit4] 2> at
org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1290)
[junit4] 2> at
org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrClientTest$SendDocsRunnable.run(ConcurrentUpdateSolrClientTest.java:301)
[junit4] 2> at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> java.io.IOException: Request processing has stalled for 102ms
with 100 remaining elements in the queue.
[junit4] 2> at
org.apache.solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClient.request(ConcurrentUpdateHttp2SolrClient.java:446)
[junit4] 2> at
org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1290)
[junit4] 2> at
org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrClientTest$SendDocsRunnable.run(ConcurrentUpdateSolrClientTest.java:301)
[junit4] 2> at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 46259 INFO
(TEST-ConcurrentUpdateHttp2SolrClientTest.testConcurrentUpdate-seed#[2B5284771F7CB908])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testConcurrentUpdate
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=ConcurrentUpdateHttp2SolrClientTest
-Dtests.method=testConcurrentUpdate -Dtests.seed=2B5284771F7CB908
-Dtests.slow=true -Dtests.locale=uk-UA -Dtests.timezone=America/Punta_Arenas
-Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 5.10s J0 |
ConcurrentUpdateHttp2SolrClientTest.testConcurrentUpdate <<<
[junit4] > Throwable #1: java.lang.AssertionError: Expected CUSS to send
500 but got 495
[junit4] > at
__randomizedtesting.SeedInfo.seed([2B5284771F7CB908:D354DD8CCB44DC43]:0)
[junit4] > at
org.apache.solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest.testConcurrentUpdate(ConcurrentUpdateHttp2SolrClientTest.java:102)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 46276 INFO
(TEST-ConcurrentUpdateHttp2SolrClientTest.testConcurrentCollectionUpdate-seed#[2B5284771F7CB908])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testConcurrentCollectionUpdate
[junit4] 2> 46277 WARN
(TEST-ConcurrentUpdateHttp2SolrClientTest.testConcurrentCollectionUpdate-seed#[2B5284771F7CB908])
[ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1
transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 46289 WARN
(TEST-ConcurrentUpdateHttp2SolrClientTest.testConcurrentCollectionUpdate-seed#[2B5284771F7CB908])
[ ] o.e.j.u.s.S.config Trusting all certificates configured for
Client@dffdf08[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 46289 WARN
(TEST-ConcurrentUpdateHttp2SolrClientTest.testConcurrentCollectionUpdate-seed#[2B5284771F7CB908])
[ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm
configured for Client@dffdf08[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 46480 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [DW][qtp1086214608-93]: anyChanges? numDocsInRam=0
deletes=true hasTickets:false pendingChangesInFullFlush: false
[junit4] 2> 46480 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [DW][qtp1086214608-93]: anyChanges? numDocsInRam=0
deletes=true hasTickets:false pendingChangesInFullFlush: false
[junit4] 2> 46480 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: nrtIsCurrent: infoVersion
matches: true; DW changes: true; BD changes: false
[junit4] 2> 46480 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: flush at getReader
[junit4] 2> 46480 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [DW][qtp1086214608-93]: startFullFlush
[junit4] 2> 46480 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [DW][qtp1086214608-93]: anyChanges? numDocsInRam=0
deletes=true hasTickets:false pendingChangesInFullFlush: false
[junit4] 2> 46481 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [DW][qtp1086214608-93]: qtp1086214608-93: flush naked
frozen global deletes
[junit4] 2> 46498 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [BD][qtp1086214608-93]: compressed 76 to 48 bytes
(63.16%) for deletes/updates; private segment null
[junit4] 2> 46503 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [BD][qtp1086214608-93]: push new packet (delGen=1
numDeleteQueries=1 bytesUsed=48), packetCount=1, bytesUsed=0.000 MB
[junit4] 2> 46506 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: flush: push buffered updates:
delGen=1 numDeleteQueries=1 bytesUsed=48
[junit4] 2> 46509 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [BD][qtp1086214608-93]: packet matches no segments
[junit4] 2> 46510 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [BD][qtp1086214608-93]: finished packet delGen=1 now
completedDelGen=1
[junit4] 2> 46510 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [BD][qtp1086214608-93]: done apply del packet
(delGen=1 numDeleteQueries=1 bytesUsed=48) to 0 segments; 0 new
deletes/updates; took 0.003 sec; 0 packets remain
[junit4] 2> 46510 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: now apply all deletes for all
segments buffered updates bytesUsed=0 reader pool bytesUsed=0
[junit4] 2> 46510 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [BD][qtp1086214608-93]: waitApply: no deletes to apply
[junit4] 2> 46510 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: incRefDeleter for NRT reader
version=2 segments=
[junit4] 2> 46510 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: return reader version=2
reader=StandardDirectoryReader(segments_1:2:nrt)
[junit4] 2> 46510 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [DW][qtp1086214608-93]: qtp1086214608-93
finishFullFlush success=true
[junit4] 2> 46510 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: getReader took 30 msec
[junit4] 2> 46510 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: decRefDeleter for NRT reader
version=2 segments=
[junit4] 2> 46518 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
params={wt=javabin&version=2}{deleteByQuery=*:* (-1652711289373327360)} 0 186
[junit4] 2> 46809 INFO (qtp1086214608-94) [ x:collection1 ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
params={wt=javabin&version=2}{add=[2_13 (1652711289595625472), 0_32
(1652711289747668992), 0_33 (1652711289748717568), 0_34 (1652711289749766144),
0_35 (1652711289749766146), 0_36 (1652711289750814720), 0_37
(1652711289751863297), 0_38 (1652711289751863298), 0_39 (1652711289752911873),
0_40 (1652711289753960449), ... (101 adds)]} 0 190
[junit4] 2> 46837 INFO (qtp1086214608-89) [ x:collection1 ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
params={wt=javabin&version=2}{add=[3_78 (1652711289809534976), 3_79
(1652711289809534977), 3_80 (1652711289810583552), 3_81 (1652711289810583553),
3_82 (1652711289810583554), 3_83 (1652711289810583555), 3_84
(1652711289810583556), 3_85 (1652711289811632128), 3_86 (1652711289811632129),
3_87 (1652711289811632130), ... (49 adds)]} 0 12
[junit4] 2> 46876 INFO (qtp1086214608-91) [ x:collection1 ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
params={wt=javabin&version=2}{add=[0_0 (1652711289558925312), 4_0
(1652711289747668993), 0_1 (1652711289749766145), 0_2 (1652711289751863296),
0_3 (1652711289752911872), 0_4 (1652711289753960448), 0_5
(1652711289753960450), 0_6 (1652711289755009024), 0_7 (1652711289758154753),
0_8 (1652711289758154754), ... (350 adds)]} 0 311
[junit4] 2> 51569 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1652711294785028096,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 51569 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@7b2f156
commitCommandVersion:1652711294785028096
[junit4] 2> 51571 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: commit: start
[junit4] 2> 51571 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: commit: enter lock
[junit4] 2> 51571 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: commit: now prepare
[junit4] 2> 51571 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: prepareCommit: flush
[junit4] 2> 51571 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: index before flush
[junit4] 2> 51571 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [DW][qtp1086214608-93]: startFullFlush
[junit4] 2> 51571 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [DW][qtp1086214608-93]: anyChanges? numDocsInRam=500
deletes=true hasTickets:false pendingChangesInFullFlush: false
[junit4] 2> 51571 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [DWFC][qtp1086214608-93]: addFlushableState
DocumentsWriterPerThread [pendingDeletes=gen=0 266 deleted terms (unique
count=266) bytesUsed=46777, segment=_0, aborted=false, numDocsInRAM=140,
deleteQueue=DWDQ: [ generation: 2 ]]
[junit4] 2> 51571 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [DWFC][qtp1086214608-93]: addFlushableState
DocumentsWriterPerThread [pendingDeletes=gen=0 498 deleted terms (unique
count=498) bytesUsed=87599, segment=_1, aborted=false, numDocsInRAM=360,
deleteQueue=DWDQ: [ generation: 2 ]]
[junit4] 2> 51608 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [BD][qtp1086214608-93]: compressed 87950 to 2064
bytes (2.35%) for deletes/updates; private segment null
[junit4] 2> 51610 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [DWPT][qtp1086214608-93]: flush postings as segment
_0 numDocs=140
[junit4] 2> 51610 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: 0 msec to write norms
[junit4] 2> 51714 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: 98 msec to write docValues
[junit4] 2> 51714 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: 0 msec to write points
[junit4] 2> 51714 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: 0 msec to finish stored fields
[junit4] 2> 51920 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: 205 msec to write postings
and finish vectors
[junit4] 2> 51936 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: 15 msec to write fieldInfos
[junit4] 2> 51936 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [DWPT][qtp1086214608-93]: new segment has 0 deleted
docs
[junit4] 2> 51936 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [DWPT][qtp1086214608-93]: new segment has 0
soft-deleted docs
[junit4] 2> 51936 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [DWPT][qtp1086214608-93]: new segment has no vectors;
no norms; docValues; no prox; freqs
[junit4] 2> 51936 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [DWPT][qtp1086214608-93]:
flushedFiles=[_0_Lucene80_0.dvd, _0_Lucene84_0.doc, _0_Lucene84_0.tim,
_0_Lucene84_0.tip, _0.fdx, _0.fdt, _0_Lucene80_0.dvm, _0.fnm]
[junit4] 2> 51936 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [DWPT][qtp1086214608-93]: flushed codec=Lucene84
[junit4] 2> 51946 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [DWPT][qtp1086214608-93]: flushed: segment=_0
ramUsed=0.18 MB newFlushedSize=0.005 MB docs/MB=30,469.207
[junit4] 2> 51971 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [DWPT][qtp1086214608-93]: flush time 358.8832 msec
[junit4] 2> 51971 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [DWPT][qtp1086214608-93]: flush postings as segment
_1 numDocs=360
[junit4] 2> 51971 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: 0 msec to write norms
[junit4] 2> 51973 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: 2 msec to write docValues
[junit4] 2> 51974 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: 0 msec to write points
[junit4] 2> 51978 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: 3 msec to finish stored fields
[junit4] 2> 51983 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: 6 msec to write postings and
finish vectors
[junit4] 2> 51989 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: 4 msec to write fieldInfos
[junit4] 2> 51989 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [DWPT][qtp1086214608-93]: new segment has 0 deleted
docs
[junit4] 2> 51989 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [DWPT][qtp1086214608-93]: new segment has 0
soft-deleted docs
[junit4] 2> 51989 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [DWPT][qtp1086214608-93]: new segment has no vectors;
no norms; docValues; no prox; freqs
[junit4] 2> 51989 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [DWPT][qtp1086214608-93]:
flushedFiles=[_1_Lucene84_0.doc, _1_Lucene84_0.tim, _1_Lucene80_0.dvd, _1.fdx,
_1.fnm, _1_Lucene84_0.tip, _1_Lucene80_0.dvm, _1.fdt]
[junit4] 2> 51989 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [DWPT][qtp1086214608-93]: flushed codec=Lucene84
[junit4] 2> 51993 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [DWPT][qtp1086214608-93]: flushed: segment=_1
ramUsed=0.192 MB newFlushedSize=0.009 MB docs/MB=41,748.215
[junit4] 2> 51993 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [DWPT][qtp1086214608-93]: flush time 21.639399 msec
[junit4] 2> 51994 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: publishFlushedSegment
seg-private updates=null
[junit4] 2> 51994 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: publishFlushedSegment
_0(8.5.0):C140:[diagnostics={os=Windows 10, java.vendor=Oracle Corporation,
java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.5.0,
os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush,
os.version=10.0,
timestamp=1576148314664}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
[junit4] 2> 51994 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [BD][qtp1086214608-93]: push new packet (delGen=2
numDeleteTerms=500 bytesUsed=2064), packetCount=1, bytesUsed=0.002 MB
[junit4] 2> 51995 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [BD][qtp1086214608-93]: finished packet delGen=3 now
completedDelGen=1
[junit4] 2> 51995 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: publish sets newSegment
delGen=3 seg=_0(8.5.0):C140:[diagnostics={os=Windows 10, java.vendor=Oracle
Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09,
lucene.version=8.5.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09,
source=flush, os.version=10.0,
timestamp=1576148314664}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
[junit4] 2> 51995 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IFD][qtp1086214608-93]: now checkpoint
"_0(8.5.0):C140:[diagnostics={os=Windows 10, java.vendor=Oracle Corporation,
java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.5.0,
os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush,
os.version=10.0,
timestamp=1576148314664}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]"
[1 segments ; isCommit = false]
[junit4] 2> 51995 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IFD][qtp1086214608-93]: 0 msec to checkpoint
[junit4] 2> 51995 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: publishFlushedSegment
seg-private updates=null
[junit4] 2> 51995 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: publishFlushedSegment
_1(8.5.0):C360:[diagnostics={os=Windows 10, java.vendor=Oracle Corporation,
java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.5.0,
os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush,
os.version=10.0,
timestamp=1576148314695}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
[junit4] 2> 51995 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [BD][qtp1086214608-93]: finished packet delGen=4 now
completedDelGen=1
[junit4] 2> 51995 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: publish sets newSegment
delGen=4 seg=_1(8.5.0):C360:[diagnostics={os=Windows 10, java.vendor=Oracle
Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09,
lucene.version=8.5.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09,
source=flush, os.version=10.0,
timestamp=1576148314695}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
[junit4] 2> 51995 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IFD][qtp1086214608-93]: now checkpoint
"_0(8.5.0):C140:[diagnostics={os=Windows 10, java.vendor=Oracle Corporation,
java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.5.0,
os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush,
os.version=10.0,
timestamp=1576148314664}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
_1(8.5.0):C360:[diagnostics={os=Windows 10, java.vendor=Oracle Corporation,
java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.5.0,
os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush,
os.version=10.0,
timestamp=1576148314695}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]"
[2 segments ; isCommit = false]
[junit4] 2> 51995 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IFD][qtp1086214608-93]: 0 msec to checkpoint
[junit4] 2> 51995 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [BD][qtp1086214608-93]: packet matches no segments
[junit4] 2> 51995 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [BD][qtp1086214608-93]: finished packet delGen=2 now
completedDelGen=4
[junit4] 2> 51995 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [BD][qtp1086214608-93]: done apply del packet
(delGen=2 numDeleteTerms=500 bytesUsed=2064) to 0 segments; 0 new
deletes/updates; took 0.000 sec; 0 packets remain
[junit4] 2> 52000 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: now apply all deletes for all
segments buffered updates bytesUsed=0 reader pool bytesUsed=0
[junit4] 2> 52000 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [BD][qtp1086214608-93]: waitApply: no deletes to apply
[junit4] 2> 52000 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [DW][qtp1086214608-93]: qtp1086214608-93
finishFullFlush success=true
[junit4] 2> 52000 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: startCommit(): start
[junit4] 2> 52000 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: startCommit
index=_0(8.5.0):C140:[diagnostics={os=Windows 10, java.vendor=Oracle
Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09,
lucene.version=8.5.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09,
source=flush, os.version=10.0,
timestamp=1576148314664}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
_1(8.5.0):C360:[diagnostics={os=Windows 10, java.vendor=Oracle Corporation,
java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.5.0,
os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush,
os.version=10.0,
timestamp=1576148314695}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
changeCount=6
[junit4] 2> 52000 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: startCommit: wrote pending
segments file "pending_segments_2"
[junit4] 2> 52002 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: done all syncs: [_0.si,
_1.si, _0_Lucene84_0.doc, _0_Lucene84_0.tim, _1_Lucene80_0.dvd,
_0_Lucene84_0.tip, _0.fdx, _1.fnm, _0.fdt, _0_Lucene80_0.dvm,
_1_Lucene84_0.doc, _1_Lucene84_0.tim, _0_Lucene80_0.dvd, _1.fdx,
_1_Lucene84_0.tip, _1_Lucene80_0.dvm, _0.fnm, _1.fdt]
[junit4] 2> 52002 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: commit: pendingCommit != null
[junit4] 2> 52002 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: commit: done writing segments
file "segments_2"
[junit4] 2> 52002 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IFD][qtp1086214608-93]: now checkpoint
"_0(8.5.0):C140:[diagnostics={os=Windows 10, java.vendor=Oracle Corporation,
java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.5.0,
os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush,
os.version=10.0,
timestamp=1576148314664}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
_1(8.5.0):C360:[diagnostics={os=Windows 10, java.vendor=Oracle Corporation,
java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.5.0,
os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush,
os.version=10.0,
timestamp=1576148314695}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]"
[2 segments ; isCommit = true]
[junit4] 2> 52003 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IFD][qtp1086214608-93]: deleteCommits: now decRef
commit "segments_1"
[junit4] 2> 52003 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IFD][qtp1086214608-93]: delete [segments_1]
[junit4] 2> 52003 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IFD][qtp1086214608-93]: 1 msec to checkpoint
[junit4] 2> 52003 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: commit: took 433.0 msec
[junit4] 2> 52003 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: commit: done
[junit4] 2> 52008 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [MP][qtp1086214608-93]:
seg=_1(8.5.0):C360:[diagnostics={os=Windows 10, java.vendor=Oracle Corporation,
java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.5.0,
os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush,
os.version=10.0,
timestamp=1576148314695}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
size=0.009 MB [floored]
[junit4] 2> 52008 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [MP][qtp1086214608-93]:
seg=_0(8.5.0):C140:[diagnostics={os=Windows 10, java.vendor=Oracle Corporation,
java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.5.0,
os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush,
os.version=10.0,
timestamp=1576148314664}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
size=0.005 MB [floored]
[junit4] 2> 52010 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [MP][qtp1086214608-93]: findMerges: 2 segments
[junit4] 2> 52010 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [MP][qtp1086214608-93]: allowedSegmentCount=10 vs
count=2 (eligible count=2)
[junit4] 2> 52012 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [MS][qtp1086214608-93]: initDynamicDefaults
spins=false maxThreadCount=2 maxMergeCount=7
[junit4] 2> 52012 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [MS][qtp1086214608-93]: now merge
[junit4] 2> 52012 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [MS][qtp1086214608-93]: index:
_0(8.5.0):C140:[diagnostics={os=Windows 10, java.vendor=Oracle Corporation,
java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.5.0,
os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush,
os.version=10.0,
timestamp=1576148314664}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
_1(8.5.0):C360:[diagnostics={os=Windows 10, java.vendor=Oracle Corporation,
java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.5.0,
os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush,
os.version=10.0,
timestamp=1576148314695}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
[junit4] 2> 52012 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [MS][qtp1086214608-93]: no more merges pending; now
return
[junit4] 2> 52013 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: nrtIsCurrent: infoVersion
matches: false; DW changes: false; BD changes: false
[junit4] 2> 52013 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: flush at getReader
[junit4] 2> 52013 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [DW][qtp1086214608-93]: startFullFlush
[junit4] 2> 52013 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: now apply all deletes for all
segments buffered updates bytesUsed=0 reader pool bytesUsed=0
[junit4] 2> 52013 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [BD][qtp1086214608-93]: waitApply: no deletes to apply
[junit4] 2> 52252 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: incRefDeleter for NRT reader
version=8 segments=_0(8.5.0):C140:[diagnostics={os=Windows 10,
java.vendor=Oracle Corporation, java.version=1.8.0_201,
java.vm.version=25.201-b09, lucene.version=8.5.0, os.arch=amd64,
java.runtime.version=1.8.0_201-b09, source=flush, os.version=10.0,
timestamp=1576148314664}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
_1(8.5.0):C360:[diagnostics={os=Windows 10, java.vendor=Oracle Corporation,
java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.5.0,
os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush,
os.version=10.0,
timestamp=1576148314695}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
[junit4] 2> 52253 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: return reader version=8
reader=StandardDirectoryReader(segments_2:8:nrt
_0(8.5.0):C140:[diagnostics={os=Windows 10, java.vendor=Oracle Corporation,
java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.5.0,
os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush,
os.version=10.0,
timestamp=1576148314664}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
_1(8.5.0):C360:[diagnostics={os=Windows 10, java.vendor=Oracle Corporation,
java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.5.0,
os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush,
os.version=10.0,
timestamp=1576148314695}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
[junit4] 2> 52253 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [DW][qtp1086214608-93]: qtp1086214608-93
finishFullFlush success=true
[junit4] 2> 52253 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-93]: getReader took 240 msec
[junit4] 2> 52327 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@6536059f[collection1] main]
[junit4] 2> 52330 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 52335 INFO
(searcherExecutor-26-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.c.QuerySenderListener QuerySenderListener sending requests to
Searcher@6536059f[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.5.0):C140:[diagnostics={os=Windows
10, java.vendor=Oracle Corporation, java.version=1.8.0_201,
java.vm.version=25.201-b09, lucene.version=8.5.0, os.arch=amd64,
java.runtime.version=1.8.0_201-b09, source=flush, os.version=10.0,
timestamp=1576148314664}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_1(8.5.0):C360:[diagnostics={os=Windows 10, java.vendor=Oracle
Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09,
lucene.version=8.5.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09,
source=flush, os.version=10.0,
timestamp=1576148314695}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 52335 INFO
(searcherExecutor-26-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 52355 INFO
(searcherExecutor-26-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@6536059f[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.5.0):C140:[diagnostics={os=Windows
10, java.vendor=Oracle Corporation, java.version=1.8.0_201,
java.vm.version=25.201-b09, lucene.version=8.5.0, os.arch=amd64,
java.runtime.version=1.8.0_201-b09, source=flush, os.version=10.0,
timestamp=1576148314664}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])
Uninverting(_1(8.5.0):C360:[diagnostics={os=Windows 10, java.vendor=Oracle
Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09,
lucene.version=8.5.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09,
source=flush, os.version=10.0,
timestamp=1576148314695}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 52355 INFO
(searcherExecutor-26-thread-1-processing-x:collection1) [ x:collection1 ]
o.a.s.u.LoggingInfoStream
[IW][searcherExecutor-26-thread-1-processing-x:collection1]: decRefDeleter for
NRT reader version=2 segments=
[junit4] 2> 52355 INFO (qtp1086214608-93) [ x:collection1 ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
0 787
[junit4] 2> 52419 INFO (qtp1086214608-92) [ x:collection1 ]
o.a.s.c.S.Request [collection1] webapp=/solr path=/select
params={q=*:*&wt=javabin&version=2} hits=500 status=0 QTime=54
[junit4] 2> 52548 WARN
(TEST-ConcurrentUpdateHttp2SolrClientTest.testConcurrentCollectionUpdate-seed#[2B5284771F7CB908])
[ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1
transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 52557 WARN
(TEST-ConcurrentUpdateHttp2SolrClientTest.testConcurrentCollectionUpdate-seed#[2B5284771F7CB908])
[ ] o.e.j.u.s.S.config Trusting all certificates configured for
Client@59d3b9a6[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 52557 WARN
(TEST-ConcurrentUpdateHttp2SolrClientTest.testConcurrentCollectionUpdate-seed#[2B5284771F7CB908])
[ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm
configured for Client@59d3b9a6[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 52585 INFO (qtp1086214608-94) [ x:collection1 ]
o.a.s.c.S.Request [collection1] webapp=/solr path=/select
params={q=*:*&wt=javabin&version=2} hits=500 status=0 QTime=0
[junit4] 2> 52595 INFO
(TEST-ConcurrentUpdateHttp2SolrClientTest.testConcurrentCollectionUpdate-seed#[2B5284771F7CB908])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testConcurrentCollectionUpdate
[junit4] 2> 52603 INFO
(TEST-ConcurrentUpdateHttp2SolrClientTest.testCollectionParameters-seed#[2B5284771F7CB908])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testCollectionParameters
[junit4] 2> 52605 WARN
(TEST-ConcurrentUpdateHttp2SolrClientTest.testCollectionParameters-seed#[2B5284771F7CB908])
[ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1
transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 52610 WARN
(TEST-ConcurrentUpdateHttp2SolrClientTest.testCollectionParameters-seed#[2B5284771F7CB908])
[ ] o.e.j.u.s.S.config Trusting all certificates configured for
Client@7cd3776a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 52610 WARN
(TEST-ConcurrentUpdateHttp2SolrClientTest.testCollectionParameters-seed#[2B5284771F7CB908])
[ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm
configured for Client@7cd3776a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 52641 INFO (qtp1086214608-89) [ x:collection1 ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
params={wt=javabin&version=2}{add=[collection (1652711295905955840)]} 0 3
[junit4] 2> 52645 INFO (qtp1086214608-91) [ x:collection1 ]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1652711295913295872,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 52645 INFO (qtp1086214608-91) [ x:collection1 ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@7b2f156
commitCommandVersion:1652711295913295872
[junit4] 2> 52645 INFO (qtp1086214608-91) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-91]: commit: start
[junit4] 2> 52645 INFO (qtp1086214608-91) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-91]: commit: enter lock
[junit4] 2> 52645 INFO (qtp1086214608-91) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-91]: commit: now prepare
[junit4] 2> 52645 INFO (qtp1086214608-91) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-91]: prepareCommit: flush
[junit4] 2> 52646 INFO (qtp1086214608-91) [ x:collection1 ]
o.a.s.u.LoggingInfoStream [IW][qtp1086214608-91]: index before flush
_0(8.5.0):C140:[diagnostics={os=Windows 10, java.vendor=Oracle Corporation,
java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.5.0,
os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush,
os.version=10.0,
timestamp=1576148314664}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
_1(8.5.0):C360:[diagnostics={os=Windows 10, java.vendor=Oracle Corporation,
java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.5.0,
os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush,
[...truncated too long message...]
ply: no deletes to apply
[junit4] 2> 56257 INFO (coreCloseExecutor-15-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-15-thread-1]:
coreCloseExecutor-15-thread-1 finishFullFlush success=true
[junit4] 2> 56257 INFO (coreCloseExecutor-15-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-15-thread-1]: startCommit():
start
[junit4] 2> 56257 INFO (coreCloseExecutor-15-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-15-thread-1]: skip
startCommit(): no changes pending
[junit4] 2> 56258 INFO (coreCloseExecutor-15-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-15-thread-1]: commit:
pendingCommit == null; skip
[junit4] 2> 56258 INFO (coreCloseExecutor-15-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-15-thread-1]: commit: took
1.3 msec
[junit4] 2> 56258 INFO (coreCloseExecutor-15-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-15-thread-1]: commit: done
[junit4] 2> 56258 INFO (coreCloseExecutor-15-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-15-thread-1]: rollback
[junit4] 2> 56258 INFO (coreCloseExecutor-15-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-15-thread-1]: all running
merges have aborted
[junit4] 2> 56258 INFO (coreCloseExecutor-15-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-15-thread-1]: rollback: done
finish merges
[junit4] 2> 56258 INFO (coreCloseExecutor-15-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-15-thread-1]: abort
[junit4] 2> 56258 INFO (coreCloseExecutor-15-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-15-thread-1]: done abort
success=true
[junit4] 2> 56258 INFO (coreCloseExecutor-15-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-15-thread-1]: rollback:
infos=_0(8.5.0):C196:[diagnostics={os=Windows 10, java.vendor=Oracle
Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09,
lucene.version=8.5.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09,
source=flush, os.version=10.0,
timestamp=1576150752919}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
_1(8.5.0):C304:[diagnostics={os=Windows 10, java.vendor=Oracle Corporation,
java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.5.0,
os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush,
os.version=10.0,
timestamp=1576150752958}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
_2(8.5.0):C1:[diagnostics={os=Windows 10, java.vendor=Oracle Corporation,
java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.5.0,
os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush,
os.version=10.0,
timestamp=1576150754780}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
[junit4] 2> 56258 INFO (coreCloseExecutor-15-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-15-thread-1]: now
checkpoint "_0(8.5.0):C196:[diagnostics={os=Windows 10, java.vendor=Oracle
Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09,
lucene.version=8.5.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09,
source=flush, os.version=10.0,
timestamp=1576150752919}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
_1(8.5.0):C304:[diagnostics={os=Windows 10, java.vendor=Oracle Corporation,
java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.5.0,
os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush,
os.version=10.0,
timestamp=1576150752958}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]
_2(8.5.0):C1:[diagnostics={os=Windows 10, java.vendor=Oracle Corporation,
java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.5.0,
os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush,
os.version=10.0,
timestamp=1576150754780}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]"
[3 segments ; isCommit = false]
[junit4] 2> 56258 INFO (coreCloseExecutor-15-thread-1) [ x:collection1
] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-15-thread-1]: 0 msec to
checkpoint
[junit4] 2> 56274 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 56274 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@7588ac1c: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@53117e92
[junit4] 2> 56282 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 56282 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@6275f869: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@4c201776
[junit4] 2> 56287 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 56287 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@78adce8c: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@6c0a56fa
[junit4] 2> 56314 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.e.j.s.AbstractConnector Stopped ServerConnector@6a8dc47f{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 56322 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@93188fa{/solr,null,UNAVAILABLE}
[junit4] 2> 56322 INFO
(SUITE-ConcurrentUpdateHttp2SolrClientTest-seed#[2B5284771F7CB908]-worker) [
] 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-solrj\test\J0\temp\solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest_2B5284771F7CB908-001
[junit4] 2> NOTE: test params are: codec=Lucene84,
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@1b6ebb69),
locale=uk-UA, timezone=America/Punta_Arenas
[junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 1.8.0_201
(64-bit)/cpus=3,threads=2,free=46005680,total=100663296
[junit4] 2> NOTE: All tests run in this JVM:
[ConcurrentUpdateHttp2SolrClientTest]
[junit4] Completed [2/5 (2!)] on J0 in 54.11s, 3 tests, 1 failure <<<
FAILURES!
[...truncated 29 lines...]
BUILD FAILED
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\lucene\common-build.xml:1591:
The following error occurred while executing this line:
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\lucene\common-build.xml:1117:
There were test failures: 5 suites, 15 tests, 2 failures [seed:
2B5284771F7CB908]
Total time: 1 minute 25 seconds
[repro] Setting last failure code to 1
[repro] Failures w/original seeds:
[repro] 2/5 failed:
org.apache.solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClientTest
[repro] Exiting with code 1
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows>IF EXIST lucene\build move
/y lucene\build lucene\build.repro
1 dir(s) moved.
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows>IF EXIST solr\build move /y
solr\build solr\build.repro
1 dir(s) moved.
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows>IF EXIST lucene\build.orig
move /y lucene\build.orig lucene\build
1 dir(s) moved.
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows>IF EXIST solr\build.orig
move /y solr\build.orig solr\build
1 dir(s) moved.
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows>exit 0
Archiving artifacts
Setting
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
Setting
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
No credentials specified
Setting
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
<Git Blamer> Using GitBlamer to create author and commit information for all
warnings.
<Git Blamer> GIT_COMMIT=451d5348f4b5fe93e01fa07ebfa2c6e89385831a,
workspace=C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows
[WARNINGS] Computing warning deltas based on reference build #590
Recording test results
Setting
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]