lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Apache Jenkins Server <jenk...@builds.apache.org>
Subject [JENKINS] Lucene-Solr-NightlyTests-5.x - Build # 916 - Still Failing
Date Sat, 01 Aug 2015 17:35:20 GMT
Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-5.x/916/

4 tests failed.
FAILED:  org.apache.solr.DistributedIntervalFacetingTest.test

Error Message:
Captured an uncaught exception in thread: Thread[id=893, name=Thread-280, state=RUNNABLE, group=TGRP-DistributedIntervalFacetingTest]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=893, name=Thread-280, state=RUNNABLE, group=TGRP-DistributedIntervalFacetingTest]
Caused by: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: IOException occured when talking to server at: http://127.0.0.1:48307/b_s/collection1
	at __randomizedtesting.SeedInfo.seed([D2CDF61640F93AEA]:0)
	at org.apache.solr.BaseDistributedSearchTestCase$5.run(BaseDistributedSearchTestCase.java:632)
Caused by: org.apache.solr.client.solrj.SolrServerException: IOException occured when talking to server at: http://127.0.0.1:48307/b_s/collection1
	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:574)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:234)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:226)
	at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:135)
	at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:943)
	at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:958)
	at org.apache.solr.BaseDistributedSearchTestCase$5.run(BaseDistributedSearchTestCase.java:627)
Caused by: java.io.InterruptedIOException: Connection has been shut down
	at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:579)
	at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882)
	at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
	at org.apache.solr.util.SolrHttpClient$SolrSystemDefaultHttpClient.execute(SolrHttpClient.java:54)
	at org.apache.solr.util.SolrHttpClient$SolrSystemDefaultHttpClient.execute(SolrHttpClient.java:45)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:465)
	... 6 more
Caused by: org.apache.http.impl.conn.ConnectionShutdownException
	at org.apache.http.impl.conn.ManagedClientConnectionImpl.ensurePoolEntry(ManagedClientConnectionImpl.java:123)
	at org.apache.http.impl.conn.ManagedClientConnectionImpl.getRoute(ManagedClientConnectionImpl.java:282)
	at org.apache.http.client.protocol.RequestProxyAuthentication.process(RequestProxyAuthentication.java:74)
	at org.apache.http.protocol.ImmutableHttpProcessor.process(ImmutableHttpProcessor.java:132)
	at org.apache.http.protocol.HttpRequestExecutor.preProcess(HttpRequestExecutor.java:166)
	at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:485)
	... 11 more


FAILED:  org.apache.solr.TestDistributedSearch.test

Error Message:
Captured an uncaught exception in thread: Thread[id=45119, name=Thread-44333, state=RUNNABLE, group=TGRP-TestDistributedSearch]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=45119, name=Thread-44333, state=RUNNABLE, group=TGRP-TestDistributedSearch]
Caused by: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: IOException occured when talking to server at: http://127.0.0.1:55624//collection1
	at __randomizedtesting.SeedInfo.seed([D2CDF61640F93AEA]:0)
	at org.apache.solr.BaseDistributedSearchTestCase$5.run(BaseDistributedSearchTestCase.java:632)
Caused by: org.apache.solr.client.solrj.SolrServerException: IOException occured when talking to server at: http://127.0.0.1:55624//collection1
	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:574)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:234)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:226)
	at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:135)
	at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:943)
	at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:958)
	at org.apache.solr.BaseDistributedSearchTestCase$5.run(BaseDistributedSearchTestCase.java:627)
Caused by: java.io.InterruptedIOException: Connection has been shut down
	at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:579)
	at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882)
	at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
	at org.apache.solr.util.SolrHttpClient$SolrSystemDefaultHttpClient.execute(SolrHttpClient.java:54)
	at org.apache.solr.util.SolrHttpClient$SolrSystemDefaultHttpClient.execute(SolrHttpClient.java:45)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:465)
	... 6 more
Caused by: org.apache.http.impl.conn.ConnectionShutdownException
	at org.apache.http.impl.conn.ManagedClientConnectionImpl.ensurePoolEntry(ManagedClientConnectionImpl.java:123)
	at org.apache.http.impl.conn.ManagedClientConnectionImpl.getRoute(ManagedClientConnectionImpl.java:282)
	at org.apache.http.client.protocol.RequestProxyAuthentication.process(RequestProxyAuthentication.java:74)
	at org.apache.http.protocol.ImmutableHttpProcessor.process(ImmutableHttpProcessor.java:132)
	at org.apache.http.protocol.HttpRequestExecutor.preProcess(HttpRequestExecutor.java:166)
	at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:485)
	... 11 more


FAILED:  org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test

Error Message:
Captured an uncaught exception in thread: Thread[id=21285, name=collection3, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=21285, name=collection3, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:49585: collection already exists: awholynewstresscollection_collection3_0
	at __randomizedtesting.SeedInfo.seed([D2CDF61640F93AEA]:0)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:560)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:234)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:226)
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:376)
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:328)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1086)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:856)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:799)
	at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220)
	at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1572)
	at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1593)
	at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:887)


FAILED:  org.apache.solr.handler.component.TermVectorComponentDistributedTest.test

Error Message:
Captured an uncaught exception in thread: Thread[id=23532, name=Thread-17722, state=RUNNABLE, group=TGRP-TermVectorComponentDistributedTest]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=23532, name=Thread-17722, state=RUNNABLE, group=TGRP-TermVectorComponentDistributedTest]
	at __randomizedtesting.SeedInfo.seed([D2CDF61640F93AEA:5A99C9CCEE055712]:0)
Caused by: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: IOException occured when talking to server at: http://127.0.0.1:60201/p/fi/collection1
	at __randomizedtesting.SeedInfo.seed([D2CDF61640F93AEA]:0)
	at org.apache.solr.BaseDistributedSearchTestCase$5.run(BaseDistributedSearchTestCase.java:632)
Caused by: org.apache.solr.client.solrj.SolrServerException: IOException occured when talking to server at: http://127.0.0.1:60201/p/fi/collection1
	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:574)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:234)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:226)
	at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:135)
	at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:943)
	at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:958)
	at org.apache.solr.BaseDistributedSearchTestCase$5.run(BaseDistributedSearchTestCase.java:627)
Caused by: java.io.InterruptedIOException: Connection has been shut down
	at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:579)
	at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882)
	at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
	at org.apache.solr.util.SolrHttpClient$SolrSystemDefaultHttpClient.execute(SolrHttpClient.java:54)
	at org.apache.solr.util.SolrHttpClient$SolrSystemDefaultHttpClient.execute(SolrHttpClient.java:45)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:465)
	... 6 more
Caused by: org.apache.http.impl.conn.ConnectionShutdownException
	at org.apache.http.impl.conn.ManagedClientConnectionImpl.ensureConnection(ManagedClientConnectionImpl.java:115)
	at org.apache.http.impl.conn.ManagedClientConnectionImpl.getSSLSession(ManagedClientConnectionImpl.java:247)
	at org.apache.http.impl.client.DefaultUserTokenHandler.getUserToken(DefaultUserTokenHandler.java:81)
	at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:550)
	... 11 more




Build Log:
[...truncated 10326 lines...]
   [junit4] Suite: org.apache.solr.DistributedIntervalFacetingTest
   [junit4]   2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/init-core-data-001
   [junit4]   2> 223796 INFO  (SUITE-DistributedIntervalFacetingTest-seed#[D2CDF61640F93AEA]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
   [junit4]   2> 223796 INFO  (SUITE-DistributedIntervalFacetingTest-seed#[D2CDF61640F93AEA]-worker) [    ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /b_s/
   [junit4]   2> 224186 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/control/cores/collection1
   [junit4]   2> 224188 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.e.j.s.Server jetty-9.2.11.v20150529
   [junit4]   2> 224190 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7bc17541{/b_s,null,AVAILABLE}
   [junit4]   2> 224197 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.e.j.s.ServerConnector Started ServerConnector@59f93de0{HTTP/1.1}{127.0.0.1:47709}
   [junit4]   2> 224197 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.e.j.s.Server Started @227255ms
   [junit4]   2> 224197 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema-distrib-interval-faceting.xml, solrconfig=solrconfig-basic.xml, hostContext=/b_s, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/control/cores, hostPort=47709}
   [junit4]   2> 224198 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@6b482747
   [junit4]   2> 224198 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/control/'
   [junit4]   2> 224213 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/control/solr.xml
   [junit4]   2> 224228 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.c.CoresLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/control/cores
   [junit4]   2> 224228 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.c.CoreContainer New CoreContainer 1232744362
   [junit4]   2> 224228 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/control/]
   [junit4]   2> 224228 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.c.CoreContainer loading shared library: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/control/lib
   [junit4]   2> 224229 WARN  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/control/lib).
   [junit4]   2> 224238 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
   [junit4]   2> 224239 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 224240 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 224240 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 224240 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 224242 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.c.CoresLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/control/cores
   [junit4]   2> 224243 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.c.SolrCore Created CoreDescriptor: {absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/control/cores/collection1/, config=solrconfig-basic.xml, configSetProperties=configsetprops.json, name=collection1, configSet=collection1, dataDir=data/, schema=schema-distrib-interval-faceting.xml, loadOnStartup=true, transient=false, instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/control/cores/collection1}
   [junit4]   2> 224243 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.c.CoresLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/control/cores/collection1/
   [junit4]   2> 224243 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.c.CoresLocator Found 1 core definitions
   [junit4]   2> 224244 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2
   [junit4]   2> 224251 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 224252 INFO  (coreLoadExecutor-203-thread-1) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 224253 INFO  (coreLoadExecutor-203-thread-1) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader
   [junit4]   2> 224253 INFO  (coreLoadExecutor-203-thread-1) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 224253 INFO  (coreLoadExecutor-203-thread-1) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 224276 INFO  (coreLoadExecutor-203-thread-1) [    ] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 224287 INFO  (coreLoadExecutor-203-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.3.0
   [junit4]   2> 224316 INFO  (coreLoadExecutor-203-thread-1) [    ] o.a.s.c.Config Loaded SolrConfig: solrconfig-basic.xml
   [junit4]   2> 224316 INFO  (coreLoadExecutor-203-thread-1) [    ] o.a.s.s.IndexSchema Reading Solr Schema from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/schema-distrib-interval-faceting.xml
   [junit4]   2> 224321 INFO  (coreLoadExecutor-203-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 224337 INFO  (coreLoadExecutor-203-thread-1) [    ] o.a.s.s.IndexSchema default search field in schema is id
   [junit4]   2> 224339 INFO  (coreLoadExecutor-203-thread-1) [    ] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 224340 INFO  (coreLoadExecutor-203-thread-1) [    ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf'
   [junit4]   2> 224340 INFO  (coreLoadExecutor-203-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1
   [junit4]   2> 224341 INFO  (coreLoadExecutor-203-thread-1) [    x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 224341 INFO  (coreLoadExecutor-203-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/], dataDir=[null]
   [junit4]   2> 224341 INFO  (coreLoadExecutor-203-thread-1) [    x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
   [junit4]   2> 224342 INFO  (coreLoadExecutor-203-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/control/cores/collection1/data
   [junit4]   2> 224342 INFO  (coreLoadExecutor-203-thread-1) [    x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/control/cores/collection1/data/index/
   [junit4]   2> 224342 WARN  (coreLoadExecutor-203-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/control/cores/collection1/data/index' doesn't exist. Creating new index...
   [junit4]   2> 224343 INFO  (coreLoadExecutor-203-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/control/cores/collection1/data/index
   [junit4]   2> 224343 INFO  (coreLoadExecutor-203-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=6, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=0.798828125, noCFSRatio=1.0]
   [junit4]   2> 224344 INFO  (coreLoadExecutor-203-thread-1) [    x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@448f3ab0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@17561bfa; maxCacheMB=0.4326171875 maxMergeSizeMB=0.5859375)),segFN=segments_1,generation=1}
   [junit4]   2> 224344 INFO  (coreLoadExecutor-203-thread-1) [    x:collection1] o.a.s.c.SolrCore newest commit generation = 1
   [junit4]   2> 224345 INFO  (OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/control/cores/collection1/data/
   [junit4]   2> 224345 WARN  (OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] o.a.s.c.DirectoryFactory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/control/cores/collection1/data/ does not point to a valid data directory; skipping clean-up of old index directories.
   [junit4]   2> 224347 INFO  (coreLoadExecutor-203-thread-1) [    x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 224350 INFO  (coreLoadExecutor-203-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 224351 INFO  (coreLoadExecutor-203-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 224352 INFO  (coreLoadExecutor-203-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 224353 INFO  (coreLoadExecutor-203-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 224355 INFO  (coreLoadExecutor-203-thread-1) [    x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/luke,/admin/plugins,/replication,/get,/admin/segments,/admin/system,/update/json,/admin/ping,/update/json/docs,/schema,/update/csv,/admin/mbeans,standard,/admin/file,/admin/logging,/update,/admin/threads,/admin/properties,/config
   [junit4]   2> 224356 INFO  (coreLoadExecutor-203-thread-1) [    x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 224357 INFO  (coreLoadExecutor-203-thread-1) [    x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
   [junit4]   2> 224357 INFO  (coreLoadExecutor-203-thread-1) [    x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
   [junit4]   2> 224357 INFO  (coreLoadExecutor-203-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=40, maxMergeAtOnceExplicit=19, maxMergedSegmentMB=46.2958984375, floorSegmentMB=0.626953125, forceMergeDeletesPctAllowed=9.03776042347282, segmentsPerTier=23.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 224358 INFO  (coreLoadExecutor-203-thread-1) [    x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@448f3ab0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@17561bfa; maxCacheMB=0.4326171875 maxMergeSizeMB=0.5859375)),segFN=segments_1,generation=1}
   [junit4]   2> 224358 INFO  (coreLoadExecutor-203-thread-1) [    x:collection1] o.a.s.c.SolrCore newest commit generation = 1
   [junit4]   2> 224358 INFO  (coreLoadExecutor-203-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@6401b48a[collection1] main
   [junit4]   2> 224359 WARN  (coreLoadExecutor-203-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
   [junit4]   2> 224359 INFO  (coreLoadExecutor-203-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
   [junit4]   2> 224359 INFO  (coreLoadExecutor-203-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage
   [junit4]   2> 224359 INFO  (coreLoadExecutor-203-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 224359 INFO  (coreLoadExecutor-203-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 224359 INFO  (coreLoadExecutor-203-thread-1) [    x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 224360 INFO  (searcherExecutor-204-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6401b48a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 225073 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/shard0/cores/collection1
   [junit4]   2> 225074 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.e.j.s.Server jetty-9.2.11.v20150529
   [junit4]   2> 225080 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1bb70a88{/b_s,null,AVAILABLE}
   [junit4]   2> 225081 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.e.j.s.ServerConnector Started ServerConnector@e1474ef{HTTP/1.1}{127.0.0.1:48307}
   [junit4]   2> 225081 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.e.j.s.Server Started @228139ms
   [junit4]   2> 225082 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solrconfig=solrconfig-basic.xml, hostContext=/b_s, schema=schema-distrib-interval-faceting.xml, hostPort=48307, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/shard0/cores}
   [junit4]   2> 225082 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@6b482747
   [junit4]   2> 225082 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/shard0/'
   [junit4]   2> 225102 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/shard0/solr.xml
   [junit4]   2> 225126 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.c.CoresLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/shard0/cores
   [junit4]   2> 225127 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.c.CoreContainer New CoreContainer 1326342700
   [junit4]   2> 225127 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/shard0/]
   [junit4]   2> 225128 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.c.CoreContainer loading shared library: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/shard0/lib
   [junit4]   2> 225129 WARN  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/shard0/lib).
   [junit4]   2> 225145 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
   [junit4]   2> 225149 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 225150 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 225150 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 225150 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 225152 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.c.CoresLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/shard0/cores
   [junit4]   2> 225153 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.c.SolrCore Created CoreDescriptor: {configSet=collection1, dataDir=data/, transient=false, absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/shard0/cores/collection1/, config=solrconfig-basic.xml, name=collection1, loadOnStartup=true, instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/shard0/cores/collection1, schema=schema-distrib-interval-faceting.xml, configSetProperties=configsetprops.json}
   [junit4]   2> 225153 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.c.CoresLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/shard0/cores/collection1/
   [junit4]   2> 225154 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.c.CoresLocator Found 1 core definitions
   [junit4]   2> 225175 INFO  (coreLoadExecutor-213-thread-1) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 225175 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2
   [junit4]   2> 225186 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 225186 INFO  (coreLoadExecutor-213-thread-1) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader
   [junit4]   2> 225187 INFO  (coreLoadExecutor-213-thread-1) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 225187 INFO  (coreLoadExecutor-213-thread-1) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 225221 INFO  (coreLoadExecutor-213-thread-1) [    ] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 225253 INFO  (coreLoadExecutor-213-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.3.0
   [junit4]   2> 225315 INFO  (coreLoadExecutor-213-thread-1) [    ] o.a.s.c.Config Loaded SolrConfig: solrconfig-basic.xml
   [junit4]   2> 225316 INFO  (coreLoadExecutor-213-thread-1) [    ] o.a.s.s.IndexSchema Reading Solr Schema from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/schema-distrib-interval-faceting.xml
   [junit4]   2> 225325 INFO  (coreLoadExecutor-213-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 225351 INFO  (coreLoadExecutor-213-thread-1) [    ] o.a.s.s.IndexSchema default search field in schema is id
   [junit4]   2> 225352 INFO  (coreLoadExecutor-213-thread-1) [    ] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 225354 INFO  (coreLoadExecutor-213-thread-1) [    ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf'
   [junit4]   2> 225354 INFO  (coreLoadExecutor-213-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1
   [junit4]   2> 225354 INFO  (coreLoadExecutor-213-thread-1) [    x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 225354 INFO  (coreLoadExecutor-213-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/], dataDir=[null]
   [junit4]   2> 225354 INFO  (coreLoadExecutor-213-thread-1) [    x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
   [junit4]   2> 225355 INFO  (coreLoadExecutor-213-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/shard0/cores/collection1/data
   [junit4]   2> 225355 INFO  (coreLoadExecutor-213-thread-1) [    x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/shard0/cores/collection1/data/index/
   [junit4]   2> 225355 WARN  (coreLoadExecutor-213-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/shard0/cores/collection1/data/index' doesn't exist. Creating new index...
   [junit4]   2> 225356 INFO  (coreLoadExecutor-213-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/shard0/cores/collection1/data/index
   [junit4]   2> 225356 INFO  (coreLoadExecutor-213-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=6, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=0.798828125, noCFSRatio=1.0]
   [junit4]   2> 225357 INFO  (coreLoadExecutor-213-thread-1) [    x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@22e82fb1 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@39931f5e; maxCacheMB=0.4326171875 maxMergeSizeMB=0.5859375)),segFN=segments_1,generation=1}
   [junit4]   2> 225357 INFO  (coreLoadExecutor-213-thread-1) [    x:collection1] o.a.s.c.SolrCore newest commit generation = 1
   [junit4]   2> 225358 INFO  (OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/shard0/cores/collection1/data/
   [junit4]   2> 225359 WARN  (OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] o.a.s.c.DirectoryFactory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.DistributedIntervalFacetingTest_D2CDF61640F93AEA-001/tempDir-001/shard0/cores/collection1/data/ does not point to a valid data directory; skipping clean-up of old index directories.
   [junit4]   2> 225361 INFO  (coreLoadExecutor-213-thread-1) [    x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 225364 INFO  (coreLoadExecutor-213-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 225366 INFO  (coreLoadExecutor-213-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 225367 INFO  (coreLoadExecutor-213-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 225368 INFO  (coreLoadExecutor-213-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 225374 INFO  (coreLoadExecutor-213-thread-1) [    x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/luke,/admin/plugins,/replication,/get,/admin/segments,/admin/system,/update/json,/admin/ping,/update/json/docs,/schema,/update/csv,/admin/mbeans,standard,/admin/file,/admin/logging,/update,/admin/threads,/admin/properties,/config
   [junit4]   2> 225375 INFO  (coreLoadExecutor-213-thread-1) [    x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 225375 INFO  (coreLoadExecutor-213-thread-1) [    x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
   [junit4]   2> 225376 INFO  (coreLoadExecutor-213-thread-1) [    x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
   [junit4]   2> 225376 INFO  (coreLoadExecutor-213-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=40, maxMergeAtOnceExplicit=19, maxMergedSegmentMB=46.2958984375, floorSegmentMB=0.626953125, forceMergeDeletesPctAllowed=9.03776042347282, segmentsPerTier=23.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 225377 INFO  (coreLoadExecutor-213-thread-1) [    x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@22e82fb1 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@39931f5e; maxCacheMB=0.4326171875 maxMergeSizeMB=0.5859375)),segFN=segments_1,generation=1}
   [junit4]   2> 225377 INFO  (coreLoadExecutor-213-thread-1) [    x:collection1] o.a.s.c.SolrCore newest commit generation = 1
   [junit4]   2> 225377 INFO  (coreLoadExecutor-213-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@2080973e[collection1] main
   [junit4]   2> 225377 WARN  (coreLoadExecutor-213-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
   [junit4]   2> 225378 INFO  (coreLoadExecutor-213-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
   [junit4]   2> 225378 INFO  (coreLoadExecutor-213-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage
   [junit4]   2> 225378 INFO  (coreLoadExecutor-213-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 225378 INFO  (coreLoadExecutor-213-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 225378 INFO  (coreLoadExecutor-213-thread-1) [    x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 225379 INFO  (searcherExecutor-214-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2080973e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 225687 INFO  (TEST-DistributedIntervalFacetingTest.test-seed#[D2CDF61640F93AEA]) [    ] o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 225692 INFO  (qtp483398844-797) [    x:collection1] o.a.s.c.SolrCore [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 225692 INFO  (qtp483398844-797) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {deleteByQuery=*:*} 0 1
   [junit4]   2> 225695 INFO  (qtp83200478-815) [    x:collection1] o.a.s.c.SolrCore [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 225696 INFO  (qtp83200478-815) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {deleteByQuery=*:*} 0 1
   [junit4]   2> 225699 INFO  (qtp483398844-798) [    x:collection1] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 225701 INFO  (qtp483398844-798) [    x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@448f3ab0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@17561bfa; maxCacheMB=0.4326171875 maxMergeSizeMB=0.5859375)),segFN=segments_1,generation=1}
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@448f3ab0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@17561bfa; maxCacheMB=0.4326171875 maxMergeSizeMB=0.5859375)),segFN=segments_2,generation=2}
   [junit4]   2> 225701 INFO  (qtp483398844-798) [    x:collection1] o.a.s.c.SolrCore newest commit generation = 2
   [junit4]   2> 225702 INFO  (qtp483398844-798) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@147b5907[collection1] main
   [junit4]   2> 225702 INFO  (qtp483398844-798) [    x:collection1] o.a.s.u.UpdateHandler end_commit_flush
   [junit4]   2> 225702 INFO  (searcherExecutor-204-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@147b5907[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 225702 INFO  (qtp483398844-798) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={softCommit=false&waitSearcher=true&commit=true&wt=javabin&version=2} {commit=} 0 3
   [junit4]   2> 225706 INFO  (qtp83200478-816) [    x:collection1] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 225707 INFO  (qtp83200478-816) [    x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@22e82fb1 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@39931f5e; maxCacheMB=0.4326171875 maxMergeSizeMB=0.5859375)),segFN=segments_1,generation=1}
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@22e82fb1 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@39931f5e; maxCacheMB=0.4326171875 maxMergeSizeMB=0.5859375)),segFN=segments_2,generation=2}
   [junit4]   2> 225707 INFO  (qtp83200478-816) [    x:collection1] o.a.s.c.SolrCore newest commit generation = 2
   [junit4]   2> 225707 INFO  (qtp83200478-816) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@6b8dd9da[collection1] main
   [junit4]   2> 225708 INFO  (qtp83200478-816) [    x:collection1] o.a.s.u.UpdateHandler end_commit_flush
   [junit4]   2> 225710 INFO  (searcherExecutor-214-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6b8dd9da[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 225710 INFO  (qtp83200478-816) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={softCommit=false&waitSearcher=true&commit=true&wt=javabin&version=2} {commit=} 0 4
   [junit4]   2> 225723 INFO  (qtp483398844-799) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[0]} 0 8
   [junit4]   2> 225730 INFO  (qtp83200478-817) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[0]} 0 3
   [junit4]   2> 225737 INFO  (qtp483398844-800) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[1]} 0 3
   [junit4]   2> 225742 INFO  (qtp83200478-818) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[1]} 0 1
   [junit4]   2> 225748 INFO  (qtp483398844-801) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[2]} 0 1
   [junit4]   2> 225755 INFO  (qtp83200478-819) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[2]} 0 3
   [junit4]   2> 225762 INFO  (qtp483398844-797) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[3]} 0 1
   [junit4]   2> 225768 INFO  (qtp83200478-815) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[3]} 0 1
   [junit4]   2> 225773 INFO  (qtp483398844-798) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[4]} 0 1
   [junit4]   2> 225781 INFO  (qtp83200478-816) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[4]} 0 2
   [junit4]   2> 225786 INFO  (qtp483398844-799) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[5]} 0 1
   [junit4]   2> 225795 INFO  (qtp83200478-817) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[5]} 0 1
   [junit4]   2> 225799 INFO  (qtp483398844-800) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[6]} 0 1
   [junit4]   2> 225803 INFO  (qtp83200478-818) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[6]} 0 1
   [junit4]   2> 225808 INFO  (qtp483398844-801) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[7]} 0 1
   [junit4]   2> 225812 INFO  (qtp83200478-819) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[7]} 0 1
   [junit4]   2> 225816 INFO  (qtp483398844-797) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[8]} 0 1
   [junit4]   2> 225822 INFO  (qtp83200478-815) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[8]} 0 1
   [junit4]   2> 225827 INFO  (qtp483398844-798) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[9]} 0 1
   [junit4]   2> 225831 INFO  (qtp83200478-816) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[9]} 0 1
   [junit4]   2> 225837 INFO  (qtp483398844-799) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[10]} 0 1
   [junit4]   2> 225842 INFO  (qtp83200478-817) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[10]} 0 1
   [junit4]   2> 225849 INFO  (qtp483398844-800) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[11]} 0 1
   [junit4]   2> 225854 INFO  (qtp83200478-818) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[11]} 0 1
   [junit4]   2> 225859 INFO  (qtp483398844-801) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[12]} 0 1
   [junit4]   2> 225864 INFO  (qtp83200478-819) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[12]} 0 1
   [junit4]   2> 225869 INFO  (qtp483398844-797) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[13]} 0 1
   [junit4]   2> 225875 INFO  (qtp83200478-815) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[13]} 0 1
   [junit4]   2> 225882 INFO  (qtp483398844-798) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[14]} 0 1
   [junit4]   2> 225887 INFO  (qtp83200478-816) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[14]} 0 1
   [junit4]   2> 225891 INFO  (qtp483398844-799) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[15]} 0 1
   [junit4]   2> 225899 INFO  (qtp83200478-817) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[15]} 0 1
   [junit4]   2> 225915 INFO  (qtp483398844-800) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[16]} 0 1
   [junit4]   2> 225920 INFO  (qtp83200478-818) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[16]} 0 0
   [junit4]   2> 225926 INFO  (qtp483398844-801) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[17]} 0 1
   [junit4]   2> 225932 INFO  (qtp83200478-819) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[17]} 0 1
   [junit4]   2> 225937 INFO  (qtp483398844-797) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[18]} 0 1
   [junit4]   2> 225944 INFO  (qtp83200478-815) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[18]} 0 1
   [junit4]   2> 225948 INFO  (qtp483398844-798) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[19]} 0 1
   [junit4]   2> 225953 INFO  (qtp83200478-816) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[19]} 0 1
   [junit4]   2> 225958 INFO  (qtp483398844-799) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[20]} 0 1
   [junit4]   2> 225962 INFO  (qtp83200478-817) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[20]} 0 1
   [junit4]   2> 225967 INFO  (qtp483398844-800) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[21]} 0 1
   [junit4]   2> 225972 INFO  (qtp83200478-818) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[21]} 0 1
   [junit4]   2> 225978 INFO  (qtp483398844-801) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[22]} 0 1
   [junit4]   2> 225990 INFO  (qtp83200478-819) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[22]} 0 1
   [junit4]   2> 226005 INFO  (qtp483398844-797) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[23]} 0 5
   [junit4]   2> 226009 INFO  (qtp83200478-815) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[23]} 0 1
   [junit4]   2> 226015 INFO  (qtp483398844-798) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[24]} 0 1
   [junit4]   2> 226019 INFO  (qtp83200478-816) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[24]} 0 1
   [junit4]   2> 226024 INFO  (qtp483398844-799) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[25]} 0 2
   [junit4]   2> 226030 INFO  (qtp83200478-817) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[25]} 0 1
   [junit4]   2> 226036 INFO  (qtp483398844-800) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[26]} 0 1
   [junit4]   2> 226053 INFO  (qtp83200478-818) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[26]} 0 1
   [junit4]   2> 226058 INFO  (qtp483398844-801) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[27]} 0 1
   [junit4]   2> 226062 INFO  (qtp83200478-819) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[27]} 0 1
   [junit4]   2> 226068 INFO  (qtp483398844-797) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[28]} 0 1
   [junit4]   2> 226072 INFO  (qtp83200478-815) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[28]} 0 1
   [junit4]   2> 226078 INFO  (qtp483398844-798) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[29]} 0 1
   [junit4]   2> 226083 INFO  (qtp83200478-816) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[29]} 0 1
   [junit4]   2> 226088 INFO  (qtp483398844-799) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[30]} 0 1
   [junit4]   2> 226092 INFO  (qtp83200478-817) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[30]} 0 1
   [junit4]   2> 226097 INFO  (qtp483398844-800) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[31]} 0 1
   [junit4]   2> 226101 INFO  (qtp83200478-818) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[31]} 0 1
   [junit4]   2> 226105 INFO  (qtp483398844-801) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[32]} 0 1
   [junit4]   2> 226110 INFO  (qtp83200478-819) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[32]} 0 1
   [junit4]   2> 226115 INFO  (qtp483398844-797) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[33]} 0 1
   [junit4]   2> 226120 INFO  (qtp83200478-815) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[33]} 0 1
   [junit4]   2> 226127 INFO  (qtp483398844-798) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[34]} 0 1
   [junit4]   2> 226132 INFO  (qtp83200478-816) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[34]} 0 1
   [junit4]   2> 226136 INFO  (qtp483398844-799) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[35]} 0 1
   [junit4]   2> 226140 INFO  (qtp83200478-817) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[35]} 0 1
   [junit4]   2> 226145 INFO  (qtp483398844-800) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[36]} 0 1
   [junit4]   2> 226154 INFO  (qtp83200478-818) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[36]} 0 1
   [junit4]   2> 226167 INFO  (qtp483398844-801) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[37]} 0 1
   [junit4]   2> 226174 INFO  (qtp83200478-819) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[37]} 0 2
   [junit4]   2> 226179 INFO  (qtp483398844-797) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[38]} 0 1
   [junit4]   2> 226185 INFO  (qtp83200478-815) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[38]} 0 1
   [junit4]   2> 226195 INFO  (qtp483398844-798) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[39]} 0 1
   [junit4]   2> 226199 INFO  (qtp83200478-816) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[39]} 0 1
   [junit4]   2> 226204 INFO  (qtp483398844-799) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[40]} 0 1
   [junit4]   2> 226218 INFO  (qtp83200478-817) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[40]} 0 1
   [junit4]   2> 226230 INFO  (qtp483398844-800) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[41]} 0 1
   [junit4]   2> 226236 INFO  (qtp83200478-818) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[41]} 0 1
   [junit4]   2> 226242 INFO  (qtp483398844-801) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[42]} 0 1
   [junit4]   2> 226247 INFO  (qtp83200478-819) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[42]} 0 1
   [junit4]   2> 226252 INFO  (qtp483398844-797) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[43]} 0 1
   [junit4]   2> 226259 INFO  (qtp83200478-815) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[43]} 0 1
   [junit4]   2> 226265 INFO  (qtp483398844-798) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[44]} 0 2
   [junit4]   2> 226270 INFO  (qtp83200478-816) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[44]} 0 1
   [junit4]   2> 226280 INFO  (qtp483398844-799) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[45]} 0 5
   [junit4]   2> 226289 INFO  (qtp83200478-817) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[45]} 0 1
   [junit4]   2> 226297 INFO  (qtp483398844-800) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[46]} 0 1
   [junit4]   2> 226302 INFO  (qtp83200478-818) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[46]} 0 1
   [junit4]   2> 226306 INFO  (qtp483398844-801) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[47]} 0 1
   [junit4]   2> 226318 INFO  (qtp83200478-819) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[47]} 0 1
   [junit4]   2> 226325 INFO  (qtp483398844-797) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[48]} 0 1
   [junit4]   2> 226331 INFO  (qtp83200478-815) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[48]} 0 1
   [junit4]   2> 226335 INFO  (qtp483398844-798) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[49]} 0 0
   [junit4]   2> 226342 INFO  (qtp83200478-816) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[49]} 0 1
   [junit4]   2> 226348 INFO  (qtp483398844-799) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[50]} 0 1
   [junit4]   2> 226354 INFO  (qtp83200478-817) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[50]} 0 1
   [junit4]   2> 226359 INFO  (qtp483398844-800) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[51]} 0 1
   [junit4]   2> 226364 INFO  (qtp83200478-818) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[51]} 0 1
   [junit4]   2> 226384 INFO  (qtp483398844-801) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[52]} 0 8
   [junit4]   2> 226400 INFO  (qtp83200478-819) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[52]} 0 2
   [junit4]   2> 226406 INFO  (qtp483398844-797) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[53]} 0 1
   [junit4]   2> 226413 INFO  (qtp83200478-815) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[53]} 0 1
   [junit4]   2> 226419 INFO  (qtp483398844-798) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {deleteByQuery=id:53} 0 0
   [junit4]   2> 226423 INFO  (qtp83200478-816) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {deleteByQuery=id:53} 0 0
   [junit4]   2> 226435 INFO  (qtp483398844-799) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[54]} 0 1
   [junit4]   2> 226440 INFO  (qtp83200478-817) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[54]} 0 1
   [junit4]   2> 226445 INFO  (qtp483398844-800) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[55]} 0 1
   [junit4]   2> 226452 INFO  (qtp83200478-818) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[55]} 0 1
   [junit4]   2> 226457 INFO  (qtp483398844-801) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[56]} 0 1
   [junit4]   2> 226463 INFO  (qtp83200478-819) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[56]} 0 1
   [junit4]   2> 226466 INFO  (qtp483398844-797) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {deleteByQuery=id:56} 0 0
   [junit4]   2> 226469 INFO  (qtp83200478-815) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {deleteByQuery=id:56} 0 0
   [junit4]   2> 226476 INFO  (qtp483398844-798) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[57]} 0 1
   [junit4]   2> 226481 INFO  (qtp83200478-816) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[57]} 0 1
   [junit4]   2> 226488 INFO  (qtp483398844-799) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[58]} 0 1
   [junit4]   2> 226504 INFO  (qtp83200478-817) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[58]} 0 1
   [junit4]   2> 226515 INFO  (qtp483398844-800) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[59]} 0 1
   [junit4]   2> 226522 INFO  (qtp83200478-818) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[59]} 0 2
   [junit4]   2> 226536 INFO  (qtp483398844-801) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[60]} 0 1
   [junit4]   2> 226542 INFO  (qtp83200478-819) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[60]} 0 2
   [junit4]   2> 226552 INFO  (qtp483398844-797) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[61]} 0 2
   [junit4]   2> 226558 INFO  (qtp83200478-815) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[61]} 0 2
   [junit4]   2> 226564 INFO  (qtp483398844-798) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[62]} 0 1
   [junit4]   2> 226583 INFO  (qtp83200478-816) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[62]} 0 1
   [junit4]   2> 226591 INFO  (qtp483398844-799) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[63]} 0 1
   [junit4]   2> 226599 INFO  (qtp83200478-817) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[63]} 0 1
   [junit4]   2> 226604 INFO  (qtp483398844-800) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[64]} 0 2
   [junit4]   2> 226610 INFO  (qtp83200478-818) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[64]} 0 1
   [junit4]   2> 226617 INFO  (qtp483398844-801) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[65]} 0 1
   [junit4]   2> 226624 INFO  (qtp83200478-819) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[65]} 0 2
   [junit4]   2> 226629 INFO  (qtp483398844-797) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[66]} 0 2
   [junit4]   2> 226634 INFO  (qtp83200478-815) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[66]} 0 1
   [junit4]   2> 226640 INFO  (qtp483398844-798) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[67]} 0 1
   [junit4]   2> 226646 INFO  (qtp83200478-816) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[67]} 0 1
   [junit4]   2> 226651 INFO  (qtp483398844-799) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[68]} 0 1
   [junit4]   2> 226657 INFO  (qtp83200478-817) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[68]} 0 1
   [junit4]   2> 226663 INFO  (qtp483398844-800) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[69]} 0 1
   [junit4]   2> 226668 INFO  (qtp83200478-818) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[69]} 0 1
   [junit4]   2> 226676 INFO  (qtp483398844-801) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[70]} 0 1
   [junit4]   2> 226681 INFO  (qtp83200478-819) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[70]} 0 1
   [junit4]   2> 226689 INFO  (qtp483398844-797) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[71]} 0 1
   [junit4]   2> 226694 INFO  (qtp83200478-815) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[71]} 0 1
   [junit4]   2> 226702 INFO  (qtp483398844-798) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[72]} 0 1
   [junit4]   2> 226710 INFO  (qtp83200478-816) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[72]} 0 1
   [junit4]   2> 226716 INFO  (qtp483398844-799) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[73]} 0 1
   [junit4]   2> 226722 INFO  (qtp83200478-817) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[73]} 0 2
   [junit4]   2> 226727 INFO  (qtp483398844-800) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[74]} 0 1
   [junit4]   2> 226734 INFO  (qtp83200478-818) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[74]} 0 1
   [junit4]   2> 226742 INFO  (qtp483398844-801) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[75]} 0 1
   [junit4]   2> 226749 INFO  (qtp83200478-819) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[75]} 0 2
   [junit4]   2> 226755 INFO  (qtp483398844-797) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[76]} 0 1
   [junit4]   2> 226763 INFO  (qtp83200478-815) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[76]} 0 1
   [junit4]   2> 226770 INFO  (qtp483398844-798) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[77]} 0 1
   [junit4]   2> 226776 INFO  (qtp83200478-816) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[77]} 0 1
   [junit4]   2> 226785 INFO  (qtp483398844-799) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[78]} 0 1
   [junit4]   2> 226791 INFO  (qtp83200478-817) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[78]} 0 1
   [junit4]   2> 226800 INFO  (qtp483398844-800) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[79]} 0 1
   [junit4]   2> 226805 INFO  (qtp83200478-818) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[79]} 0 1
   [junit4]   2> 226810 INFO  (qtp483398844-801) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[80]} 0 1
   [junit4]   2> 226819 INFO  (qtp83200478-819) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[80]} 0 1
   [junit4]   2> 226827 INFO  (qtp483398844-797) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[81]} 0 1
   [junit4]   2> 226834 INFO  (qtp83200478-815) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[81]} 0 1
   [junit4]   2> 226843 INFO  (qtp483398844-798) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[82]} 0 1
   [junit4]   2> 226849 INFO  (qtp83200478-816) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[82]} 0 1
   [junit4]   2> 226853 INFO  (qtp483398844-799) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[83]} 0 1
   [junit4]   2> 226857 INFO  (qtp83200478-817) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[83]} 0 1
   [junit4]   2> 226863 INFO  (qtp483398844-800) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[84]} 0 2
   [junit4]   2> 226873 INFO  (qtp83200478-818) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[84]} 0 1
   [junit4]   2> 226884 INFO  (qtp483398844-801) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[85]} 0 1
   [junit4]   2> 226889 INFO  (qtp83200478-819) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[85]} 0 1
   [junit4]   2> 226894 INFO  (qtp483398844-797) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[86]} 0 1
   [junit4]   2> 226898 INFO  (qtp83200478-815) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[86]} 0 1
   [junit4]   2> 226903 INFO  (qtp483398844-798) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[87]} 0 1
   [junit4]   2> 226907 INFO  (qtp83200478-816) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[87]} 0 1
   [junit4]   2> 226911 INFO  (qtp483398844-799) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {deleteByQuery=id:87} 0 0
   [junit4]   2> 226915 INFO  (qtp83200478-817) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {deleteByQuery=id:87} 0 0
   [junit4]   2> 226920 INFO  (qtp483398844-800) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[88]} 0 1
   [junit4]   2> 226924 INFO  (qtp83200478-818) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[88]} 0 1
   [junit4]   2> 226929 INFO  (qtp483398844-801) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[89]} 0 1
   [junit4]   2> 226934 INFO  (qtp83200478-819) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[89]} 0 1
   [junit4]   2> 226940 INFO  (qtp483398844-797) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[90]} 0 1
   [junit4]   2> 226948 INFO  (qtp83200478-815) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[90]} 0 3
   [junit4]   2> 226953 INFO  (qtp483398844-798) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[91]} 0 1
   [junit4]   2> 226958 INFO  (qtp83200478-816) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[91]} 0 1
   [junit4]   2> 226963 INFO  (qtp483398844-799) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[92]} 0 1
   [junit4]   2> 226973 INFO  (qtp83200478-817) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[92]} 0 1
   [junit4]   2> 226980 INFO  (qtp483398844-800) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[93]} 0 4
   [junit4]   2> 226985 INFO  (qtp83200478-818) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[93]} 0 1
   [junit4]   2> 226991 INFO  (qtp483398844-801) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[94]} 0 1
   [junit4]   2> 227008 INFO  (qtp83200478-819) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[94]} 0 1
   [junit4]   2> 227013 INFO  (qtp483398844-797) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[95]} 0 1
   [junit4]   2> 227017 INFO  (qtp83200478-815) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[95]} 0 1
   [junit4]   2> 227023 INFO  (qtp483398844-798) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[96]} 0 1
   [junit4]   2> 227028 INFO  (qtp83200478-816) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[96]} 0 1
   [junit4]   2> 227032 INFO  (qtp483398844-799) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[97]} 0 1
   [junit4]   2> 227037 INFO  (qtp83200478-817) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[97]} 0 1
   [junit4]   2> 227042 INFO  (qtp483398844-800) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[98]} 0 2
   [junit4]   2> 227046 INFO  (qtp83200478-818) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[98]} 0 0
   [junit4]   2> 227050 INFO  (qtp483398844-801) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[99]} 0 1
   [junit4]   2> 227054 INFO  (qtp83200478-819) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={wt=javabin&version=2} {add=[99]} 0 0
   [junit4]   2> 227057 INFO  (qtp483398844-797) [    x:collection1] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 227318 INFO  (qtp483398844-797) [    x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@448f3ab0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@17561bfa; maxCacheMB=0.4326171875 maxMergeSizeMB=0.5859375)),segFN=segments_2,generation=2}
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@448f3ab0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@17561bfa; maxCacheMB=0.4326171875 maxMergeSizeMB=0.5859375)),segFN=segments_3,generation=3}
   [junit4]   2> 227318 INFO  (qtp483398844-797) [    x:collection1] o.a.s.c.SolrCore newest commit generation = 3
   [junit4]   2> 227319 INFO  (qtp483398844-797) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@50da818a[collection1] main
   [junit4]   2> 227319 INFO  (searcherExecutor-204-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@50da818a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C100/3:delGen=1)))}
   [junit4]   2> 227320 INFO  (qtp483398844-797) [    x:collection1] o.a.s.u.UpdateHandler end_commit_flush
   [junit4]   2> 227320 INFO  (qtp483398844-797) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/b_s path=/update params={softCommit=false&waitSearcher=true&commit=true&wt=javabin&version=2} {commit=} 0 263
   [junit4]   2> 227323 INFO  (qtp83200478-815) [    x:collection1] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 227544 INFO  (qtp83200478-815) [    x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@22e82fb1 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@39931f5e; maxCacheMB=0.4326171875 maxMergeSizeMB=0.5859375)),segFN=segments_2,generation=2}
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@22e82fb1 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@39931f5e; maxCacheMB=0.4326171875 maxMergeSizeMB=0.5859375)),segFN=segments_3,generation=3}
   [junit4]   2> 227544 INFO  (qtp83200478-815) [    x:collection1] o.a.s.c.SolrCore newest commit generation = 3
   [junit4]   2> 227546 INFO  (qtp83200478-815) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@2d2bfef8[collection1] main
   [junit4]   2> 227547 INFO  (searcherExecutor-214-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collectio

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

ave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/hadoop-hdfs-2.6.0-tests.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/hadoop-minikdc-2.6.0.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/jackson-annotations-2.5.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/jackson-databind-2.5.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/jcl-over-slf4j-1.7.7.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/jersey-core-1.9.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/jersey-server-1.9.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/jetty-6.1.26.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/jetty-util-6.1.26.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/mina-core-2.0.0-M5.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/objenesis-1.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/lucene/build/analysis/icu/lucene-analyzers-icu-5.3.0-SNAPSHOT.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/contrib/solr-analysis-extras/classes/java:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/contrib/analysis-extras/lib/icu4j-54.1.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-launcher.jar:/x1/jenkins/.ant/lib/ivy-2.3.0.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-antlr.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-regexp.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-resolver.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-commons-net.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jmf.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-oro.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-xalan2.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-commons-logging.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jsch.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-junit4.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-javamail.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jai.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jdepend.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-junit.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-bsf.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-swing.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-netrexx.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-bcel.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-testutil.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-log4j.jar:/x1/jenkins/jenkins-slave/tools/hudson.model.JDK/latest1.7/lib/tools.jar:/x1/jenkins/.ivy2/cache/com.carrotsearch.randomizedtesting/junit4-ant/jars/junit4-ant-2.1.13.jar com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe -eventsfile /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/temp/junit4-J2-20150801_082319_834.events @/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/temp/junit4-J2-20150801_082319_834.suites
   [junit4] ERROR: JVM J2 ended with an exception: Quit event not received from the forked process? This may indicate JVM crash or runner bugs.
   [junit4] 	at com.carrotsearch.ant.tasks.junit4.JUnit4.executeSlave(JUnit4.java:1504)
   [junit4] 	at com.carrotsearch.ant.tasks.junit4.JUnit4.access$000(JUnit4.java:133)
   [junit4] 	at com.carrotsearch.ant.tasks.junit4.JUnit4$2.call(JUnit4.java:964)
   [junit4] 	at com.carrotsearch.ant.tasks.junit4.JUnit4$2.call(JUnit4.java:961)
   [junit4] 	at java.util.concurrent.FutureTask.run(FutureTask.java:262)
   [junit4] 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
   [junit4] 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
   [junit4] 	at java.lang.Thread.run(Thread.java:745)

BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/build.xml:733: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/build.xml:670: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/build.xml:59: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build.xml:230: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/common-build.xml:524: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/lucene/common-build.xml:1449: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/lucene/common-build.xml:1003: At least one slave process threw an exception, first: Quit event not received from the forked process? This may indicate JVM crash or runner bugs.

Total time: 347 minutes 14 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Sending artifact delta relative to Lucene-Solr-NightlyTests-5.x #911
ERROR: Failed to archive {README.txt=README.txt, solr/build/solr-core/test/temp/junit4-J1-20150801_082319_833.events=solr/build/solr-core/test/temp/junit4-J1-20150801_082319_833.events, solr/build/solr-core/test/temp/junit4-J0-20150801_082319_833.events=solr/build/solr-core/test/temp/junit4-J0-20150801_082319_833.events, solr/build/solr-core/test/temp/junit4-J2-20150801_082319_834.events=solr/build/solr-core/test/temp/junit4-J2-20150801_082319_834.events} due to internal error; falling back to full archiving
java.lang.NullPointerException
	at jsync.protocol.ChangeInputStream.read(ChangeInputStream.java:69)
	at com.cloudbees.jenkins.plugins.jsync.archiver.MD5DigestingInputStream.read(MD5DigestingInputStream.java:39)
	at com.google.common.io.LimitInputStream.read(LimitInputStream.java:79)
	at java.io.FilterInputStream.read(FilterInputStream.java:107)
	at com.google.common.io.ByteStreams.copy(ByteStreams.java:193)
	at jsync.protocol.FileSequenceReader.read(FileSequenceReader.java:35)
	at com.cloudbees.jenkins.plugins.jsync.archiver.JSyncArtifactManager.remoteSync(JSyncArtifactManager.java:145)
	at com.cloudbees.jenkins.plugins.jsync.archiver.JSyncArtifactManager.archive(JSyncArtifactManager.java:68)
	at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:140)
	at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
	at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:756)
	at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:720)
	at hudson.model.Build$BuildExecution.post2(Build.java:182)
	at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:669)
	at hudson.model.Run.execute(Run.java:1731)
	at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
	at hudson.model.ResourceController.execute(ResourceController.java:88)
	at hudson.model.Executor.run(Executor.java:232)
ERROR: Failed to archive artifacts: **/*.events,heapdumps/**,**/hs_err_pid*,README.txt
java.io.IOException: Failed to extract /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/transfer of 4 files
	at hudson.FilePath.readFromTar(FilePath.java:2101)
	at hudson.FilePath.copyRecursiveTo(FilePath.java:2013)
	at jenkins.model.StandardArtifactManager.archive(StandardArtifactManager.java:61)
	at com.cloudbees.jenkins.plugins.jsync.archiver.JSyncArtifactManager.archive(JSyncArtifactManager.java:72)
	at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:140)
	at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
	at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:756)
	at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:720)
	at hudson.model.Build$BuildExecution.post2(Build.java:182)
	at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:669)
	at hudson.model.Run.execute(Run.java:1731)
	at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
	at hudson.model.ResourceController.execute(ResourceController.java:88)
	at hudson.model.Executor.run(Executor.java:232)
Caused by: java.io.IOException: unexpected EOF with 1024 bytes unread
	at hudson.org.apache.tools.tar.TarInputStream.read(TarInputStream.java:349)
	at java.io.FilterInputStream.read(FilterInputStream.java:107)
	at org.apache.commons.io.IOUtils.copyLarge(IOUtils.java:1792)
	at org.apache.commons.io.IOUtils.copyLarge(IOUtils.java:1769)
	at org.apache.commons.io.IOUtils.copy(IOUtils.java:1744)
	at hudson.util.IOUtils.copy(IOUtils.java:40)
	at hudson.FilePath.readFromTar(FilePath.java:2091)
	... 13 more
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure



Mime
View raw message