Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/2030/

1 tests failed.
FAILED:  org.apache.solr.client.solrj.TestSolrJErrorHandling.testWithXml

Error Message:
expected:<881> but was:<871>

Stack Trace:
java.lang.AssertionError: expected:<881> but was:<871>
        at 
__randomizedtesting.SeedInfo.seed([9DFC98A8B08E3F82:361E215E328826EF]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.failNotEquals(Assert.java:647)
        at org.junit.Assert.assertEquals(Assert.java:128)
        at org.junit.Assert.assertEquals(Assert.java:472)
        at org.junit.Assert.assertEquals(Assert.java:456)
        at 
org.apache.solr.client.solrj.TestSolrJErrorHandling.doThreads(TestSolrJErrorHandling.java:185)
        at 
org.apache.solr.client.solrj.TestSolrJErrorHandling.doIt(TestSolrJErrorHandling.java:200)
        at 
org.apache.solr.client.solrj.TestSolrJErrorHandling.testWithXml(TestSolrJErrorHandling.java:110)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 13937 lines...]
   [junit4] Suite: org.apache.solr.client.solrj.TestSolrJErrorHandling
   [junit4]   2> Creating dataDir: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/init-core-data-001
   [junit4]   2> 162480 INFO  
(SUITE-TestSolrJErrorHandling-seed#[9DFC98A8B08E3F82]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 162512 INFO  
(SUITE-TestSolrJErrorHandling-seed#[9DFC98A8B08E3F82]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=https://issues.apache.org/jira/browse/SOLR-5776)
   [junit4]   2> 162512 INFO  
(SUITE-TestSolrJErrorHandling-seed#[9DFC98A8B08E3F82]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 162921 INFO  
(SUITE-TestSolrJErrorHandling-seed#[9DFC98A8B08E3F82]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 162921 INFO  
(SUITE-TestSolrJErrorHandling-seed#[9DFC98A8B08E3F82]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 162921 INFO  
(SUITE-TestSolrJErrorHandling-seed#[9DFC98A8B08E3F82]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-002/cores/core
   [junit4]   2> 162940 INFO  
(SUITE-TestSolrJErrorHandling-seed#[9DFC98A8B08E3F82]-worker) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 163098 INFO  
(SUITE-TestSolrJErrorHandling-seed#[9DFC98A8B08E3F82]-worker) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@26e185a1{/solr,null,AVAILABLE}
   [junit4]   2> 163099 INFO  
(SUITE-TestSolrJErrorHandling-seed#[9DFC98A8B08E3F82]-worker) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@6be3988d{HTTP/1.1,[http/1.1]}{127.0.0.1:38603}
   [junit4]   2> 163099 INFO  
(SUITE-TestSolrJErrorHandling-seed#[9DFC98A8B08E3F82]-worker) [    ] 
o.e.j.s.Server Started @177450ms
   [junit4]   2> 163099 INFO  
(SUITE-TestSolrJErrorHandling-seed#[9DFC98A8B08E3F82]-worker) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=38603, 
configSetBaseDir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-001,
 
coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-002/cores}
   [junit4]   2> 163100 ERROR 
(SUITE-TestSolrJErrorHandling-seed#[9DFC98A8B08E3F82]-worker) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 163100 INFO  
(SUITE-TestSolrJErrorHandling-seed#[9DFC98A8B08E3F82]-worker) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 163100 INFO  
(SUITE-TestSolrJErrorHandling-seed#[9DFC98A8B08E3F82]-worker) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 163100 INFO  
(SUITE-TestSolrJErrorHandling-seed#[9DFC98A8B08E3F82]-worker) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 163100 INFO  
(SUITE-TestSolrJErrorHandling-seed#[9DFC98A8B08E3F82]-worker) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-07-23T11:10:48.569Z
   [junit4]   2> 163100 INFO  
(SUITE-TestSolrJErrorHandling-seed#[9DFC98A8B08E3F82]-worker) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-001/solr.xml
   [junit4]   2> 163382 INFO  
(SUITE-TestSolrJErrorHandling-seed#[9DFC98A8B08E3F82]-worker) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@165cc7a2, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 163653 INFO  
(SUITE-TestSolrJErrorHandling-seed#[9DFC98A8B08E3F82]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@165cc7a2
   [junit4]   2> 163743 INFO  
(SUITE-TestSolrJErrorHandling-seed#[9DFC98A8B08E3F82]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@165cc7a2
   [junit4]   2> 163743 INFO  
(SUITE-TestSolrJErrorHandling-seed#[9DFC98A8B08E3F82]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@165cc7a2
   [junit4]   2> 163874 INFO  
(SUITE-TestSolrJErrorHandling-seed#[9DFC98A8B08E3F82]-worker) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-001
   [junit4]   2> 163874 INFO  
(SUITE-TestSolrJErrorHandling-seed#[9DFC98A8B08E3F82]-worker) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 164196 WARN  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-001/collection1/../../../../contrib/extraction/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-001/collection1/../../../../contrib/extraction/lib
   [junit4]   2> 164196 WARN  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-001/collection1/../../../../dist
 filtered by solr-cell-\d.*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-001/collection1/../../../../dist
   [junit4]   2> 164196 WARN  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-001/collection1/../../../../contrib/clustering/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-001/collection1/../../../../contrib/clustering/lib
   [junit4]   2> 164196 WARN  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-001/collection1/../../../../dist
 filtered by solr-clustering-\d.*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-001/collection1/../../../../dist
   [junit4]   2> 164196 WARN  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-001/collection1/../../../../contrib/langid/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-001/collection1/../../../../contrib/langid/lib
   [junit4]   2> 164197 WARN  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-001/collection1/../../../../dist
 filtered by solr-langid-\d.*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-001/collection1/../../../../dist
   [junit4]   2> 164197 WARN  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-001/collection1/../../../../contrib/ltr/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-001/collection1/../../../../contrib/ltr/lib
   [junit4]   2> 164197 WARN  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-001/collection1/../../../../dist
 filtered by solr-ltr-\d.*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-001/collection1/../../../../dist
   [junit4]   2> 164197 WARN  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-001/collection1/../../../../contrib/velocity/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-001/collection1/../../../../contrib/velocity/lib
   [junit4]   2> 164197 WARN  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-001/collection1/../../../../dist
 filtered by solr-velocity-\d.*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-001/collection1/../../../../dist
   [junit4]   2> 164266 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.SolrIndexConfig IndexWriter infoStream solr logging is 
enabled
   [junit4]   2> 164267 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 164503 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=example
   [junit4]   2> 165529 INFO  (coreLoadExecutor-302-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> 165529 INFO  (coreLoadExecutor-302-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> 165529 INFO  (coreLoadExecutor-302-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> 165529 INFO  (coreLoadExecutor-302-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> 165530 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid 
field id
   [junit4]   2> 165530 INFO  (coreLoadExecutor-302-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> 165530 INFO  (coreLoadExecutor-302-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> 165530 INFO  (coreLoadExecutor-302-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> 165530 INFO  (coreLoadExecutor-302-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> 165778 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-001/collection1,
 trusted=true
   [junit4]   2> 165779 INFO  (coreLoadExecutor-302-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@165cc7a2
   [junit4]   2> 165779 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 165779 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-001/collection1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-001/collection1/data/]
   [junit4]   2> 165814 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-302-thread-1]: 
init: current segments file is "segments"; 
deletionPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper@47d6c39b
   [junit4]   2> 165814 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-302-thread-1]: 
now checkpoint "" [0 segments ; isCommit = false]
   [junit4]   2> 165814 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-302-thread-1]: 
0 msec to checkpoint
   [junit4]   2> 165814 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
init: create=true
   [junit4]   2> 165814 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
   [junit4]   2> dir=MockDirectoryWrapper(RAMDirectory@22e49dae 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3fe418)
   [junit4]   2> index=
   [junit4]   2> version=8.0.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=Lucene70
   [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
   [junit4]   2> 
indexerThreadPool=org.apache.lucene.index.DocumentsWriterPerThreadPool@49b9cfd8
   [junit4]   2> readerPooling=true
   [junit4]   2> perThreadHardLimitMB=1945
   [junit4]   2> useCompoundFile=false
   [junit4]   2> commitOnClose=true
   [junit4]   2> indexSort=null
   [junit4]   2> writer=org.apache.solr.update.SolrIndexWriter@4f3632ac
   [junit4]   2> 
   [junit4]   2> 165814 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
MMapDirectory.UNMAP_SUPPORTED=true
   [junit4]   2> 165814 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
now flush at close
   [junit4]   2> 165814 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]:   
start flush: applyAllDeletes=true
   [junit4]   2> 165814 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]:   
index before flush 
   [junit4]   2> 165814 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-302-thread-1]: 
startFullFlush
   [junit4]   2> 165814 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-302-thread-1]: 
coreLoadExecutor-302-thread-1 finishFullFlush success=true
   [junit4]   2> 165814 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
now apply all deletes for all segments buffered updates bytesUsed=0 reader pool 
bytesUsed=0
   [junit4]   2> 165814 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-302-thread-1]: 
waitApply: no deletes to apply
   [junit4]   2> 165814 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-302-thread-1]: 
initDynamicDefaults spins=true maxThreadCount=1 maxMergeCount=6
   [junit4]   2> 165814 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-302-thread-1]: 
updateMergeThreads ioThrottle=true targetMBPerSec=10240.0 MB/sec
   [junit4]   2> 165814 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-302-thread-1]: 
now merge
   [junit4]   2> 165814 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-302-thread-1]:   
index: 
   [junit4]   2> 165814 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-302-thread-1]:   
no more merges pending; now return
   [junit4]   2> 165814 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
waitForMerges
   [junit4]   2> 165814 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
waitForMerges done
   [junit4]   2> 165814 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
commit: start
   [junit4]   2> 165814 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
commit: enter lock
   [junit4]   2> 165814 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
commit: now prepare
   [junit4]   2> 165814 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
prepareCommit: flush
   [junit4]   2> 165814 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]:   
index before flush 
   [junit4]   2> 165814 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-302-thread-1]: 
startFullFlush
   [junit4]   2> 165814 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
now apply all deletes for all segments buffered updates bytesUsed=0 reader pool 
bytesUsed=0
   [junit4]   2> 165815 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-302-thread-1]: 
waitApply: no deletes to apply
   [junit4]   2> 165815 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-302-thread-1]: 
coreLoadExecutor-302-thread-1 finishFullFlush success=true
   [junit4]   2> 165815 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
startCommit(): start
   [junit4]   2> 165815 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
startCommit index= changeCount=2
   [junit4]   2> 165815 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
startCommit: wrote pending segments file "pending_segments_1"
   [junit4]   2> 165815 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
done all syncs: []
   [junit4]   2> 165815 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
commit: pendingCommit != null
   [junit4]   2> 165815 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
commit: done writing segments file "segments_1"
   [junit4]   2> 165815 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-302-thread-1]: 
now checkpoint "" [0 segments ; isCommit = true]
   [junit4]   2> 165815 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-302-thread-1]: 
0 msec to checkpoint
   [junit4]   2> 165815 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
commit: took 0.4 msec
   [junit4]   2> 165815 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
commit: done
   [junit4]   2> 165815 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
rollback
   [junit4]   2> 165815 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
all running merges have aborted
   [junit4]   2> 165815 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
rollback: done finish merges
   [junit4]   2> 165815 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-302-thread-1]: 
abort
   [junit4]   2> 165815 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-302-thread-1]: 
done abort success=true
   [junit4]   2> 165815 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
rollback: infos=
   [junit4]   2> 165815 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-302-thread-1]: 
now checkpoint "" [0 segments ; isCommit = false]
   [junit4]   2> 165815 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-302-thread-1]: 
0 msec to checkpoint
   [junit4]   2> 165815 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5
   [junit4]   2> 166222 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 166222 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 166223 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 
15000ms; 
   [junit4]   2> 166223 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 166224 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-302-thread-1]: 
init: current segments file is "segments_1"; 
deletionPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper@47d6c39b
   [junit4]   2> 166224 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-302-thread-1]: 
init: load commit "segments_1"
   [junit4]   2> 166224 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-302-thread-1]: 
now checkpoint "" [0 segments ; isCommit = false]
   [junit4]   2> 166224 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-302-thread-1]: 
0 msec to checkpoint
   [junit4]   2> 166224 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
init: create=false
   [junit4]   2> 166224 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
   [junit4]   2> dir=MockDirectoryWrapper(RAMDirectory@22e49dae 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3fe418)
   [junit4]   2> index=
   [junit4]   2> version=8.0.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=Lucene70
   [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
   [junit4]   2> 
indexerThreadPool=org.apache.lucene.index.DocumentsWriterPerThreadPool@41d5b5f3
   [junit4]   2> readerPooling=true
   [junit4]   2> perThreadHardLimitMB=1945
   [junit4]   2> useCompoundFile=false
   [junit4]   2> commitOnClose=true
   [junit4]   2> indexSort=null
   [junit4]   2> writer=org.apache.solr.update.SolrIndexWriter@3168a351
   [junit4]   2> 
   [junit4]   2> 166224 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
MMapDirectory.UNMAP_SUPPORTED=true
   [junit4]   2> 166224 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
flush at getReader
   [junit4]   2> 166224 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-302-thread-1]: 
startFullFlush
   [junit4]   2> 166224 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
now apply all deletes for all segments buffered updates bytesUsed=0 reader pool 
bytesUsed=0
   [junit4]   2> 166224 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-302-thread-1]: 
waitApply: no deletes to apply
   [junit4]   2> 166224 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
incRefDeleter for NRT reader version=2 segments=
   [junit4]   2> 166224 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
return reader version=2 reader=StandardDirectoryReader(segments_1:2:nrt)
   [junit4]   2> 166224 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-302-thread-1]: 
coreLoadExecutor-302-thread-1 finishFullFlush success=true
   [junit4]   2> 166225 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-302-thread-1]: 
getReader took 1 msec
   [junit4]   2> 166225 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@7a7e24db[collection1] main]
   [junit4]   2> 166225 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-001/collection1/conf
   [junit4]   2> 166225 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage Loaded LinkedHashMap at path 
_rest_managed.json using 
file:dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-001/collection1/conf
   [junit4]   2> 166225 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.r.ManagedResource Loaded initArgs {} for /rest/managed
   [junit4]   2> 166225 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage Loaded LinkedHashMap at path 
_schema_analysis_stopwords_english.json using 
file:dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-001/collection1/conf
   [junit4]   2> 166225 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.r.ManagedResource Loaded initArgs {ignoreCase=true} for 
/schema/analysis/stopwords/english
   [junit4]   2> 166225 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.r.s.a.ManagedWordSetResource Loaded 35 words for 
/schema/analysis/stopwords/english
   [junit4]   2> 166225 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.r.ManagedResource Notified 4 observers of 
/schema/analysis/stopwords/english
   [junit4]   2> 166225 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage Loaded LinkedHashMap at path 
_schema_analysis_synonyms_english.json using 
file:dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-001/collection1/conf
   [junit4]   2> 166226 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.r.ManagedResource Loaded initArgs 
{ignoreCase=true,format=solr} for /schema/analysis/synonyms/english
   [junit4]   2> 166226 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.r.s.a.ManagedSynonymGraphFilterFactory Loaded 3 synonym 
mappings for /schema/analysis/synonyms/english
   [junit4]   2> 166256 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.r.ManagedResource Notified 4 observers of 
/schema/analysis/synonyms/english
   [junit4]   2> 166256 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 166257 INFO  (coreLoadExecutor-302-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> 166257 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.h.c.SuggestComponent Initializing SuggestComponent
   [junit4]   2> 166257 INFO  (coreLoadExecutor-302-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> 166271 INFO  (coreLoadExecutor-302-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> 166271 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.h.c.QueryElevationComponent Loading QueryElevation from: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001/tempDir-001/collection1/conf/elevate.xml
   [junit4]   2> 166304 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 166304 INFO  
(searcherExecutor-303-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.QuerySenderListener QuerySenderListener sending requests to 
Searcher@7a7e24db[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 166304 INFO  
(searcherExecutor-303-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=0
   [junit4]   2> 166305 INFO  
(searcherExecutor-303-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.QuerySenderListener QuerySenderListener done.
   [junit4]   2> 166305 INFO  
(searcherExecutor-303-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 166305 INFO  
(searcherExecutor-303-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 166306 INFO  
(searcherExecutor-303-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@7a7e24db[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 166307 INFO  (coreLoadExecutor-302-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1573711513414270976
   [junit4]   2> 166709 INFO  
(SUITE-TestSolrJErrorHandling-seed#[9DFC98A8B08E3F82]-worker) [    ] 
o.a.s.SolrJettyTestBase Jetty Assigned Port#38603
   [junit4]   2> 166712 INFO  
(TEST-TestSolrJErrorHandling.testRawSocket-seed#[9DFC98A8B08E3F82]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testRawSocket
   [junit4]   2> 167500 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={}{} 0 32
   [junit4]   2> 167500 ERROR (qtp1122987211-730) [    x:collection1] 
o.a.s.h.RequestHandlerBase org.apache.solr.common.SolrException: ERROR: [doc=0] 
unknown field 'unknown_field_0'
   [junit4]   2>        at 
org.apache.solr.update.DocumentBuilder.toDocument(DocumentBuilder.java:214)
   [junit4]   2>        at 
org.apache.solr.update.AddUpdateCommand.getLuceneDocument(AddUpdateCommand.java:100)
   [junit4]   2>        at 
org.apache.solr.update.DirectUpdateHandler2.updateDocument(DirectUpdateHandler2.java:957)
   [junit4]   2>        at 
org.apache.solr.update.DirectUpdateHandler2.updateDocOrDocValues(DirectUpdateHandler2.java:948)
   [junit4]   2>        at 
org.apache.solr.update.DirectUpdateHandler2.doNormalUpdate(DirectUpdateHandler2.java:329)
   [junit4]   2>        at 
org.apache.solr.update.DirectUpdateHandler2.addDoc0(DirectUpdateHandler2.java:266)
   [junit4]   2>        at 
org.apache.solr.update.DirectUpdateHandler2.addDoc(DirectUpdateHandler2.java:216)
   [junit4]   2>        at 
org.apache.solr.update.processor.RunUpdateProcessor.processAdd(RunUpdateProcessorFactory.java:67)
   [junit4]   2>        at 
org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55)
   [junit4]   2>        at 
org.apache.solr.update.processor.DistributedUpdateProcessor.doLocalAdd(DistributedUpdateProcessor.java:990)
   [junit4]   2>        at 
org.apache.solr.update.processor.DistributedUpdateProcessor.versionAdd(DistributedUpdateProcessor.java:1206)
   [junit4]   2>        at 
org.apache.solr.update.processor.DistributedUpdateProcessor.processAdd(DistributedUpdateProcessor.java:752)
   [junit4]   2>        at 
org.apache.solr.update.processor.LogUpdateProcessorFactory$LogUpdateProcessor.processAdd(LogUpdateProcessorFactory.java:103)
   [junit4]   2>        at 
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.handleAdds(JsonLoader.java:501)
   [junit4]   2>        at 
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.processUpdate(JsonLoader.java:145)
   [junit4]   2>        at 
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.load(JsonLoader.java:121)
   [junit4]   2>        at 
org.apache.solr.handler.loader.JsonLoader.load(JsonLoader.java:84)
   [junit4]   2>        at 
org.apache.solr.handler.UpdateRequestHandler$1.load(UpdateRequestHandler.java:97)
   [junit4]   2>        at 
org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:68)
   [junit4]   2>        at 
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:177)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.execute(SolrCore.java:2473)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:720)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:526)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:378)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:322)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:395)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
   [junit4]   2>        at 
org.eclipse.jetty.server.Server.handle(Server.java:534)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
   [junit4]   2>        at 
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
   [junit4]   2>        at 
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
   [junit4]   2>        at 
org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 
   [junit4]   2> 171672 INFO  
(TEST-TestSolrJErrorHandling.testRawSocket-seed#[9DFC98A8B08E3F82]) [    ] 
o.a.s.c.s.TestSolrJErrorHandling BUFFER=HTTP/1.1 400 Bad Request
   [junit4]   2> Date: Sun, 23 Jul 2017 11:10:52 GMT
   [junit4]   2> Content-Type: text/plain;charset=utf-8
   [junit4]   2> Content-Length: 245
   [junit4]   2> Server: Jetty(9.3.14.v20161028)
   [junit4]   2> 
   [junit4]   2> 
{"responseHeader":{"status":400,"QTime":32},"error":{"metadata":["error-class","org.apache.solr.common.SolrException","root-error-class","org.apache.solr.common.SolrException"],"msg":"ERROR:
 [doc=0] unknown field 'unknown_field_0'","code":400}}
   [junit4]   2> 
   [junit4]   2> 171672 INFO  
(TEST-TestSolrJErrorHandling.testRawSocket-seed#[9DFC98A8B08E3F82]) [    ] 
o.a.s.c.s.TestSolrJErrorHandling RESPONSE BODY:HTTP/1.1 400 Bad Request
   [junit4]   2> Date: Sun, 23 Jul 2017 11:10:52 GMT
   [junit4]   2> Content-Type: text/plain;charset=utf-8
   [junit4]   2> Content-Length: 245
   [junit4]   2> Server: Jetty(9.3.14.v20161028)
   [junit4]   2> 
   [junit4]   2> 
{"responseHeader":{"status":400,"QTime":32},"error":{"metadata":["error-class","org.apache.solr.common.SolrException","root-error-class","org.apache.solr.common.SolrException"],"msg":"ERROR:
 [doc=0] unknown field 'unknown_field_0'","code":400}}
   [junit4]   2> 
   [junit4]   2> 171673 INFO  
(TEST-TestSolrJErrorHandling.testRawSocket-seed#[9DFC98A8B08E3F82]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testRawSocket
   [junit4]   2> 171675 INFO  
(TEST-TestSolrJErrorHandling.testHttpURLConnection-seed#[9DFC98A8B08E3F82]) [   
 ] o.a.s.SolrTestCaseJ4 ###Starting testHttpURLConnection
   [junit4]   2> 172598 INFO  (qtp1122987211-728) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={}{} 0 0
   [junit4]   2> 172598 ERROR (qtp1122987211-728) [    x:collection1] 
o.a.s.h.RequestHandlerBase org.apache.solr.common.SolrException: ERROR: [doc=0] 
unknown field 'unknown_field_0'
   [junit4]   2>        at 
org.apache.solr.update.DocumentBuilder.toDocument(DocumentBuilder.java:214)
   [junit4]   2>        at 
org.apache.solr.update.AddUpdateCommand.getLuceneDocument(AddUpdateCommand.java:100)
   [junit4]   2>        at 
org.apache.solr.update.DirectUpdateHandler2.updateDocument(DirectUpdateHandler2.java:957)
   [junit4]   2>        at 
org.apache.solr.update.DirectUpdateHandler2.updateDocOrDocValues(DirectUpdateHandler2.java:948)
   [junit4]   2>        at 
org.apache.solr.update.DirectUpdateHandler2.doNormalUpdate(DirectUpdateHandler2.java:329)
   [junit4]   2>        at 
org.apache.solr.update.DirectUpdateHandler2.addDoc0(DirectUpdateHandler2.java:266)
   [junit4]   2>        at 
org.apache.solr.update.DirectUpdateHandler2.addDoc(DirectUpdateHandler2.java:216)
   [junit4]   2>        at 
org.apache.solr.update.processor.RunUpdateProcessor.processAdd(RunUpdateProcessorFactory.java:67)
   [junit4]   2>        at 
org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55)
   [junit4]   2>        at 
org.apache.solr.update.processor.DistributedUpdateProcessor.doLocalAdd(DistributedUpdateProcessor.java:990)
   [junit4]   2>        at 
org.apache.solr.update.processor.DistributedUpdateProcessor.versionAdd(DistributedUpdateProcessor.java:1206)
   [junit4]   2>        at 
org.apache.solr.update.processor.DistributedUpdateProcessor.processAdd(DistributedUpdateProcessor.java:752)
   [junit4]   2>        at 
org.apache.solr.update.processor.LogUpdateProcessorFactory$LogUpdateProcessor.processAdd(LogUpdateProcessorFactory.java:103)
   [junit4]   2>        at 
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.handleAdds(JsonLoader.java:501)
   [junit4]   2>        at 
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.processUpdate(JsonLoader.java:145)
   [junit4]   2>        at 
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.load(JsonLoader.java:121)
   [junit4]   2>        at 
org.apache.solr.handler.loader.JsonLoader.load(JsonLoader.java:84)
   [junit4]   2>        at 
org.apache.solr.handler.UpdateRequestHandler$1.load(UpdateRequestHandler.java:97)
   [junit4]   2>        at 
org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:68)
   [junit4]   2>        at 
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:177)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.execute(SolrCore.java:2473)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:720)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:526)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:378)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:322)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:395)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
   [junit4]   2>        at 
org.eclipse.jetty.server.Server.handle(Server.java:534)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
   [junit4]   2>        at 
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
   [junit4]   2>        at 
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
   [junit4]   2>        at 
org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.execute(ExecuteProduceConsume.java:100)
   [junit4]   2>        at 
org.eclipse.jetty.io.ManagedSelector.run(ManagedSelector.java:147)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 
   [junit4]   2> 179223 INFO  
(TEST-TestSolrJErrorHandling.testHttpURLConnection-seed#[9DFC98A8B08E3F82]) [   
 ] o.a.s.c.s.TestSolrJErrorHandling CODE=400
   [junit4]   2> 179223 INFO  
(TEST-TestSolrJErrorHandling.testHttpURLConnection-seed#[9DFC98A8B08E3F82]) [   
 ] o.a.s.c.s.TestSolrJErrorHandling Attempting to get error stream.
   [junit4]   2> 179239 INFO  
(TEST-TestSolrJErrorHandling.testHttpURLConnection-seed#[9DFC98A8B08E3F82]) [   
 ] o.a.s.c.s.TestSolrJErrorHandling RESPONSE 
BODY:{"responseHeader":{"status":400,"QTime":0},"error":{"metadata":["error-class","org.apache.solr.common.SolrException","root-error-class","org.apache.solr.common.SolrException"],"msg":"ERROR:
 [doc=0] unknown field 'unknown_field_0'","code":400}}
   [junit4]   2> 
   [junit4]   2> 179239 INFO  
(TEST-TestSolrJErrorHandling.testHttpURLConnection-seed#[9DFC98A8B08E3F82]) [   
 ] o.a.s.SolrTestCaseJ4 ###Ending testHttpURLConnection
   [junit4]   2> 179242 INFO  
(TEST-TestSolrJErrorHandling.testWithXml-seed#[9DFC98A8B08E3F82]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testWithXml
   [junit4]   2> 179349 INFO  (qtp1122987211-731) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp1122987211-731]: anyChanges? numDocsInRam=0 
deletes=true hasTickets:false pendingChangesInFullFlush: false
   [junit4]   2> 179349 INFO  (qtp1122987211-731) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp1122987211-731]: anyChanges? numDocsInRam=0 
deletes=true hasTickets:false pendingChangesInFullFlush: false
   [junit4]   2> 179349 INFO  (qtp1122987211-731) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp1122987211-731]: nrtIsCurrent: infoVersion 
matches: true; DW changes: true; BD changes: false
   [junit4]   2> 179350 INFO  (qtp1122987211-731) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp1122987211-731]: flush at getReader
   [junit4]   2> 179350 INFO  (qtp1122987211-731) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp1122987211-731]: startFullFlush
   [junit4]   2> 179350 INFO  (qtp1122987211-731) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp1122987211-731]: anyChanges? numDocsInRam=0 
deletes=true hasTickets:false pendingChangesInFullFlush: false
   [junit4]   2> 179350 INFO  (qtp1122987211-731) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp1122987211-731]: qtp1122987211-731: flush 
naked frozen global deletes
   [junit4]   2> 179350 INFO  (qtp1122987211-731) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp1122987211-731]: compressed 76 to 48 bytes 
(63.16%) for deletes/updates; private segment null
   [junit4]   2> 179350 INFO  (qtp1122987211-731) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp1122987211-731]: push new packet (delGen=1 
numDeleteQuerys=1 bytesUsed=48), packetCount=1, bytesUsed=0.000 MB
   [junit4]   2> 179350 INFO  (qtp1122987211-731) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp1122987211-731]: flush: push buffered 
updates: delGen=1 numDeleteQuerys=1 bytesUsed=48
   [junit4]   2> 179350 INFO  (qtp1122987211-731) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp1122987211-731]: packet matches no segments
   [junit4]   2> 179350 INFO  (qtp1122987211-731) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp1122987211-731]: finished packet delGen=1 now 
completedDelGen=1
   [junit4]   2> 179350 INFO  (qtp1122987211-731) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp1122987211-731]: done apply del packet 
(delGen=1 numDeleteQuerys=1 bytesUsed=48) to 0 segments; 0 new deletes/updates; 
took 0.000 sec; 0 packets remain
   [junit4]   2> 179350 INFO  (qtp1122987211-731) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp1122987211-731]: now apply all deletes for 
all segments buffered updates bytesUsed=0 reader pool bytesUsed=0
   [junit4]   2> 179350 INFO  (qtp1122987211-731) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp1122987211-731]: waitApply: no deletes to 
apply
   [junit4]   2> 179350 INFO  (qtp1122987211-731) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp1122987211-731]: incRefDeleter for NRT reader 
version=2 segments=
   [junit4]   2> 179350 INFO  (qtp1122987211-731) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp1122987211-731]: return reader version=2 
reader=StandardDirectoryReader(segments_1:2:nrt)
   [junit4]   2> 179350 INFO  (qtp1122987211-731) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp1122987211-731]: qtp1122987211-731 
finishFullFlush success=true
   [junit4]   2> 179350 INFO  (qtp1122987211-731) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp1122987211-731]: getReader took 0 msec
   [junit4]   2> 179350 INFO  (qtp1122987211-731) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp1122987211-731]: decRefDeleter for NRT reader 
version=2 segments=
   [junit4]   2> 179350 INFO  (qtp1122987211-731) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1573711527084556288)} 0 43
   [junit4]   2> 179353 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp1122987211-730]: anyChanges? numDocsInRam=0 
deletes=true hasTickets:false pendingChangesInFullFlush: false
   [junit4]   2> 179353 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp1122987211-730]: anyChanges? numDocsInRam=0 
deletes=true hasTickets:false pendingChangesInFullFlush: false
   [junit4]   2> 179353 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp1122987211-730]: nrtIsCurrent: infoVersion 
matches: true; DW changes: true; BD changes: false
   [junit4]   2> 179353 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp1122987211-730]: flush at getReader
   [junit4]   2> 179353 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp1122987211-730]: startFullFlush
   [junit4]   2> 179353 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp1122987211-730]: anyChanges? numDocsInRam=0 
deletes=true hasTickets:false pendingChangesInFullFlush: false
   [junit4]   2> 179353 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp1122987211-730]: qtp1122987211-730: flush 
naked frozen global deletes
   [junit4]   2> 179353 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp1122987211-730]: compressed 76 to 48 bytes 
(63.16%) for deletes/updates; private segment null
   [junit4]   2> 179353 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp1122987211-730]: push new packet (delGen=2 
numDeleteQuerys=1 bytesUsed=48), packetCount=1, bytesUsed=0.000 MB
   [junit4]   2> 179353 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp1122987211-730]: flush: push buffered 
updates: delGen=2 numDeleteQuerys=1 bytesUsed=48
   [junit4]   2> 179353 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp1122987211-730]: packet matches no segments
   [junit4]   2> 179371 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp1122987211-730]: finished packet delGen=2 now 
completedDelGen=2
   [junit4]   2> 179371 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp1122987211-730]: done apply del packet 
(delGen=2 numDeleteQuerys=1 bytesUsed=48) to 0 segments; 0 new deletes/updates; 
took 0.018 sec; 0 packets remain
   [junit4]   2> 179371 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp1122987211-730]: now apply all deletes for 
all segments buffered updates bytesUsed=0 reader pool bytesUsed=0
   [junit4]   2> 179372 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp1122987211-730]: waitApply: no deletes to 
apply
   [junit4]   2> 179372 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp1122987211-730]: incRefDeleter for NRT reader 
version=2 segments=
   [junit4]   2> 179372 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp1122987211-730]: return reader version=2 
reader=StandardDirectoryReader(segments_1:2:nrt)
   [junit4]   2> 179372 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp1122987211-730]: qtp1122987211-730 
finishFullFlush success=true
   [junit4]   2> 179372 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp1122987211-730]: getReader took 19 msec
   [junit4]   2> 179372 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp1122987211-730]: decRefDeleter for NRT reader 
version=2 segments=
   [junit4]   2> 179384 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1573711527092944896)} 0 32
   [junit4]   2> 179958 INFO  (qtp1122987211-732) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711527657078784)]} 0 68
   [junit4]   2> 179959 INFO  (qtp1122987211-732) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 180133 INFO  (qtp1122987211-734) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711527910834176)]} 0 174
   [junit4]   2> 180133 INFO  (qtp1122987211-734) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 180145 INFO  (qtp1122987211-732) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711527924465664)]} 0 0
   [junit4]   2> 180145 INFO  (qtp1122987211-732) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 180149 INFO  (qtp1122987211-731) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711527927611392)]} 0 191
   [junit4]   2> 180149 INFO  (qtp1122987211-731) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 180181 INFO  (qtp1122987211-758) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711527754596352)]} 0 198
   [junit4]   2> 180208 INFO  (qtp1122987211-728) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711527931805696)]} 0 251
   [junit4]   2> 180209 INFO  (qtp1122987211-728) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 180214 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711527995768832)]} 0 259
   [junit4]   2> 180214 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 180230 INFO  (qtp1122987211-733) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711528013594624)]} 0 276
   [junit4]   2> 180230 INFO  (qtp1122987211-733) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 180238 INFO  (qtp1122987211-727) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711528021983232)]} 0 347
   [junit4]   2> 180238 INFO  (qtp1122987211-727) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 180246 INFO  (qtp1122987211-761) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711528030371840)]} 0 244
   [junit4]   2> 180247 INFO  (qtp1122987211-761) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 180263 INFO  (qtp1122987211-759) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711528047149056)]} 0 274
   [junit4]   2> 180263 INFO  (qtp1122987211-759) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 180319 INFO  (qtp1122987211-758) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 180466 INFO  (qtp1122987211-760) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711528261058560)]} 0 0
   [junit4]   2> 180466 INFO  (qtp1122987211-760) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 180469 INFO  (qtp1122987211-727) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711528264204288)]} 0 28
   [junit4]   2> 180469 INFO  (qtp1122987211-727) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 180478 INFO  (qtp1122987211-733) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711528272592896)]} 0 0
   [junit4]   2> 180478 INFO  (qtp1122987211-733) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 180530 INFO  (qtp1122987211-762) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711528327118848)]} 0 0
   [junit4]   2> 180586 INFO  (qtp1122987211-727) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711528386887680)]} 0 0
   [junit4]   2> 180586 INFO  (qtp1122987211-727) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 180591 INFO  (qtp1122987211-764) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711528392130560)]} 0 0
   [junit4]   2> 180591 INFO  (qtp1122987211-764) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 180595 INFO  (qtp1122987211-762) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 180821 INFO  (qtp1122987211-761) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711528633303040)]} 0 0
   [junit4]   2> 180822 INFO  (qtp1122987211-761) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 180851 INFO  (qtp1122987211-732) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711528664760320)]} 0 0
   [junit4]   2> 180851 INFO  (qtp1122987211-732) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 181001 INFO  (qtp1122987211-728) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711528820998144)]} 0 138
   [junit4]   2> 181001 INFO  (qtp1122987211-728) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 181061 INFO  (qtp1122987211-760) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711528884961280)]} 0 0
   [junit4]   2> 181123 INFO  (qtp1122987211-760) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 181068 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711528892301312)]} 0 0
   [junit4]   2> 181130 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 181067 INFO  (qtp1122987211-758) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711528891252736)]} 0 0
   [junit4]   2> 181147 INFO  (qtp1122987211-758) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 181063 INFO  (qtp1122987211-727) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711528887058432)]} 0 0
   [junit4]   2> 181155 INFO  (qtp1122987211-727) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 181237 INFO  (qtp1122987211-731) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711529069510656)]} 0 0
   [junit4]   2> 181239 INFO  (qtp1122987211-731) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 181240 INFO  (qtp1122987211-759) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711529071607808)]} 0 0
   [junit4]   2> 181240 INFO  (qtp1122987211-759) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 181301 INFO  (qtp1122987211-734) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711529136619520)]} 0 0
   [junit4]   2> 181301 INFO  (qtp1122987211-734) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 181340 INFO  (qtp1122987211-732) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711529177513984)]} 0 0
   [junit4]   2> 181341 INFO  (qtp1122987211-732) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 181508 INFO  (qtp1122987211-733) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711529353674752)]} 0 0
   [junit4]   2> 181508 INFO  (qtp1122987211-733) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 181568 INFO  (qtp1122987211-731) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711529415540736)]} 0 0
   [junit4]   2> 181568 INFO  (qtp1122987211-731) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 181573 INFO  (qtp1122987211-728) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711529421832192)]} 0 0
   [junit4]   2> 181573 INFO  (qtp1122987211-728) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 181601 INFO  (qtp1122987211-759) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711529451192320)]} 0 0
   [junit4]   2> 181602 INFO  (qtp1122987211-759) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 181605 INFO  (qtp1122987211-760) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711529455386624)]} 0 0
   [junit4]   2> 181605 INFO  (qtp1122987211-760) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 181631 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711529482649600)]} 0 0
   [junit4]   2> 181631 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 181634 INFO  (qtp1122987211-764) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711529485795328)]} 0 0
   [junit4]   2> 181634 INFO  (qtp1122987211-764) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 181657 INFO  (qtp1122987211-761) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711529508864000)]} 0 0
   [junit4]   2> 181657 INFO  (qtp1122987211-761) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 181703 INFO  (qtp1122987211-762) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711529558147072)]} 0 0
   [junit4]   2> 181703 INFO  (qtp1122987211-762) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 181774 INFO  (qtp1122987211-734) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711529632595968)]} 0 2
   [junit4]   2> 181775 INFO  (qtp1122987211-734) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 181780 INFO  (qtp1122987211-733) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711529638887424)]} 0 0
   [junit4]   2> 181780 INFO  (qtp1122987211-733) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 181789 INFO  (qtp1122987211-727) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711529648324608)]} 0 29
   [junit4]   2> 181789 INFO  (qtp1122987211-727) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 181798 INFO  (qtp1122987211-758) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711529656713216)]} 0 0
   [junit4]   2> 181798 INFO  (qtp1122987211-758) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 181849 INFO  (qtp1122987211-759) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711529711239168)]} 0 0
   [junit4]   2> 181850 INFO  (qtp1122987211-759) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 181856 INFO  (qtp1122987211-760) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711529718579200)]} 0 0
   [junit4]   2> 181856 INFO  (qtp1122987211-760) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 181910 INFO  (qtp1122987211-762) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711529775202304)]} 0 0
   [junit4]   2> 181911 INFO  (qtp1122987211-762) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 181928 INFO  (qtp1122987211-728) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711529793028096)]} 0 0
   [junit4]   2> 181928 INFO  (qtp1122987211-728) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 182121 INFO  (qtp1122987211-731) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711529996451840)]} 0 0
   [junit4]   2> 182142 INFO  (qtp1122987211-731) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 182161 INFO  (qtp1122987211-764) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711530038394880)]} 0 0
   [junit4]   2> 182161 INFO  (qtp1122987211-764) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 182278 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711530161078272)]} 0 0
   [junit4]   2> 182278 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 182292 INFO  (qtp1122987211-732) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711530175758336)]} 0 14
   [junit4]   2> 182292 INFO  (qtp1122987211-732) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 182309 INFO  (qtp1122987211-734) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711530193584128)]} 0 0
   [junit4]   2> 182309 INFO  (qtp1122987211-734) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 182327 INFO  (qtp1122987211-761) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711530212458496)]} 0 0
   [junit4]   2> 182328 INFO  (qtp1122987211-761) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 182386 INFO  (qtp1122987211-759) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711530274324480)]} 0 0
   [junit4]   2> 182386 INFO  (qtp1122987211-759) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 182409 INFO  (qtp1122987211-733) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711530297393152)]} 0 0
   [junit4]   2> 182409 INFO  (qtp1122987211-733) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 182419 INFO  (qtp1122987211-762) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711530308927488)]} 0 0
   [junit4]   2> 182419 INFO  (qtp1122987211-762) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 182457 INFO  (qtp1122987211-727) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711530348773376)]} 0 0
   [junit4]   2> 182458 INFO  (qtp1122987211-727) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 182471 INFO  (qtp1122987211-760) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711530363453440)]} 0 0
   [junit4]   2> 182471 INFO  (qtp1122987211-760) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 182518 INFO  (qtp1122987211-758) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711530412736512)]} 0 0
   [junit4]   2> 182519 INFO  (qtp1122987211-758) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 182525 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711530420076544)]} 0 0
   [junit4]   2> 182525 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 182557 INFO  (qtp1122987211-728) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711530453630976)]} 0 0
   [junit4]   2> 182557 INFO  (qtp1122987211-728) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 182575 INFO  (qtp1122987211-761) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711530472505344)]} 0 0
   [junit4]   2> 182576 INFO  (qtp1122987211-761) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 182597 INFO  (qtp1122987211-731) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711530495574016)]} 0 0
   [junit4]   2> 182597 INFO  (qtp1122987211-731) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 182653 INFO  (qtp1122987211-759) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711530554294272)]} 0 0
   [junit4]   2> 182653 INFO  (qtp1122987211-759) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 182721 INFO  (qtp1122987211-732) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711530624548864)]} 0 0
   [junit4]   2> 182721 INFO  (qtp1122987211-732) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 182721 INFO  (qtp1122987211-764) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711530625597440)]} 0 0
   [junit4]   2> 182722 INFO  (qtp1122987211-764) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 182731 INFO  (qtp1122987211-762) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711530636083200)]} 0 93
   [junit4]   2> 182731 INFO  (qtp1122987211-762) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 182743 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711530647617536)]} 0 0
   [junit4]   2> 182743 INFO  (qtp1122987211-730) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 182807 INFO  (qtp1122987211-728) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711530715774976)]} 0 0
   [junit4]   2> 182820 INFO  (qtp1122987211-728) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 182797 INFO  (qtp1122987211-760) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711530704240640)]} 0 0
   [junit4]   2> 182828 INFO  (qtp1122987211-760) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 182764 INFO  (qtp1122987211-758) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711530670686208)]} 0 0
   [junit4]   2> 182844 INFO  (qtp1122987211-758) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 182901 INFO  (qtp1122987211-761) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711530750377984)]} 0 61
   [junit4]   2> 182902 INFO  (qtp1122987211-761) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 182933 INFO  (qtp1122987211-734) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711530847895552)]} 0 0
   [junit4]   2> 182933 INFO  (qtp1122987211-734) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 182937 INFO  (qtp1122987211-732) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711530852089856)]} 0 0
   [junit4]   2> 182937 INFO  (qtp1122987211-732) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 182948 INFO  (qtp1122987211-733) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711530863624192)]} 0 0
   [junit4]   2> 182948 INFO  (qtp1122987211-733) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 182963 INFO  (qtp1122987211-759) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711530878304256)]} 0 0
   [junit4]   2> 182963 INFO  (qtp1122987211-759) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 183019 INFO  (qtp1122987211-727) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711530938073088)]} 0 15
   [junit4]   2> 183020 INFO  (qtp1122987211-727) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 183036 INFO  (qtp1122987211-762) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573711530955898880)]} 0 0
   [junit4]   2> 18303

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

dateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 229417 INFO  (qtp1122987211-758) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 229417 INFO  (qtp1122987211-758) [    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 1
   [junit4]   2> 229418 INFO  (qtp1122987211-758) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=id:test&fl=count_i&wt=javabin&version=2} hits=1 status=0 QTime=0
   [junit4]   2> 229418 INFO  
(TEST-TestSolrJErrorHandling.testWithBinary-seed#[9DFC98A8B08E3F82]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testWithBinary
   [junit4]   2> 229448 INFO  
(SUITE-TestSolrJErrorHandling-seed#[9DFC98A8B08E3F82]-worker) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@6be3988d{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 229448 INFO  
(SUITE-TestSolrJErrorHandling-seed#[9DFC98A8B08E3F82]-worker) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=495251107
   [junit4]   2> 229448 INFO  
(SUITE-TestSolrJErrorHandling-seed#[9DFC98A8B08E3F82]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 229450 INFO  
(SUITE-TestSolrJErrorHandling-seed#[9DFC98A8B08E3F82]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 229451 INFO  
(SUITE-TestSolrJErrorHandling-seed#[9DFC98A8B08E3F82]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 229451 INFO  
(SUITE-TestSolrJErrorHandling-seed#[9DFC98A8B08E3F82]-worker) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 229451 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@4e84fca3
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-308-thread-1]: 
now flush at close
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-308-thread-1]:  
 start flush: applyAllDeletes=true
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-308-thread-1]:  
 index before flush _6(8.0.0):C149/148:delGen=1
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-308-thread-1]: 
startFullFlush
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-308-thread-1]: 
coreCloseExecutor-308-thread-1 finishFullFlush success=true
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-308-thread-1]: 
now apply all deletes for all segments buffered updates bytesUsed=0 reader pool 
bytesUsed=0
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [BD][coreCloseExecutor-308-thread-1]: 
waitApply: no deletes to apply
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-308-thread-1]: 
updateMergeThreads ioThrottle=true targetMBPerSec=10240.0 MB/sec
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-308-thread-1]: 
now merge
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-308-thread-1]:  
 index: _6(8.0.0):C149/148:delGen=1
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-308-thread-1]:  
 no more merges pending; now return
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-308-thread-1]: 
waitForMerges
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-308-thread-1]: 
waitForMerges done
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-308-thread-1]: 
commit: start
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-308-thread-1]: 
commit: enter lock
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-308-thread-1]: 
commit: now prepare
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-308-thread-1]: 
prepareCommit: flush
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-308-thread-1]:  
 index before flush _6(8.0.0):C149/148:delGen=1
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-308-thread-1]: 
startFullFlush
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-308-thread-1]: 
now apply all deletes for all segments buffered updates bytesUsed=0 reader pool 
bytesUsed=0
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [BD][coreCloseExecutor-308-thread-1]: 
waitApply: no deletes to apply
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-308-thread-1]: 
coreCloseExecutor-308-thread-1 finishFullFlush success=true
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-308-thread-1]: 
startCommit(): start
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-308-thread-1]:  
 skip startCommit(): no changes pending
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-308-thread-1]: 
commit: pendingCommit == null; skip
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-308-thread-1]: 
commit: took 0.2 msec
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-308-thread-1]: 
commit: done
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-308-thread-1]: 
rollback
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-308-thread-1]: 
all running merges have aborted
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-308-thread-1]: 
rollback: done finish merges
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-308-thread-1]: 
abort
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-308-thread-1]: 
done abort success=true
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-308-thread-1]: 
rollback: infos=_6(8.0.0):C149/148:delGen=1
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-308-thread-1]: 
now checkpoint "_6(8.0.0):C149/148:delGen=1" [1 segments ; isCommit = false]
   [junit4]   2> 229470 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-308-thread-1]: 
0 msec to checkpoint
   [junit4]   2> 229476 INFO  (coreCloseExecutor-308-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=1317338275
   [junit4]   2> 229546 INFO  
(SUITE-TestSolrJErrorHandling-seed#[9DFC98A8B08E3F82]-worker) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@26e185a1{/solr,null,UNAVAILABLE}
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_9DFC98A8B08E3F82-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {}, 
docValues:{}, maxPointsInLeafNode=1732, maxMBSortInHeap=6.581215753290193, 
sim=RandomSimilarity(queryNorm=true): {}, locale=nl-NL, timezone=Etc/Greenwich
   [junit4]   2> NOTE: Linux 4.4.0-83-generic amd64/Oracle Corporation 
1.8.0_131 (64-bit)/cpus=4,threads=1,free=96993200,total=339738624
   [junit4]   2> NOTE: All tests run in this JVM: [LessThanEvaluatorTest, 
ClientUtilsTest, SolrQueryTest, CloudSolrClientBuilderTest, 
MergeIndexesEmbeddedTest, QueryResponseTest, ArcSineEvaluatorTest, 
JdbcDriverTest, TestSolrProperties, TestClusteringResponse, 
NaturalLogEvaluatorTest, TestConfigSetAdminRequest, SolrExampleEmbeddedTest, 
HyperbolicTangentEvaluatorTest, SineEvaluatorTest, CloudSolrClientTest, 
SelectWithEvaluatorsTest, DivideEvaluatorTest, TestCloudSolrClientConnections, 
TangentEvaluatorTest, FieldEvaluatorTest, TestSolrJErrorHandling]
   [junit4] Completed [98/135 (1!)] on J1 in 67.20s, 4 tests, 1 failure <<< 
FAILURES!

[...truncated 42499 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to