[JENKINS] Lucene-Solr-Tests-7.0 - Build # 29 - Still Unstable

[Apache Jenkins Server]

Build: https://builds.apache.org/job/Lucene-Solr-Tests-7.0/29/

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

Error Message:
expected:<857> but was:<847>

Stack Trace:
java.lang.AssertionError: expected:<857> but was:<847>
        at 
__randomizedtesting.SeedInfo.seed([1B9193AD39DE901F:B0732A5BBBD88972]: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 13995 lines...]
   [junit4] Suite: org.apache.solr.client.solrj.TestSolrJErrorHandling
   [junit4]   2> Creating dataDir: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/init-core-data-001
   [junit4]   2> 164727 INFO  
(SUITE-TestSolrJErrorHandling-seed#[1B9193AD39DE901F]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 164727 INFO  
(SUITE-TestSolrJErrorHandling-seed#[1B9193AD39DE901F]-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> 164864 INFO  
(SUITE-TestSolrJErrorHandling-seed#[1B9193AD39DE901F]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 164864 INFO  
(SUITE-TestSolrJErrorHandling-seed#[1B9193AD39DE901F]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 164864 INFO  
(SUITE-TestSolrJErrorHandling-seed#[1B9193AD39DE901F]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-002/cores/core
   [junit4]   2> 164866 INFO  
(SUITE-TestSolrJErrorHandling-seed#[1B9193AD39DE901F]-worker) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 164875 INFO  
(SUITE-TestSolrJErrorHandling-seed#[1B9193AD39DE901F]-worker) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@4e558b11{/solr,null,AVAILABLE}
   [junit4]   2> 164876 INFO  
(SUITE-TestSolrJErrorHandling-seed#[1B9193AD39DE901F]-worker) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@fc7d0e{HTTP/1.1,[http/1.1]}{127.0.0.1:45162}
   [junit4]   2> 164876 INFO  
(SUITE-TestSolrJErrorHandling-seed#[1B9193AD39DE901F]-worker) [    ] 
o.e.j.s.Server Started @173228ms
   [junit4]   2> 164876 INFO  
(SUITE-TestSolrJErrorHandling-seed#[1B9193AD39DE901F]-worker) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=45162, 
configSetBaseDir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-001,
 
coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-002/cores}
   [junit4]   2> 164876 ERROR 
(SUITE-TestSolrJErrorHandling-seed#[1B9193AD39DE901F]-worker) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 164876 INFO  
(SUITE-TestSolrJErrorHandling-seed#[1B9193AD39DE901F]-worker) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 164876 INFO  
(SUITE-TestSolrJErrorHandling-seed#[1B9193AD39DE901F]-worker) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 164876 INFO  
(SUITE-TestSolrJErrorHandling-seed#[1B9193AD39DE901F]-worker) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 164876 INFO  
(SUITE-TestSolrJErrorHandling-seed#[1B9193AD39DE901F]-worker) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-07-16T15:01:56.496Z
   [junit4]   2> 164877 INFO  
(SUITE-TestSolrJErrorHandling-seed#[1B9193AD39DE901F]-worker) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-001/solr.xml
   [junit4]   2> 164881 INFO  
(SUITE-TestSolrJErrorHandling-seed#[1B9193AD39DE901F]-worker) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@25beb752, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 164953 INFO  
(SUITE-TestSolrJErrorHandling-seed#[1B9193AD39DE901F]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25beb752
   [junit4]   2> 164968 INFO  
(SUITE-TestSolrJErrorHandling-seed#[1B9193AD39DE901F]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25beb752
   [junit4]   2> 164968 INFO  
(SUITE-TestSolrJErrorHandling-seed#[1B9193AD39DE901F]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25beb752
   [junit4]   2> 164981 INFO  
(SUITE-TestSolrJErrorHandling-seed#[1B9193AD39DE901F]-worker) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-001
   [junit4]   2> 164981 INFO  
(SUITE-TestSolrJErrorHandling-seed#[1B9193AD39DE901F]-worker) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 165052 WARN  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-001/collection1/../../../../contrib/extraction/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-001/collection1/../../../../contrib/extraction/lib
   [junit4]   2> 165094 WARN  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-001/collection1/../../../../dist
 filtered by solr-cell-\d.*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-001/collection1/../../../../dist
   [junit4]   2> 165094 WARN  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-001/collection1/../../../../contrib/clustering/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-001/collection1/../../../../contrib/clustering/lib
   [junit4]   2> 165094 WARN  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-001/collection1/../../../../dist
 filtered by solr-clustering-\d.*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-001/collection1/../../../../dist
   [junit4]   2> 165094 WARN  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-001/collection1/../../../../contrib/langid/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-001/collection1/../../../../contrib/langid/lib
   [junit4]   2> 165094 WARN  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-001/collection1/../../../../dist
 filtered by solr-langid-\d.*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-001/collection1/../../../../dist
   [junit4]   2> 165094 WARN  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-001/collection1/../../../../contrib/ltr/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-001/collection1/../../../../contrib/ltr/lib
   [junit4]   2> 165095 WARN  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-001/collection1/../../../../dist
 filtered by solr-ltr-\d.*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-001/collection1/../../../../dist
   [junit4]   2> 165095 WARN  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-001/collection1/../../../../contrib/velocity/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-001/collection1/../../../../contrib/velocity/lib
   [junit4]   2> 165095 WARN  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-001/collection1/../../../../dist
 filtered by solr-velocity-\d.*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-001/collection1/../../../../dist
   [junit4]   2> 165113 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.SolrIndexConfig IndexWriter infoStream solr logging is 
enabled
   [junit4]   2> 165131 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 165231 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=example
   [junit4]   2> 166260 INFO  (coreLoadExecutor-387-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> 166260 INFO  (coreLoadExecutor-387-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> 166260 INFO  (coreLoadExecutor-387-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> 166260 INFO  (coreLoadExecutor-387-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> 166262 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid 
field id
   [junit4]   2> 166262 INFO  (coreLoadExecutor-387-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> 166262 INFO  (coreLoadExecutor-387-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> 166262 INFO  (coreLoadExecutor-387-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> 166262 INFO  (coreLoadExecutor-387-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> 166327 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-001/collection1,
 trusted=true
   [junit4]   2> 166327 INFO  (coreLoadExecutor-387-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@25beb752
   [junit4]   2> 166327 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 166327 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-001/collection1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-001/collection1/data/]
   [junit4]   2> 166341 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-387-thread-1]: 
init: current segments file is "segments"; 
deletionPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper@20517307
   [junit4]   2> 166341 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-387-thread-1]: 
now checkpoint "" [0 segments ; isCommit = false]
   [junit4]   2> 166341 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-387-thread-1]: 
0 msec to checkpoint
   [junit4]   2> 166341 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
init: create=true
   [junit4]   2> 166341 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
   [junit4]   2> dir=MockDirectoryWrapper(RAMDirectory@4a761759 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@64b866c5)
   [junit4]   2> index=
   [junit4]   2> version=7.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@57c5d216
   [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@2df3cb68
   [junit4]   2> 
   [junit4]   2> 166341 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
MMapDirectory.UNMAP_SUPPORTED=true
   [junit4]   2> 166341 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
now flush at close
   [junit4]   2> 166341 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]:   
start flush: applyAllDeletes=true
   [junit4]   2> 166341 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]:   
index before flush 
   [junit4]   2> 166341 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-387-thread-1]: 
startFullFlush
   [junit4]   2> 166341 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-387-thread-1]: 
coreLoadExecutor-387-thread-1 finishFullFlush success=true
   [junit4]   2> 166341 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
now apply all deletes for all segments buffered updates bytesUsed=0 reader pool 
bytesUsed=0
   [junit4]   2> 166341 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-387-thread-1]: 
waitApply: no deletes to apply
   [junit4]   2> 166341 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-387-thread-1]: 
initDynamicDefaults spins=false maxThreadCount=1 maxMergeCount=6
   [junit4]   2> 166341 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-387-thread-1]: 
updateMergeThreads ioThrottle=true targetMBPerSec=10240.0 MB/sec
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-387-thread-1]: 
now merge
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-387-thread-1]:   
index: 
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-387-thread-1]:   
no more merges pending; now return
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
waitForMerges
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
waitForMerges done
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
commit: start
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
commit: enter lock
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
commit: now prepare
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
prepareCommit: flush
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]:   
index before flush 
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-387-thread-1]: 
startFullFlush
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
now apply all deletes for all segments buffered updates bytesUsed=0 reader pool 
bytesUsed=0
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-387-thread-1]: 
waitApply: no deletes to apply
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-387-thread-1]: 
coreLoadExecutor-387-thread-1 finishFullFlush success=true
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
startCommit(): start
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
startCommit index= changeCount=2
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
startCommit: wrote pending segments file "pending_segments_1"
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
done all syncs: []
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
commit: pendingCommit != null
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
commit: done writing segments file "segments_1"
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-387-thread-1]: 
now checkpoint "" [0 segments ; isCommit = true]
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-387-thread-1]: 
0 msec to checkpoint
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
commit: took 0.4 msec
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
commit: done
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
rollback
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
all running merges have aborted
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
rollback: done finish merges
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-387-thread-1]: 
abort
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-387-thread-1]: 
done abort success=true
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
rollback: infos=
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-387-thread-1]: 
now checkpoint "" [0 segments ; isCommit = false]
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-387-thread-1]: 
0 msec to checkpoint
   [junit4]   2> 166342 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5
   [junit4]   2> 166493 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 166493 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 166494 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 
15000ms; 
   [junit4]   2> 166494 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 166507 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-387-thread-1]: 
init: current segments file is "segments_1"; 
deletionPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper@20517307
   [junit4]   2> 166507 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-387-thread-1]: 
init: load commit "segments_1"
   [junit4]   2> 166507 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-387-thread-1]: 
now checkpoint "" [0 segments ; isCommit = false]
   [junit4]   2> 166508 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-387-thread-1]: 
0 msec to checkpoint
   [junit4]   2> 166508 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
init: create=false
   [junit4]   2> 166508 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
   [junit4]   2> dir=MockDirectoryWrapper(RAMDirectory@4a761759 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@64b866c5)
   [junit4]   2> index=
   [junit4]   2> version=7.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@7170eb63
   [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@32236c46
   [junit4]   2> 
   [junit4]   2> 166508 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
MMapDirectory.UNMAP_SUPPORTED=true
   [junit4]   2> 166508 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
flush at getReader
   [junit4]   2> 166508 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-387-thread-1]: 
startFullFlush
   [junit4]   2> 166508 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
now apply all deletes for all segments buffered updates bytesUsed=0 reader pool 
bytesUsed=0
   [junit4]   2> 166508 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-387-thread-1]: 
waitApply: no deletes to apply
   [junit4]   2> 166508 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
incRefDeleter for NRT reader version=2 segments=
   [junit4]   2> 166508 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
return reader version=2 reader=StandardDirectoryReader(segments_1:2:nrt)
   [junit4]   2> 166508 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-387-thread-1]: 
coreLoadExecutor-387-thread-1 finishFullFlush success=true
   [junit4]   2> 166508 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-387-thread-1]: 
getReader took 0 msec
   [junit4]   2> 166508 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@6062d5c7[collection1] main]
   [junit4]   2> 166508 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-001/collection1/conf
   [junit4]   2> 166508 INFO  (coreLoadExecutor-387-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-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-001/collection1/conf
   [junit4]   2> 166508 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.r.ManagedResource Loaded initArgs {} for /rest/managed
   [junit4]   2> 166508 INFO  (coreLoadExecutor-387-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-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-001/collection1/conf
   [junit4]   2> 166509 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.r.ManagedResource Loaded initArgs {ignoreCase=true} for 
/schema/analysis/stopwords/english
   [junit4]   2> 166509 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.r.s.a.ManagedWordSetResource Loaded 35 words for 
/schema/analysis/stopwords/english
   [junit4]   2> 166509 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.r.ManagedResource Notified 4 observers of 
/schema/analysis/stopwords/english
   [junit4]   2> 166509 INFO  (coreLoadExecutor-387-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-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-001/collection1/conf
   [junit4]   2> 166509 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.r.ManagedResource Loaded initArgs 
{ignoreCase=true,format=solr} for /schema/analysis/synonyms/english
   [junit4]   2> 166509 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.r.s.a.ManagedSynonymGraphFilterFactory Loaded 3 synonym 
mappings for /schema/analysis/synonyms/english
   [junit4]   2> 166509 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.r.ManagedResource Notified 4 observers of 
/schema/analysis/synonyms/english
   [junit4]   2> 166510 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 166510 INFO  (coreLoadExecutor-387-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> 166510 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.h.c.SuggestComponent Initializing SuggestComponent
   [junit4]   2> 166510 INFO  (coreLoadExecutor-387-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> 166510 INFO  (coreLoadExecutor-387-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> 166510 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.h.c.QueryElevationComponent Loading QueryElevation from: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001/tempDir-001/collection1/conf/elevate.xml
   [junit4]   2> 166526 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 166526 INFO  
(searcherExecutor-388-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.QuerySenderListener QuerySenderListener sending requests to 
Searcher@6062d5c7[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 166564 INFO  
(searcherExecutor-388-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> 166564 INFO  
(searcherExecutor-388-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.QuerySenderListener QuerySenderListener done.
   [junit4]   2> 166564 INFO  
(searcherExecutor-388-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 166564 INFO  
(searcherExecutor-388-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 166565 INFO  
(searcherExecutor-388-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6062d5c7[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 166526 INFO  (coreLoadExecutor-387-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1573091874592260096
   [junit4]   2> 166588 INFO  
(SUITE-TestSolrJErrorHandling-seed#[1B9193AD39DE901F]-worker) [    ] 
o.a.s.SolrJettyTestBase Jetty Assigned Port#45162
   [junit4]   2> 166598 INFO  
(TEST-TestSolrJErrorHandling.testHttpURLConnection-seed#[1B9193AD39DE901F]) [   
 ] o.a.s.SolrTestCaseJ4 ###Starting testHttpURLConnection
   [junit4]   2> 167284 INFO  (qtp1160869160-1266) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={}{} 0 37
   [junit4]   2> 167348 ERROR (qtp1160869160-1266) [    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> 173110 INFO  
(TEST-TestSolrJErrorHandling.testHttpURLConnection-seed#[1B9193AD39DE901F]) [   
 ] o.a.s.c.s.TestSolrJErrorHandling CODE=400
   [junit4]   2> 173110 INFO  
(TEST-TestSolrJErrorHandling.testHttpURLConnection-seed#[1B9193AD39DE901F]) [   
 ] o.a.s.c.s.TestSolrJErrorHandling Attempting to get error stream.
   [junit4]   2> 173110 INFO  
(TEST-TestSolrJErrorHandling.testHttpURLConnection-seed#[1B9193AD39DE901F]) [   
 ] o.a.s.c.s.TestSolrJErrorHandling RESPONSE 
BODY:{"responseHeader":{"status":400,"QTime":103},"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> 173110 INFO  
(TEST-TestSolrJErrorHandling.testHttpURLConnection-seed#[1B9193AD39DE901F]) [   
 ] o.a.s.SolrTestCaseJ4 ###Ending testHttpURLConnection
   [junit4]   2> 173127 INFO  
(TEST-TestSolrJErrorHandling.testRawSocket-seed#[1B9193AD39DE901F]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testRawSocket
   [junit4]   2> 173370 INFO  (qtp1160869160-1264) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={}{} 0 0
   [junit4]   2> 173370 ERROR (qtp1160869160-1264) [    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> 175863 INFO  
(TEST-TestSolrJErrorHandling.testRawSocket-seed#[1B9193AD39DE901F]) [    ] 
o.a.s.c.s.TestSolrJErrorHandling BUFFER=HTTP/1.1 400 Bad Request
   [junit4]   2> Date: Sun, 16 Jul 2017 15:02:04 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":54},"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> 175863 INFO  
(TEST-TestSolrJErrorHandling.testRawSocket-seed#[1B9193AD39DE901F]) [    ] 
o.a.s.c.s.TestSolrJErrorHandling RESPONSE BODY:HTTP/1.1 400 Bad Request
   [junit4]   2> Date: Sun, 16 Jul 2017 15:02:04 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":54},"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> 175863 INFO  
(TEST-TestSolrJErrorHandling.testRawSocket-seed#[1B9193AD39DE901F]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testRawSocket
   [junit4]   2> 175878 INFO  
(TEST-TestSolrJErrorHandling.testWithBinary-seed#[1B9193AD39DE901F]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testWithBinary
   [junit4]   2> 175926 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp1160869160-1263]: anyChanges? numDocsInRam=0 
deletes=true hasTickets:false pendingChangesInFullFlush: false
   [junit4]   2> 175926 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp1160869160-1263]: anyChanges? numDocsInRam=0 
deletes=true hasTickets:false pendingChangesInFullFlush: false
   [junit4]   2> 175926 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp1160869160-1263]: nrtIsCurrent: infoVersion 
matches: true; DW changes: true; BD changes: false
   [junit4]   2> 175926 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp1160869160-1263]: flush at getReader
   [junit4]   2> 175926 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp1160869160-1263]: startFullFlush
   [junit4]   2> 175926 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp1160869160-1263]: anyChanges? numDocsInRam=0 
deletes=true hasTickets:false pendingChangesInFullFlush: false
   [junit4]   2> 175926 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp1160869160-1263]: qtp1160869160-1263: flush 
naked frozen global deletes
   [junit4]   2> 175926 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp1160869160-1263]: compressed 76 to 48 bytes 
(63.16%) for deletes/updates; private segment null
   [junit4]   2> 175926 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp1160869160-1263]: push new packet (delGen=1 
numDeleteQuerys=1 bytesUsed=48), packetCount=1, bytesUsed=0.000 MB
   [junit4]   2> 175926 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp1160869160-1263]: flush: push buffered 
updates: delGen=1 numDeleteQuerys=1 bytesUsed=48
   [junit4]   2> 175926 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp1160869160-1263]: packet matches no segments
   [junit4]   2> 175927 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp1160869160-1263]: finished packet delGen=1 
now completedDelGen=1
   [junit4]   2> 175927 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp1160869160-1263]: 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> 175927 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp1160869160-1263]: now apply all deletes for 
all segments buffered updates bytesUsed=0 reader pool bytesUsed=0
   [junit4]   2> 175927 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp1160869160-1263]: waitApply: no deletes to 
apply
   [junit4]   2> 175927 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp1160869160-1263]: incRefDeleter for NRT 
reader version=2 segments=
   [junit4]   2> 175927 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp1160869160-1263]: return reader version=2 
reader=StandardDirectoryReader(segments_1:2:nrt)
   [junit4]   2> 175927 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp1160869160-1263]: qtp1160869160-1263 
finishFullFlush success=true
   [junit4]   2> 175927 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp1160869160-1263]: getReader took 1 msec
   [junit4]   2> 175927 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp1160869160-1263]: decRefDeleter for NRT 
reader version=2 segments=
   [junit4]   2> 175927 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1573091884400640000)} 0 46
   [junit4]   2> 175928 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp1160869160-1263]: anyChanges? numDocsInRam=0 
deletes=true hasTickets:false pendingChangesInFullFlush: false
   [junit4]   2> 175928 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp1160869160-1263]: anyChanges? numDocsInRam=0 
deletes=true hasTickets:false pendingChangesInFullFlush: false
   [junit4]   2> 175928 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp1160869160-1263]: nrtIsCurrent: infoVersion 
matches: true; DW changes: true; BD changes: false
   [junit4]   2> 175928 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp1160869160-1263]: flush at getReader
   [junit4]   2> 175928 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp1160869160-1263]: startFullFlush
   [junit4]   2> 175928 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp1160869160-1263]: anyChanges? numDocsInRam=0 
deletes=true hasTickets:false pendingChangesInFullFlush: false
   [junit4]   2> 175928 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp1160869160-1263]: qtp1160869160-1263: flush 
naked frozen global deletes
   [junit4]   2> 175928 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp1160869160-1263]: compressed 76 to 48 bytes 
(63.16%) for deletes/updates; private segment null
   [junit4]   2> 175928 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp1160869160-1263]: push new packet (delGen=2 
numDeleteQuerys=1 bytesUsed=48), packetCount=1, bytesUsed=0.000 MB
   [junit4]   2> 175928 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp1160869160-1263]: flush: push buffered 
updates: delGen=2 numDeleteQuerys=1 bytesUsed=48
   [junit4]   2> 175928 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp1160869160-1263]: packet matches no segments
   [junit4]   2> 175928 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp1160869160-1263]: finished packet delGen=2 
now completedDelGen=2
   [junit4]   2> 175928 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp1160869160-1263]: done apply del packet 
(delGen=2 numDeleteQuerys=1 bytesUsed=48) to 0 segments; 0 new deletes/updates; 
took 0.000 sec; 0 packets remain
   [junit4]   2> 175928 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp1160869160-1263]: now apply all deletes for 
all segments buffered updates bytesUsed=0 reader pool bytesUsed=0
   [junit4]   2> 175928 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp1160869160-1263]: waitApply: no deletes to 
apply
   [junit4]   2> 175928 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp1160869160-1263]: incRefDeleter for NRT 
reader version=2 segments=
   [junit4]   2> 175928 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp1160869160-1263]: return reader version=2 
reader=StandardDirectoryReader(segments_1:2:nrt)
   [junit4]   2> 175928 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp1160869160-1263]: qtp1160869160-1263 
finishFullFlush success=true
   [junit4]   2> 175928 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp1160869160-1263]: getReader took 0 msec
   [junit4]   2> 175928 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp1160869160-1263]: decRefDeleter for NRT 
reader version=2 segments=
   [junit4]   2> 175928 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1573091884450971648)} 0 0
   [junit4]   2> 176222 INFO  (qtp1160869160-1266) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091884618743808)]} 0 133
   [junit4]   2> 176222 INFO  (qtp1160869160-1266) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176449 INFO  (qtp1160869160-1269) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091884761350144)]} 0 296
   [junit4]   2> 176449 INFO  (qtp1160869160-1269) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176453 INFO  (qtp1160869160-1267) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885001474048)]} 0 314
   [junit4]   2> 176453 INFO  (qtp1160869160-1267) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176469 INFO  (qtp1160869160-1264) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885018251264)]} 0 331
   [junit4]   2> 176470 INFO  (qtp1160869160-1264) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176485 INFO  (qtp1160869160-1270) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885035028480)]} 0 348
   [junit4]   2> 176486 INFO  (qtp1160869160-1270) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176518 INFO  (qtp1160869160-1268) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885069631488)]} 0 417
   [junit4]   2> 176518 INFO  (qtp1160869160-1268) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176534 INFO  (qtp1160869160-1269) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885086408704)]} 0 20
   [junit4]   2> 176534 INFO  (qtp1160869160-1297) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885086408706)]} 0 227
   [junit4]   2> 176534 INFO  (qtp1160869160-1269) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176534 INFO  (qtp1160869160-1297) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176550 INFO  (qtp1160869160-1266) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885103185920)]} 0 267
   [junit4]   2> 176551 INFO  (qtp1160869160-1266) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176553 INFO  (qtp1160869160-1296) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885106331648)]} 0 294
   [junit4]   2> 176554 INFO  (qtp1160869160-1296) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176571 INFO  (qtp1160869160-1295) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885124157440)]} 0 339
   [junit4]   2> 176571 INFO  (qtp1160869160-1295) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176573 INFO  (qtp1160869160-1294) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885127303168)]} 0 343
   [junit4]   2> 176573 INFO  (qtp1160869160-1294) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176580 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885134643200)]} 0 0
   [junit4]   2> 176580 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176584 INFO  (qtp1160869160-1298) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885137788928)]} 0 0
   [junit4]   2> 176584 INFO  (qtp1160869160-1298) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176617 INFO  (qtp1160869160-1270) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885172391936)]} 0 0
   [junit4]   2> 176617 INFO  (qtp1160869160-1270) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176644 INFO  (qtp1160869160-1268) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885201752064)]} 0 0
   [junit4]   2> 176644 INFO  (qtp1160869160-1268) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176652 INFO  (qtp1160869160-1295) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885210140672)]} 0 0
   [junit4]   2> 176652 INFO  (qtp1160869160-1295) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176686 INFO  (qtp1160869160-1269) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885245792256)]} 0 0
   [junit4]   2> 176687 INFO  (qtp1160869160-1269) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176687 INFO  (qtp1160869160-1270) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885246840832)]} 0 0
   [junit4]   2> 176800 INFO  (qtp1160869160-1266) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885365329920)]} 0 0
   [junit4]   2> 176801 INFO  (qtp1160869160-1266) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176802 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885367427072)]} 0 0
   [junit4]   2> 176803 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176807 INFO  (qtp1160869160-1300) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885372669952)]} 0 0
   [junit4]   2> 176807 INFO  (qtp1160869160-1300) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176832 INFO  (qtp1160869160-1297) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885397835776)]} 0 0
   [junit4]   2> 176832 INFO  (qtp1160869160-1297) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176847 INFO  (qtp1160869160-1269) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885414612992)]} 0 0
   [junit4]   2> 176847 INFO  (qtp1160869160-1269) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176863 INFO  (qtp1160869160-1270) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176867 INFO  (qtp1160869160-1296) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885435584512)]} 0 0
   [junit4]   2> 176867 INFO  (qtp1160869160-1296) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176888 INFO  (qtp1160869160-1298) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885457604608)]} 0 0
   [junit4]   2> 176888 INFO  (qtp1160869160-1298) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176908 INFO  (qtp1160869160-1294) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885478576128)]} 0 0
   [junit4]   2> 176908 INFO  (qtp1160869160-1294) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176923 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885494304768)]} 0 0
   [junit4]   2> 176923 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176937 INFO  (qtp1160869160-1264) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885508984832)]} 0 0
   [junit4]   2> 176937 INFO  (qtp1160869160-1264) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176959 INFO  (qtp1160869160-1300) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885531004928)]} 0 0
   [junit4]   2> 176959 INFO  (qtp1160869160-1300) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176969 INFO  (qtp1160869160-1267) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885541490688)]} 0 0
   [junit4]   2> 176969 INFO  (qtp1160869160-1267) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176976 INFO  (qtp1160869160-1268) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885548830720)]} 0 0
   [junit4]   2> 176976 INFO  (qtp1160869160-1268) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176978 INFO  (qtp1160869160-1270) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885551976448)]} 0 0
   [junit4]   2> 176978 INFO  (qtp1160869160-1270) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176990 INFO  (qtp1160869160-1295) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885564559360)]} 0 0
   [junit4]   2> 176991 INFO  (qtp1160869160-1295) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 176994 INFO  (qtp1160869160-1266) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885568753664)]} 0 0
   [junit4]   2> 176994 INFO  (qtp1160869160-1266) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177060 INFO  (qtp1160869160-1294) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885637959680)]} 0 0
   [junit4]   2> 177061 INFO  (qtp1160869160-1294) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177107 INFO  (qtp1160869160-1269) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885687242752)]} 0 0
   [junit4]   2> 177107 INFO  (qtp1160869160-1269) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177123 INFO  (qtp1160869160-1296) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885704019968)]} 0 0
   [junit4]   2> 177123 INFO  (qtp1160869160-1296) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177126 INFO  (qtp1160869160-1297) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885707165696)]} 0 0
   [junit4]   2> 177139 INFO  (qtp1160869160-1298) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885720797184)]} 0 0
   [junit4]   2> 177140 INFO  (qtp1160869160-1298) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177167 INFO  (qtp1160869160-1301) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885728137216)]} 0 21
   [junit4]   2> 177168 INFO  (qtp1160869160-1301) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177168 INFO  (qtp1160869160-1270) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885751205888)]} 0 12
   [junit4]   2> 177168 INFO  (qtp1160869160-1270) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177170 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885753303040)]} 0 2
   [junit4]   2> 177170 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177171 INFO  (qtp1160869160-1297) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177186 INFO  (qtp1160869160-1295) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885769031680)]} 0 0
   [junit4]   2> 177186 INFO  (qtp1160869160-1295) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177217 INFO  (qtp1160869160-1300) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885802586112)]} 0 0
   [junit4]   2> 177218 INFO  (qtp1160869160-1300) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177226 INFO  (qtp1160869160-1294) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885812023296)]} 0 0
   [junit4]   2> 177226 INFO  (qtp1160869160-1294) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177232 INFO  (qtp1160869160-1267) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885818314752)]} 0 77
   [junit4]   2> 177232 INFO  (qtp1160869160-1267) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177242 INFO  (qtp1160869160-1296) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885827751936)]} 0 0
   [junit4]   2> 177242 INFO  (qtp1160869160-1296) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177265 INFO  (qtp1160869160-1297) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885852917760)]} 0 0
   [junit4]   2> 177265 INFO  (qtp1160869160-1297) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177286 INFO  (qtp1160869160-1301) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885873889280)]} 0 0
   [junit4]   2> 177286 INFO  (qtp1160869160-1301) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177302 INFO  (qtp1160869160-1298) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885891715072)]} 0 0
   [junit4]   2> 177302 INFO  (qtp1160869160-1298) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177337 INFO  (qtp1160869160-1269) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885928415232)]} 0 0
   [junit4]   2> 177338 INFO  (qtp1160869160-1269) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177353 INFO  (qtp1160869160-1297) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885945192448)]} 0 0
   [junit4]   2> 177353 INFO  (qtp1160869160-1297) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177386 INFO  (qtp1160869160-1295) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885979795456)]} 0 0
   [junit4]   2> 177386 INFO  (qtp1160869160-1295) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177402 INFO  (qtp1160869160-1294) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885996572672)]} 0 0
   [junit4]   2> 177402 INFO  (qtp1160869160-1294) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177402 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091885996572674)]} 0 0
   [junit4]   2> 177402 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177415 INFO  (qtp1160869160-1268) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091886010204160)]} 0 0
   [junit4]   2> 177416 INFO  (qtp1160869160-1268) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177417 INFO  (qtp1160869160-1296) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091886012301312)]} 0 0
   [junit4]   2> 177417 INFO  (qtp1160869160-1296) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177433 INFO  (qtp1160869160-1298) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091886029078528)]} 0 0
   [junit4]   2> 177434 INFO  (qtp1160869160-1298) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177435 INFO  (qtp1160869160-1266) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091886031175680)]} 0 0
   [junit4]   2> 177526 INFO  (qtp1160869160-1266) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177531 INFO  (qtp1160869160-1264) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091886130790400)]} 0 0
   [junit4]   2> 177531 INFO  (qtp1160869160-1264) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177569 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091886171684864)]} 0 0
   [junit4]   2> 177585 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177610 INFO  (qtp1160869160-1297) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091886213627904)]} 0 0
   [junit4]   2> 177610 INFO  (qtp1160869160-1297) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177623 INFO  (qtp1160869160-1301) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091886228307968)]} 0 0
   [junit4]   2> 177623 INFO  (qtp1160869160-1301) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177630 INFO  (qtp1160869160-1296) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091886235648000)]} 0 0
   [junit4]   2> 177630 INFO  (qtp1160869160-1296) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177649 INFO  (qtp1160869160-1264) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091886255570944)]} 0 0
   [junit4]   2> 177649 INFO  (qtp1160869160-1264) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177706 INFO  (qtp1160869160-1298) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091886315339776)]} 0 0
   [junit4]   2> 177707 INFO  (qtp1160869160-1298) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177738 INFO  (qtp1160869160-1301) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091886347845632)]} 0 0
   [junit4]   2> 177738 INFO  (qtp1160869160-1301) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177785 INFO  (qtp1160869160-1295) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091886398177280)]} 0 0
   [junit4]   2> 177786 INFO  (qtp1160869160-1295) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177796 INFO  (qtp1160869160-1264) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091886409711616)]} 0 0
   [junit4]   2> 177796 INFO  (qtp1160869160-1264) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177810 INFO  (qtp1160869160-1267) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091886424391680)]} 0 0
   [junit4]   2> 177810 INFO  (qtp1160869160-1267) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177813 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091886427537408)]} 0 0
   [junit4]   2> 177814 INFO  (qtp1160869160-1263) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177821 INFO  (qtp1160869160-1269) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091886435926016)]} 0 0
   [junit4]   2> 177826 INFO  (qtp1160869160-1300) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091886441168896)]} 0 0
   [junit4]   2> 177826 INFO  (qtp1160869160-1300) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177847 INFO  (qtp1160869160-1294) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091886463188992)]} 0 0
   [junit4]   2> 177847 INFO  (qtp1160869160-1294) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177851 INFO  (qtp1160869160-1301) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573091886467383296)]} 0 0
   [junit4]   2> 177852 INFO  (qtp1160869160-1301) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 177870 INFO  (qtp1160869160-1269) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring 

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

multiplier=2 -Dtests.slow=true -Dtests.locale=en-MT -Dtests.timezone=US/Samoa 
-Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] FAILURE 31.4s J2 | TestSolrJErrorHandling.testWithXml <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: expected:<857> but 
was:<847>
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([1B9193AD39DE901F:B0732A5BBBD88972]:0)
   [junit4]    >        at 
org.apache.solr.client.solrj.TestSolrJErrorHandling.doThreads(TestSolrJErrorHandling.java:185)
   [junit4]    >        at 
org.apache.solr.client.solrj.TestSolrJErrorHandling.doIt(TestSolrJErrorHandling.java:200)
   [junit4]    >        at 
org.apache.solr.client.solrj.TestSolrJErrorHandling.testWithXml(TestSolrJErrorHandling.java:110)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 225654 INFO  
(SUITE-TestSolrJErrorHandling-seed#[1B9193AD39DE901F]-worker) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@fc7d0e{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 225654 INFO  
(SUITE-TestSolrJErrorHandling-seed#[1B9193AD39DE901F]-worker) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=65928112
   [junit4]   2> 225666 INFO  
(SUITE-TestSolrJErrorHandling-seed#[1B9193AD39DE901F]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 225667 INFO  
(SUITE-TestSolrJErrorHandling-seed#[1B9193AD39DE901F]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 225668 INFO  
(SUITE-TestSolrJErrorHandling-seed#[1B9193AD39DE901F]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 225668 INFO  
(SUITE-TestSolrJErrorHandling-seed#[1B9193AD39DE901F]-worker) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 225682 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@32962ba6
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-393-thread-1]: 
now flush at close
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-393-thread-1]:  
 start flush: applyAllDeletes=true
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-393-thread-1]:  
 index before flush _5(7.0.0):C438/437:delGen=1 _6(7.0.0):C10/10:delGen=1
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-393-thread-1]: 
startFullFlush
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-393-thread-1]: 
coreCloseExecutor-393-thread-1 finishFullFlush success=true
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-393-thread-1]: 
now apply all deletes for all segments buffered updates bytesUsed=0 reader pool 
bytesUsed=0
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [BD][coreCloseExecutor-393-thread-1]: 
waitApply: no deletes to apply
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-393-thread-1]: 
updateMergeThreads ioThrottle=true targetMBPerSec=10240.0 MB/sec
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-393-thread-1]: 
now merge
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-393-thread-1]:  
 index: _5(7.0.0):C438/437:delGen=1 _6(7.0.0):C10/10:delGen=1
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-393-thread-1]:  
 no more merges pending; now return
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-393-thread-1]: 
waitForMerges
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-393-thread-1]: 
waitForMerges done
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-393-thread-1]: 
commit: start
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-393-thread-1]: 
commit: enter lock
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-393-thread-1]: 
commit: now prepare
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-393-thread-1]: 
prepareCommit: flush
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-393-thread-1]:  
 index before flush _5(7.0.0):C438/437:delGen=1 _6(7.0.0):C10/10:delGen=1
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-393-thread-1]: 
startFullFlush
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-393-thread-1]: 
now apply all deletes for all segments buffered updates bytesUsed=0 reader pool 
bytesUsed=0
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [BD][coreCloseExecutor-393-thread-1]: 
waitApply: no deletes to apply
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-393-thread-1]: 
coreCloseExecutor-393-thread-1 finishFullFlush success=true
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-393-thread-1]: 
startCommit(): start
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-393-thread-1]:  
 skip startCommit(): no changes pending
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-393-thread-1]: 
commit: pendingCommit == null; skip
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-393-thread-1]: 
commit: took 0.2 msec
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-393-thread-1]: 
commit: done
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-393-thread-1]: 
rollback
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-393-thread-1]: 
all running merges have aborted
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-393-thread-1]: 
rollback: done finish merges
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-393-thread-1]: 
abort
   [junit4]   2> 225683 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-393-thread-1]: 
done abort success=true
   [junit4]   2> 225684 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-393-thread-1]: 
rollback: infos=_5(7.0.0):C438/437:delGen=1 _6(7.0.0):C10/10:delGen=1
   [junit4]   2> 225684 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-393-thread-1]: 
now checkpoint "_5(7.0.0):C438/437:delGen=1 _6(7.0.0):C10/10:delGen=1" [2 
segments ; isCommit = false]
   [junit4]   2> 225684 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-393-thread-1]: 
0 msec to checkpoint
   [junit4]   2> 225684 INFO  (coreCloseExecutor-393-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=848702374
   [junit4]   2> 225715 INFO  
(SUITE-TestSolrJErrorHandling-seed#[1B9193AD39DE901F]-worker) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@4e558b11{/solr,null,UNAVAILABLE}
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.0/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.TestSolrJErrorHandling_1B9193AD39DE901F-001
   [junit4]   2> NOTE: test params are: codec=Lucene70, 
sim=RandomSimilarity(queryNorm=true): {}, locale=en-MT, timezone=US/Samoa
   [junit4]   2> NOTE: Linux 4.4.0-83-generic amd64/Oracle Corporation 
1.8.0_131 (64-bit)/cpus=4,threads=1,free=218128752,total=443023360
   [junit4]   2> NOTE: All tests run in this JVM: [GraphExpressionTest, 
SolrExampleJettyTest, TestDelegationTokenRequest, TestRetryUtil, NamedListTest, 
NotEvaluatorTest, SolrExceptionTest, TestCoreAdmin, LengthEvaluatorTest, 
TestBatchUpdate, AndEvaluatorTest, SolrExampleBinaryTest, StreamingTest, 
FloorEvaluatorTest, CosineEvaluatorTest, ModuloEvaluatorTest, 
TestDelegationTokenResponse, JsonValidatorTest, CloudSolrClientCacheTest, 
JettyWebappTest, TestJavaBinCodec, SolrZkClientTest, TestSolrJErrorHandling]
   [junit4] Completed [93/135 (1!)] on J2 in 61.12s, 4 tests, 1 failure <<< 
FAILURES!

[...truncated 42600 lines...]

---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org