Build: https://builds.apache.org/job/Lucene-Solr-Tests-7.x/68/

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

Error Message:
expected:<832> but was:<822>

Stack Trace:
java.lang.AssertionError: expected:<832> but was:<822>
        at 
__randomizedtesting.SeedInfo.seed([97962D1F089FB2EC:3C7494E98A99AB81]: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 13751 lines...]
   [junit4] Suite: org.apache.solr.client.solrj.TestSolrJErrorHandling
   [junit4]   2> Creating dataDir: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/init-core-data-001
   [junit4]   2> 62583 WARN  
(SUITE-TestSolrJErrorHandling-seed#[97962D1F089FB2EC]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=120 numCloses=120
   [junit4]   2> 62584 INFO  
(SUITE-TestSolrJErrorHandling-seed#[97962D1F089FB2EC]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 62585 INFO  
(SUITE-TestSolrJErrorHandling-seed#[97962D1F089FB2EC]-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> 63592 INFO  
(SUITE-TestSolrJErrorHandling-seed#[97962D1F089FB2EC]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 63592 INFO  
(SUITE-TestSolrJErrorHandling-seed#[97962D1F089FB2EC]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 63593 INFO  
(SUITE-TestSolrJErrorHandling-seed#[97962D1F089FB2EC]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-002/cores/core
   [junit4]   2> 63594 INFO  
(SUITE-TestSolrJErrorHandling-seed#[97962D1F089FB2EC]-worker) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 63609 INFO  
(SUITE-TestSolrJErrorHandling-seed#[97962D1F089FB2EC]-worker) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@5e0d9fef{/solr,null,AVAILABLE}
   [junit4]   2> 63610 INFO  
(SUITE-TestSolrJErrorHandling-seed#[97962D1F089FB2EC]-worker) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@2b4acaaf{HTTP/1.1,[http/1.1]}{127.0.0.1:41383}
   [junit4]   2> 63610 INFO  
(SUITE-TestSolrJErrorHandling-seed#[97962D1F089FB2EC]-worker) [    ] 
o.e.j.s.Server Started @72925ms
   [junit4]   2> 63610 INFO  
(SUITE-TestSolrJErrorHandling-seed#[97962D1F089FB2EC]-worker) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=41383, 
configSetBaseDir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-001,
 
coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-002/cores}
   [junit4]   2> 63610 ERROR 
(SUITE-TestSolrJErrorHandling-seed#[97962D1F089FB2EC]-worker) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 63610 INFO  
(SUITE-TestSolrJErrorHandling-seed#[97962D1F089FB2EC]-worker) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.1.0
   [junit4]   2> 63610 INFO  
(SUITE-TestSolrJErrorHandling-seed#[97962D1F089FB2EC]-worker) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 63610 INFO  
(SUITE-TestSolrJErrorHandling-seed#[97962D1F089FB2EC]-worker) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 63610 INFO  
(SUITE-TestSolrJErrorHandling-seed#[97962D1F089FB2EC]-worker) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-07-18T16:54:20.942Z
   [junit4]   2> 63610 INFO  
(SUITE-TestSolrJErrorHandling-seed#[97962D1F089FB2EC]-worker) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-001/solr.xml
   [junit4]   2> 64010 INFO  
(SUITE-TestSolrJErrorHandling-seed#[97962D1F089FB2EC]-worker) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-001
   [junit4]   2> 64010 INFO  
(SUITE-TestSolrJErrorHandling-seed#[97962D1F089FB2EC]-worker) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 64368 WARN  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-001/collection1/../../../../contrib/extraction/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-001/collection1/../../../../contrib/extraction/lib
   [junit4]   2> 64416 WARN  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-001/collection1/../../../../dist
 filtered by solr-cell-\d.*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-001/collection1/../../../../dist
   [junit4]   2> 64416 WARN  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-001/collection1/../../../../contrib/clustering/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-001/collection1/../../../../contrib/clustering/lib
   [junit4]   2> 64416 WARN  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-001/collection1/../../../../dist
 filtered by solr-clustering-\d.*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-001/collection1/../../../../dist
   [junit4]   2> 64417 WARN  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-001/collection1/../../../../contrib/langid/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-001/collection1/../../../../contrib/langid/lib
   [junit4]   2> 64417 WARN  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-001/collection1/../../../../dist
 filtered by solr-langid-\d.*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-001/collection1/../../../../dist
   [junit4]   2> 64418 WARN  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-001/collection1/../../../../contrib/ltr/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-001/collection1/../../../../contrib/ltr/lib
   [junit4]   2> 64418 WARN  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-001/collection1/../../../../dist
 filtered by solr-ltr-\d.*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-001/collection1/../../../../dist
   [junit4]   2> 64419 WARN  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-001/collection1/../../../../contrib/velocity/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-001/collection1/../../../../contrib/velocity/lib
   [junit4]   2> 64419 WARN  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-001/collection1/../../../../dist
 filtered by solr-velocity-\d.*\.jar to classpath: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-001/collection1/../../../../dist
   [junit4]   2> 64468 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.SolrIndexConfig IndexWriter infoStream solr logging is enabled
   [junit4]   2> 64514 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0
   [junit4]   2> 64839 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.s.IndexSchema [collection1] Schema name=example
   [junit4]   2> 66400 INFO  (coreLoadExecutor-33-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> 66400 INFO  (coreLoadExecutor-33-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> 66400 INFO  (coreLoadExecutor-33-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> 66400 INFO  (coreLoadExecutor-33-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> 66401 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid field id
   [junit4]   2> 66401 INFO  (coreLoadExecutor-33-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> 66401 INFO  (coreLoadExecutor-33-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> 66401 INFO  (coreLoadExecutor-33-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> 66401 INFO  (coreLoadExecutor-33-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> 66645 INFO  (coreLoadExecutor-33-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.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-001/collection1,
 trusted=true
   [junit4]   2> 66646 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 66646 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-001/collection1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-001/collection1/data/]
   [junit4]   2> 66663 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-33-thread-1]: init: current 
segments file is "segments"; 
deletionPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper@5503dafa
   [junit4]   2> 66663 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-33-thread-1]: now checkpoint 
"" [0 segments ; isCommit = false]
   [junit4]   2> 66663 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-33-thread-1]: 0 msec to 
checkpoint
   [junit4]   2> 66663 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: init: create=true
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: 
   [junit4]   2> dir=MockDirectoryWrapper(RAMDirectory@55ae16c2 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@65c7ed2d)
   [junit4]   2> index=
   [junit4]   2> version=7.1.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@7e70062d
   [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@5b4d0727
   [junit4]   2> 
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: 
MMapDirectory.UNMAP_SUPPORTED=true
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: now flush at close
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]:   start flush: 
applyAllDeletes=true
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]:   index before 
flush 
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-33-thread-1]: startFullFlush
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-33-thread-1]: 
coreLoadExecutor-33-thread-1 finishFullFlush success=true
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: now apply all 
deletes for all segments buffered updates bytesUsed=0 reader pool bytesUsed=0
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-33-thread-1]: waitApply: no 
deletes to apply
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-33-thread-1]: 
initDynamicDefaults spins=false maxThreadCount=1 maxMergeCount=6
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-33-thread-1]: 
updateMergeThreads ioThrottle=true targetMBPerSec=10240.0 MB/sec
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-33-thread-1]: now merge
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-33-thread-1]:   index: 
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-33-thread-1]:   no more merges 
pending; now return
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: waitForMerges
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: waitForMerges done
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: commit: start
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: commit: enter lock
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: commit: now 
prepare
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: prepareCommit: 
flush
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]:   index before 
flush 
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-33-thread-1]: startFullFlush
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: now apply all 
deletes for all segments buffered updates bytesUsed=0 reader pool bytesUsed=0
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-33-thread-1]: waitApply: no 
deletes to apply
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-33-thread-1]: 
coreLoadExecutor-33-thread-1 finishFullFlush success=true
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: startCommit(): 
start
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: startCommit 
index= changeCount=2
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: startCommit: 
wrote pending segments file "pending_segments_1"
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: done all syncs: []
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: commit: 
pendingCommit != null
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: commit: done 
writing segments file "segments_1"
   [junit4]   2> 66664 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-33-thread-1]: now checkpoint 
"" [0 segments ; isCommit = true]
   [junit4]   2> 66665 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-33-thread-1]: 0 msec to 
checkpoint
   [junit4]   2> 66665 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: commit: took 0.4 
msec
   [junit4]   2> 66665 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: commit: done
   [junit4]   2> 66665 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: rollback
   [junit4]   2> 66665 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: all running 
merges have aborted
   [junit4]   2> 66665 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: rollback: done 
finish merges
   [junit4]   2> 66665 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-33-thread-1]: abort
   [junit4]   2> 66665 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-33-thread-1]: done abort 
success=true
   [junit4]   2> 66665 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: rollback: infos=
   [junit4]   2> 66665 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-33-thread-1]: now checkpoint 
"" [0 segments ; isCommit = false]
   [junit4]   2> 66665 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-33-thread-1]: 0 msec to 
checkpoint
   [junit4]   2> 66692 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5
   [junit4]   2> 67022 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 67022 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 67023 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 15000ms; 
   [junit4]   2> 67023 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 67024 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-33-thread-1]: init: current 
segments file is "segments_1"; 
deletionPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper@5503dafa
   [junit4]   2> 67024 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-33-thread-1]: init: load 
commit "segments_1"
   [junit4]   2> 67024 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-33-thread-1]: now checkpoint 
"" [0 segments ; isCommit = false]
   [junit4]   2> 67024 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-33-thread-1]: 0 msec to 
checkpoint
   [junit4]   2> 67024 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: init: create=false
   [junit4]   2> 67024 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: 
   [junit4]   2> dir=MockDirectoryWrapper(RAMDirectory@55ae16c2 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@65c7ed2d)
   [junit4]   2> index=
   [junit4]   2> version=7.1.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@4efb288b
   [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@636f27f
   [junit4]   2> 
   [junit4]   2> 67024 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: 
MMapDirectory.UNMAP_SUPPORTED=true
   [junit4]   2> 67024 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: flush at getReader
   [junit4]   2> 67024 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-33-thread-1]: startFullFlush
   [junit4]   2> 67025 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: now apply all 
deletes for all segments buffered updates bytesUsed=0 reader pool bytesUsed=0
   [junit4]   2> 67025 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-33-thread-1]: waitApply: no 
deletes to apply
   [junit4]   2> 67025 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: incRefDeleter for 
NRT reader version=2 segments=
   [junit4]   2> 67025 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: return reader 
version=2 reader=StandardDirectoryReader(segments_1:2:nrt)
   [junit4]   2> 67025 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-33-thread-1]: 
coreLoadExecutor-33-thread-1 finishFullFlush success=true
   [junit4]   2> 67025 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-33-thread-1]: getReader took 1 
msec
   [junit4]   2> 67025 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@4951c10b[collection1] main]
   [junit4]   2> 67040 INFO  (coreLoadExecutor-33-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.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-001/collection1/conf
   [junit4]   2> 67040 INFO  (coreLoadExecutor-33-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.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-001/collection1/conf
   [junit4]   2> 67040 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.r.ManagedResource Loaded initArgs {} for /rest/managed
   [junit4]   2> 67040 INFO  (coreLoadExecutor-33-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.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-001/collection1/conf
   [junit4]   2> 67053 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.r.ManagedResource Loaded initArgs {ignoreCase=true} for 
/schema/analysis/stopwords/english
   [junit4]   2> 67053 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.r.s.a.ManagedWordSetResource Loaded 35 words for 
/schema/analysis/stopwords/english
   [junit4]   2> 67054 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.r.ManagedResource Notified 4 observers of 
/schema/analysis/stopwords/english
   [junit4]   2> 67054 INFO  (coreLoadExecutor-33-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.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-001/collection1/conf
   [junit4]   2> 67054 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.r.ManagedResource Loaded initArgs {ignoreCase=true,format=solr} for 
/schema/analysis/synonyms/english
   [junit4]   2> 67054 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.r.s.a.ManagedSynonymGraphFilterFactory Loaded 3 synonym mappings for 
/schema/analysis/synonyms/english
   [junit4]   2> 67148 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.r.ManagedResource Notified 4 observers of 
/schema/analysis/synonyms/english
   [junit4]   2> 67148 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 67148 INFO  (coreLoadExecutor-33-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> 67149 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.h.c.SuggestComponent Initializing SuggestComponent
   [junit4]   2> 67149 INFO  (coreLoadExecutor-33-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> 67149 INFO  (coreLoadExecutor-33-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> 67149 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.h.c.QueryElevationComponent Loading QueryElevation from: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001/tempDir-001/collection1/conf/elevate.xml
   [junit4]   2> 67245 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 67245 INFO  
(searcherExecutor-34-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.QuerySenderListener QuerySenderListener sending requests to 
Searcher@4951c10b[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 67246 INFO  
(searcherExecutor-34-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> 67246 INFO  
(searcherExecutor-34-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.QuerySenderListener QuerySenderListener done.
   [junit4]   2> 67246 INFO  
(searcherExecutor-34-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 67246 INFO  
(searcherExecutor-34-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 67247 INFO  
(searcherExecutor-34-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@4951c10b[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 67247 INFO  (coreLoadExecutor-33-thread-1) [    x:collection1] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1573280142672789504
   [junit4]   2> 67301 INFO  
(SUITE-TestSolrJErrorHandling-seed#[97962D1F089FB2EC]-worker) [    ] 
o.a.s.SolrJettyTestBase Jetty Assigned Port#41383
   [junit4]   2> 67708 INFO  
(TEST-TestSolrJErrorHandling.testRawSocket-seed#[97962D1F089FB2EC]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testRawSocket
   [junit4]   2> 68093 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={}{} 0 60
   [junit4]   2> 68093 ERROR (qtp763919426-151) [    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> 71603 INFO  
(TEST-TestSolrJErrorHandling.testRawSocket-seed#[97962D1F089FB2EC]) [    ] 
o.a.s.c.s.TestSolrJErrorHandling BUFFER=HTTP/1.1 400 Bad Request
   [junit4]   2> Date: Tue, 18 Jul 2017 16:54:25 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":73},"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> 71603 INFO  
(TEST-TestSolrJErrorHandling.testRawSocket-seed#[97962D1F089FB2EC]) [    ] 
o.a.s.c.s.TestSolrJErrorHandling RESPONSE BODY:HTTP/1.1 400 Bad Request
   [junit4]   2> Date: Tue, 18 Jul 2017 16:54:25 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":73},"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> 71603 INFO  
(TEST-TestSolrJErrorHandling.testRawSocket-seed#[97962D1F089FB2EC]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testRawSocket
   [junit4]   2> 71721 INFO  
(TEST-TestSolrJErrorHandling.testHttpURLConnection-seed#[97962D1F089FB2EC]) [   
 ] o.a.s.SolrTestCaseJ4 ###Starting testHttpURLConnection
   [junit4]   2> 72152 INFO  (qtp763919426-149) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={}{} 0 0
   [junit4]   2> 72152 ERROR (qtp763919426-149) [    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> 73710 INFO  
(TEST-TestSolrJErrorHandling.testHttpURLConnection-seed#[97962D1F089FB2EC]) [   
 ] o.a.s.c.s.TestSolrJErrorHandling CODE=400
   [junit4]   2> 73710 INFO  
(TEST-TestSolrJErrorHandling.testHttpURLConnection-seed#[97962D1F089FB2EC]) [   
 ] o.a.s.c.s.TestSolrJErrorHandling Attempting to get error stream.
   [junit4]   2> 73712 INFO  
(TEST-TestSolrJErrorHandling.testHttpURLConnection-seed#[97962D1F089FB2EC]) [   
 ] o.a.s.c.s.TestSolrJErrorHandling RESPONSE 
BODY:{"responseHeader":{"status":400,"QTime":1},"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> 73712 INFO  
(TEST-TestSolrJErrorHandling.testHttpURLConnection-seed#[97962D1F089FB2EC]) [   
 ] o.a.s.SolrTestCaseJ4 ###Ending testHttpURLConnection
   [junit4]   2> 73731 INFO  
(TEST-TestSolrJErrorHandling.testWithXml-seed#[97962D1F089FB2EC]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testWithXml
   [junit4]   2> 73735 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp763919426-148]: anyChanges? numDocsInRam=0 
deletes=true hasTickets:false pendingChangesInFullFlush: false
   [junit4]   2> 73735 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp763919426-148]: anyChanges? numDocsInRam=0 
deletes=true hasTickets:false pendingChangesInFullFlush: false
   [junit4]   2> 73735 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp763919426-148]: nrtIsCurrent: infoVersion 
matches: true; DW changes: true; BD changes: false
   [junit4]   2> 73735 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp763919426-148]: flush at getReader
   [junit4]   2> 73735 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp763919426-148]: startFullFlush
   [junit4]   2> 73735 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp763919426-148]: anyChanges? numDocsInRam=0 
deletes=true hasTickets:false pendingChangesInFullFlush: false
   [junit4]   2> 73735 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp763919426-148]: qtp763919426-148: flush naked 
frozen global deletes
   [junit4]   2> 73735 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp763919426-148]: compressed 76 to 48 bytes 
(63.16%) for deletes/updates; private segment null
   [junit4]   2> 73735 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp763919426-148]: push new packet (delGen=1 
numDeleteQuerys=1 bytesUsed=48), packetCount=1, bytesUsed=0.000 MB
   [junit4]   2> 73735 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp763919426-148]: flush: push buffered updates: 
delGen=1 numDeleteQuerys=1 bytesUsed=48
   [junit4]   2> 73735 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp763919426-148]: packet matches no segments
   [junit4]   2> 73735 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp763919426-148]: finished packet delGen=1 now 
completedDelGen=1
   [junit4]   2> 73735 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp763919426-148]: 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> 73735 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp763919426-148]: now apply all deletes for all 
segments buffered updates bytesUsed=0 reader pool bytesUsed=0
   [junit4]   2> 73735 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp763919426-148]: waitApply: no deletes to apply
   [junit4]   2> 73735 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp763919426-148]: incRefDeleter for NRT reader 
version=2 segments=
   [junit4]   2> 73736 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp763919426-148]: return reader version=2 
reader=StandardDirectoryReader(segments_1:2:nrt)
   [junit4]   2> 73736 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp763919426-148]: qtp763919426-148 
finishFullFlush success=true
   [junit4]   2> 73736 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp763919426-148]: getReader took 1 msec
   [junit4]   2> 73736 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp763919426-148]: decRefDeleter for NRT reader 
version=2 segments=
   [junit4]   2> 73736 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1573280149474902016)} 0 2
   [junit4]   2> 73737 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp763919426-151]: anyChanges? numDocsInRam=0 
deletes=true hasTickets:false pendingChangesInFullFlush: false
   [junit4]   2> 73737 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp763919426-151]: anyChanges? numDocsInRam=0 
deletes=true hasTickets:false pendingChangesInFullFlush: false
   [junit4]   2> 73737 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp763919426-151]: nrtIsCurrent: infoVersion 
matches: true; DW changes: true; BD changes: false
   [junit4]   2> 73737 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp763919426-151]: flush at getReader
   [junit4]   2> 73737 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp763919426-151]: startFullFlush
   [junit4]   2> 73737 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp763919426-151]: anyChanges? numDocsInRam=0 
deletes=true hasTickets:false pendingChangesInFullFlush: false
   [junit4]   2> 73737 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp763919426-151]: qtp763919426-151: flush naked 
frozen global deletes
   [junit4]   2> 73737 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp763919426-151]: compressed 76 to 48 bytes 
(63.16%) for deletes/updates; private segment null
   [junit4]   2> 73737 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp763919426-151]: push new packet (delGen=2 
numDeleteQuerys=1 bytesUsed=48), packetCount=1, bytesUsed=0.000 MB
   [junit4]   2> 73737 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp763919426-151]: flush: push buffered updates: 
delGen=2 numDeleteQuerys=1 bytesUsed=48
   [junit4]   2> 73737 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp763919426-151]: packet matches no segments
   [junit4]   2> 73738 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp763919426-151]: finished packet delGen=2 now 
completedDelGen=2
   [junit4]   2> 73738 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp763919426-151]: 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> 73738 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp763919426-151]: now apply all deletes for all 
segments buffered updates bytesUsed=0 reader pool bytesUsed=0
   [junit4]   2> 73738 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.u.LoggingInfoStream [BD][qtp763919426-151]: waitApply: no deletes to apply
   [junit4]   2> 73738 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp763919426-151]: incRefDeleter for NRT reader 
version=2 segments=
   [junit4]   2> 73738 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp763919426-151]: return reader version=2 
reader=StandardDirectoryReader(segments_1:2:nrt)
   [junit4]   2> 73738 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.u.LoggingInfoStream [DW][qtp763919426-151]: qtp763919426-151 
finishFullFlush success=true
   [junit4]   2> 73738 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp763919426-151]: getReader took 1 msec
   [junit4]   2> 73738 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.u.LoggingInfoStream [IW][qtp763919426-151]: decRefDeleter for NRT reader 
version=2 segments=
   [junit4]   2> 73738 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1573280149478047744)} 0 1
   [junit4]   2> 73946 INFO  (qtp763919426-154) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280149620654080)]} 0 73
   [junit4]   2> 73946 INFO  (qtp763919426-154) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 73953 INFO  (qtp763919426-149) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280149697200129)]} 0 45
   [junit4]   2> 73953 INFO  (qtp763919426-149) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 73953 INFO  (qtp763919426-179) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280149704540160)]} 0 30
   [junit4]   2> 73953 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280149704540162)]} 0 30
   [junit4]   2> 73954 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 73954 INFO  (qtp763919426-153) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280149704540164)]} 0 47
   [junit4]   2> 73954 INFO  (qtp763919426-153) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 73958 INFO  (qtp763919426-181) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280149705588737)]} 0 4
   [junit4]   2> 73958 INFO  (qtp763919426-181) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 73970 INFO  (qtp763919426-179) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 73978 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280149730754560)]} 0 72
   [junit4]   2> 73978 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 73986 INFO  (qtp763919426-152) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280149739143168)]} 0 81
   [junit4]   2> 73987 INFO  (qtp763919426-152) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74019 INFO  (qtp763919426-183) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280149773746176)]} 0 73
   [junit4]   2> 74019 INFO  (qtp763919426-183) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74035 INFO  (qtp763919426-184) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280149790523392)]} 0 21
   [junit4]   2> 74035 INFO  (qtp763919426-184) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74061 INFO  (qtp763919426-155) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280149712928768)]} 0 154
   [junit4]   2> 74062 INFO  (qtp763919426-155) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74114 INFO  (qtp763919426-180) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280149872312320)]} 0 0
   [junit4]   2> 74133 INFO  (qtp763919426-180) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74136 INFO  (qtp763919426-153) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280149895380992)]} 0 0
   [junit4]   2> 74136 INFO  (qtp763919426-153) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74137 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280149897478144)]} 0 0
   [junit4]   2> 74137 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74166 INFO  (qtp763919426-185) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280149926838272)]} 0 29
   [junit4]   2> 74166 INFO  (qtp763919426-185) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74186 INFO  (qtp763919426-152) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280149948858368)]} 0 0
   [junit4]   2> 74187 INFO  (qtp763919426-152) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74187 INFO  (qtp763919426-184) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280149948858370)]} 0 0
   [junit4]   2> 74187 INFO  (qtp763919426-184) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74188 INFO  (qtp763919426-179) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280149949906945)]} 0 1
   [junit4]   2> 74188 INFO  (qtp763919426-179) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74235 INFO  (qtp763919426-154) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280149968781312)]} 0 30
   [junit4]   2> 74236 INFO  (qtp763919426-154) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74238 INFO  (qtp763919426-181) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150002335744)]} 0 51
   [junit4]   2> 74238 INFO  (qtp763919426-181) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74251 INFO  (qtp763919426-149) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150015967232)]} 0 17
   [junit4]   2> 74251 INFO  (qtp763919426-149) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74251 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150017015809)]} 0 0
   [junit4]   2> 74251 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74267 INFO  (qtp763919426-180) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150033793024)]} 0 0
   [junit4]   2> 74268 INFO  (qtp763919426-180) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74286 INFO  (qtp763919426-155) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150053715968)]} 0 0
   [junit4]   2> 74286 INFO  (qtp763919426-155) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74410 INFO  (qtp763919426-185) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150182690816)]} 0 0
   [junit4]   2> 74410 INFO  (qtp763919426-185) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74414 INFO  (qtp763919426-149) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150186885120)]} 0 0
   [junit4]   2> 74414 INFO  (qtp763919426-149) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74427 INFO  (qtp763919426-183) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150200516608)]} 0 0
   [junit4]   2> 74427 INFO  (qtp763919426-183) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74430 INFO  (qtp763919426-180) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150204710912)]} 0 0
   [junit4]   2> 74430 INFO  (qtp763919426-180) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74433 INFO  (qtp763919426-152) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150207856640)]} 0 0
   [junit4]   2> 74463 INFO  (qtp763919426-152) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74460 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150235119616)]} 0 0
   [junit4]   2> 74478 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74495 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150272868352)]} 0 0
   [junit4]   2> 74495 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74515 INFO  (qtp763919426-184) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150293839872)]} 0 0
   [junit4]   2> 74596 INFO  (qtp763919426-184) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74657 INFO  (qtp763919426-179) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150425960448)]} 0 16
   [junit4]   2> 74657 INFO  (qtp763919426-179) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74665 INFO  (qtp763919426-153) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150451126272)]} 0 20
   [junit4]   2> 74665 INFO  (qtp763919426-153) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74674 INFO  (qtp763919426-155) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150460563456)]} 0 55
   [junit4]   2> 74674 INFO  (qtp763919426-155) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74689 INFO  (qtp763919426-180) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150459514880)]} 0 45
   [junit4]   2> 74690 INFO  (qtp763919426-180) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74690 INFO  (qtp763919426-149) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150477340672)]} 0 0
   [junit4]   2> 74690 INFO  (qtp763919426-149) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74727 INFO  (qtp763919426-184) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150515089408)]} 0 0
   [junit4]   2> 74727 INFO  (qtp763919426-184) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74746 INFO  (qtp763919426-181) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150501457920)]} 0 33
   [junit4]   2> 74779 INFO  (qtp763919426-153) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150570663936)]} 0 12
   [junit4]   2> 74794 INFO  (qtp763919426-153) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74763 INFO  (qtp763919426-185) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150553886720)]} 0 0
   [junit4]   2> 74795 INFO  (qtp763919426-185) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74807 INFO  (qtp763919426-181) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74808 INFO  (qtp763919426-155) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150601072640)]} 0 0
   [junit4]   2> 74808 INFO  (qtp763919426-155) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74810 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150603169792)]} 0 0
   [junit4]   2> 74810 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74759 INFO  (qtp763919426-154) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150549692416)]} 0 0
   [junit4]   2> 74811 INFO  (qtp763919426-154) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74871 INFO  (qtp763919426-152) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150665035776)]} 0 2
   [junit4]   2> 74872 INFO  (qtp763919426-152) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74885 INFO  (qtp763919426-179) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150681812992)]} 0 0
   [junit4]   2> 74885 INFO  (qtp763919426-179) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74983 INFO  (qtp763919426-183) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150783524864)]} 0 0
   [junit4]   2> 74983 INFO  (qtp763919426-183) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74997 INFO  (qtp763919426-149) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150799253504)]} 0 0
   [junit4]   2> 74997 INFO  (qtp763919426-149) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 74999 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150753116160)]} 0 45
   [junit4]   2> 74999 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 75032 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150834905088)]} 0 0
   [junit4]   2> 75032 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 75035 INFO  (qtp763919426-181) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150762553344)]} 0 73
   [junit4]   2> 75035 INFO  (qtp763919426-181) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 75062 INFO  (qtp763919426-184) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150867410944)]} 0 0
   [junit4]   2> 75062 INFO  (qtp763919426-184) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 75064 INFO  (qtp763919426-180) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150869508096)]} 0 0
   [junit4]   2> 75064 INFO  (qtp763919426-180) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 75150 INFO  (qtp763919426-155) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150959685632)]} 0 52
   [junit4]   2> 75150 INFO  (qtp763919426-155) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 75165 INFO  (qtp763919426-179) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280150890479616)]} 0 81
   [junit4]   2> 75165 INFO  (qtp763919426-179) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 75190 INFO  (qtp763919426-154) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280151001628672)]} 0 0
   [junit4]   2> 75190 INFO  (qtp763919426-154) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 75198 INFO  (qtp763919426-153) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280151010017280)]} 0 0
   [junit4]   2> 75198 INFO  (qtp763919426-153) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 75243 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280151057203200)]} 0 0
   [junit4]   2> 75243 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 75246 INFO  (qtp763919426-185) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280151059300352)]} 0 0
   [junit4]   2> 75246 INFO  (qtp763919426-185) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 75277 INFO  (qtp763919426-152) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280151092854784)]} 0 0
   [junit4]   2> 75278 INFO  (qtp763919426-152) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 75319 INFO  (qtp763919426-181) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280151136894976)]} 0 0
   [junit4]   2> 75338 INFO  (qtp763919426-154) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280151155769344)]} 0 0
   [junit4]   2> 75338 INFO  (qtp763919426-154) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 75354 INFO  (qtp763919426-181) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 75374 INFO  (qtp763919426-183) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280151194566656)]} 0 0
   [junit4]   2> 75374 INFO  (qtp763919426-183) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 75434 INFO  (qtp763919426-149) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280151257481216)]} 0 0
   [junit4]   2> 75435 INFO  (qtp763919426-149) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 75439 INFO  (qtp763919426-180) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280151262724096)]} 0 0
   [junit4]   2> 75439 INFO  (qtp763919426-180) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 75455 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280151279501312)]} 0 0
   [junit4]   2> 75455 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 75506 INFO  (qtp763919426-184) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280151332978688)]} 0 0
   [junit4]   2> 75506 INFO  (qtp763919426-184) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 75520 INFO  (qtp763919426-155) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280151347658752)]} 0 0
   [junit4]   2> 75520 INFO  (qtp763919426-155) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 75589 INFO  (qtp763919426-152) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280151420010496)]} 0 0
   [junit4]   2> 75589 INFO  (qtp763919426-152) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 75601 INFO  (qtp763919426-153) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280151432593408)]} 0 0
   [junit4]   2> 75601 INFO  (qtp763919426-153) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 75869 INFO  (qtp763919426-185) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280151713611776)]} 0 0
   [junit4]   2> 75870 INFO  (qtp763919426-185) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 75887 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280151731437568)]} 0 0
   [junit4]   2> 75887 INFO  (qtp763919426-148) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 75962 INFO  (qtp763919426-154) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280151811129344)]} 0 16
   [junit4]   2> 75963 INFO  (qtp763919426-154) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 75978 INFO  (qtp763919426-183) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280151827906560)]} 0 41
   [junit4]   2> 75979 INFO  (qtp763919426-183) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 75996 INFO  (qtp763919426-180) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280151780720640)]} 0 62
   [junit4]   2> 75996 INFO  (qtp763919426-180) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 76012 INFO  (qtp763919426-149) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280151862509568)]} 0 0
   [junit4]   2> 76012 INFO  (qtp763919426-149) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 76047 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280151900258304)]} 0 0
   [junit4]   2> 76055 INFO  (qtp763919426-181) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280151908646912)]} 0 0
   [junit4]   2> 76068 INFO  (qtp763919426-181) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 76077 INFO  (qtp763919426-152) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280151931715584)]} 0 0
   [junit4]   2> 76078 INFO  (qtp763919426-152) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 76109 INFO  (qtp763919426-179) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280151965270016)]} 0 0
   [junit4]   2> 76110 INFO  (qtp763919426-179) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 76141 INFO  (qtp763919426-151) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 76143 INFO  (qtp763919426-184) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280152000921600)]} 0 0
   [junit4]   2> 76143 INFO  (qtp763919426-184) [    x:collection1] 
o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 76152 INFO  (qtp763919426-185) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[test (1573280152010358784)]} 0 0
   [junit4]   2> 76218 INFO  (qtp763919426-185) [    x:collection1] 
o.a.s.h.RequestHa

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

] o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=id:test&fl=count_i&wt=javabin&version=2} hits=1 status=0 QTime=0
   [junit4]   2> 126973 INFO  (qtp763919426-184) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1573280205300039680,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 126973 INFO  (qtp763919426-184) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 126986 INFO  (qtp763919426-184) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 126986 INFO  (qtp763919426-184) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 13
   [junit4]   2> 126987 INFO  (qtp763919426-184) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=id:test&fl=count_i&wt=javabin&version=2} hits=1 status=0 QTime=0
   [junit4]   2> 126987 INFO  
(TEST-TestSolrJErrorHandling.testWithBinary-seed#[97962D1F089FB2EC]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testWithBinary
   [junit4]   2> 127014 INFO  
(SUITE-TestSolrJErrorHandling-seed#[97962D1F089FB2EC]-worker) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@2b4acaaf{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 127014 INFO  
(SUITE-TestSolrJErrorHandling-seed#[97962D1F089FB2EC]-worker) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1148478429
   [junit4]   2> 127014 INFO  
(SUITE-TestSolrJErrorHandling-seed#[97962D1F089FB2EC]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 127014 INFO  
(SUITE-TestSolrJErrorHandling-seed#[97962D1F089FB2EC]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 127015 INFO  
(SUITE-TestSolrJErrorHandling-seed#[97962D1F089FB2EC]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 127015 INFO  
(SUITE-TestSolrJErrorHandling-seed#[97962D1F089FB2EC]-worker) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 127015 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@333ef797
   [junit4]   2> 127015 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-39-thread-1]: 
now flush at close
   [junit4]   2> 127015 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-39-thread-1]:   
start flush: applyAllDeletes=true
   [junit4]   2> 127015 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-39-thread-1]:   
index before flush _6(7.1.0):C266/265:delGen=1
   [junit4]   2> 127015 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-39-thread-1]: 
startFullFlush
   [junit4]   2> 127016 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-39-thread-1]: 
coreCloseExecutor-39-thread-1 finishFullFlush success=true
   [junit4]   2> 127016 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-39-thread-1]: 
now apply all deletes for all segments buffered updates bytesUsed=0 reader pool 
bytesUsed=0
   [junit4]   2> 127016 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [BD][coreCloseExecutor-39-thread-1]: 
waitApply: no deletes to apply
   [junit4]   2> 127016 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-39-thread-1]: 
updateMergeThreads ioThrottle=true targetMBPerSec=10240.0 MB/sec
   [junit4]   2> 127016 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-39-thread-1]: 
now merge
   [junit4]   2> 127016 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-39-thread-1]:   
index: _6(7.1.0):C266/265:delGen=1
   [junit4]   2> 127016 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-39-thread-1]:   
no more merges pending; now return
   [junit4]   2> 127016 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-39-thread-1]: 
waitForMerges
   [junit4]   2> 127016 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-39-thread-1]: 
waitForMerges done
   [junit4]   2> 127016 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-39-thread-1]: 
commit: start
   [junit4]   2> 127016 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-39-thread-1]: 
commit: enter lock
   [junit4]   2> 127016 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-39-thread-1]: 
commit: now prepare
   [junit4]   2> 127016 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-39-thread-1]: 
prepareCommit: flush
   [junit4]   2> 127016 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-39-thread-1]:   
index before flush _6(7.1.0):C266/265:delGen=1
   [junit4]   2> 127016 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-39-thread-1]: 
startFullFlush
   [junit4]   2> 127016 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-39-thread-1]: 
now apply all deletes for all segments buffered updates bytesUsed=0 reader pool 
bytesUsed=0
   [junit4]   2> 127016 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [BD][coreCloseExecutor-39-thread-1]: 
waitApply: no deletes to apply
   [junit4]   2> 127016 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-39-thread-1]: 
coreCloseExecutor-39-thread-1 finishFullFlush success=true
   [junit4]   2> 127016 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-39-thread-1]: 
startCommit(): start
   [junit4]   2> 127016 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-39-thread-1]:   
skip startCommit(): no changes pending
   [junit4]   2> 127016 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-39-thread-1]: 
commit: pendingCommit == null; skip
   [junit4]   2> 127016 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-39-thread-1]: 
commit: took 0.2 msec
   [junit4]   2> 127016 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-39-thread-1]: 
commit: done
   [junit4]   2> 127016 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-39-thread-1]: 
rollback
   [junit4]   2> 127016 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-39-thread-1]: 
all running merges have aborted
   [junit4]   2> 127016 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-39-thread-1]: 
rollback: done finish merges
   [junit4]   2> 127016 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-39-thread-1]: 
abort
   [junit4]   2> 127016 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-39-thread-1]: 
done abort success=true
   [junit4]   2> 127016 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-39-thread-1]: 
rollback: infos=_6(7.1.0):C266/265:delGen=1
   [junit4]   2> 127016 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-39-thread-1]: 
now checkpoint "_6(7.1.0):C266/265:delGen=1" [1 segments ; isCommit = false]
   [junit4]   2> 127016 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-39-thread-1]: 
0 msec to checkpoint
   [junit4]   2> 127031 INFO  (coreCloseExecutor-39-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=859764631
   [junit4]   2> 127145 INFO  
(SUITE-TestSolrJErrorHandling-seed#[97962D1F089FB2EC]-worker) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@5e0d9fef{/solr,null,UNAVAILABLE}
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.TestSolrJErrorHandling_97962D1F089FB2EC-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {}, 
docValues:{}, maxPointsInLeafNode=242, maxMBSortInHeap=7.520520875060283, 
sim=RandomSimilarity(queryNorm=true): {}, locale=mk, timezone=America/Caracas
   [junit4]   2> NOTE: Linux 4.4.0-83-generic amd64/Oracle Corporation 
1.8.0_131 (64-bit)/cpus=4,threads=1,free=134753264,total=300941312
   [junit4]   2> NOTE: All tests run in this JVM: [GetByIdTest, 
SolrExampleStreamingBinaryTest, TestToleratedUpdateError, ClientUtilsTest, 
TestSolrJErrorHandling]
   [junit4] Completed [25/135 (1!)] on J1 in 64.73s, 4 tests, 1 failure <<< 
FAILURES!

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

Reply via email to