You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2013/05/11 20:11:17 UTC

[JENKINS] Lucene-Solr-trunk-MacOSX (64bit/jdk1.7.0) - Build # 459 - Failure!

Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-MacOSX/459/
Java: 64bit/jdk1.7.0 -XX:-UseCompressedOops -XX:+UseG1GC

1 tests failed.
REGRESSION:  org.apache.solr.client.solrj.TestBatchUpdate.testWithBinary

Error Message:
IOException occured when talking to server at: https://127.0.0.1:52094/solr/collection1

Stack Trace:
org.apache.solr.client.solrj.SolrServerException: IOException occured when talking to server at: https://127.0.0.1:52094/solr/collection1
	at __randomizedtesting.SeedInfo.seed([B806D0A318EEA810:EA709EBC9F017203]:0)
	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:435)
	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:180)
	at org.apache.solr.client.solrj.request.AbstractUpdateRequest.process(AbstractUpdateRequest.java:117)
	at org.apache.solr.client.solrj.SolrServer.commit(SolrServer.java:168)
	at org.apache.solr.client.solrj.SolrServer.commit(SolrServer.java:146)
	at org.apache.solr.client.solrj.TestBatchUpdate.doIt(TestBatchUpdate.java:130)
	at org.apache.solr.client.solrj.TestBatchUpdate.testWithBinary(TestBatchUpdate.java:62)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:601)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
	at java.lang.Thread.run(Thread.java:722)
Caused by: org.apache.http.NoHttpResponseException: The target server failed to respond
	at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:95)
	at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:62)
	at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:254)
	at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:289)
	at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:252)
	at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:191)
	at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:300)
	at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:127)
	at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:717)
	at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:522)
	at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:906)
	at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:805)
	at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:784)
	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:365)
	... 46 more




Build Log:
[...truncated 10294 lines...]
[junit4:junit4] Suite: org.apache.solr.client.solrj.TestBatchUpdate
[junit4:junit4]   1> 329027 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.SolrJettyTestBase  ? Randomized ssl (true) and clientAuth (false)
[junit4:junit4]   1> 329028 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.SolrTestCaseJ4  ? ####initCore
[junit4:junit4]   1> 329030 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.SolrTestCaseJ4  ? ####initCore end
[junit4:junit4]   1> 329031 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.eclipse.jetty.server.Server  ? jetty-8.1.10.v20130312
[junit4:junit4]   1> 329043 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.eclipse.jetty.util.ssl.SslContextFactory  ? Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2]
[junit4:junit4]   1> 329054 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.eclipse.jetty.server.AbstractConnector  ? Started SslSelectChannelConnector@127.0.0.1:52094
[junit4:junit4]   1> 329059 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.servlet.SolrDispatchFilter  ? SolrDispatchFilter.init()
[junit4:junit4]   1> 329060 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.core.SolrResourceLoader  ? JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   1> 329061 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.core.SolrResourceLoader  ? using system property solr.solr.home: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/example/solr
[junit4:junit4]   1> 329061 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.core.CoreContainer  ? looking for solr config file: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/example/solr/solr.xml
[junit4:junit4]   1> 329062 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.core.CoreContainer  ? New CoreContainer 26099611
[junit4:junit4]   1> 329063 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.core.CoreContainer  ? Loading CoreContainer using Solr Home: '/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/example/solr/'
[junit4:junit4]   1> 329064 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.core.SolrResourceLoader  ? new SolrResourceLoader for directory: '/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/example/solr/'
[junit4:junit4]   1> 329274 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.core.SolrCoreDiscoverer  ? Looking for cores in /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/example/solr
[junit4:junit4]   1> 329277 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.core.SolrCoreDiscoverer  ? Looking for cores in /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/example/solr/.svn
[junit4:junit4]   1> 329281 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.core.SolrCoreDiscoverer  ? Looking for cores in /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/example/solr/.svn/prop-base
[junit4:junit4]   1> 329284 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.core.SolrCoreDiscoverer  ? Looking for cores in /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/example/solr/.svn/props
[junit4:junit4]   1> 329288 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.core.SolrCoreDiscoverer  ? Looking for cores in /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/example/solr/.svn/text-base
[junit4:junit4]   1> 329295 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.core.SolrCoreDiscoverer  ? Looking for cores in /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/example/solr/.svn/tmp
[junit4:junit4]   1> 329298 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.core.SolrCoreDiscoverer  ? Looking for cores in /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/example/solr/.svn/tmp/prop-base
[junit4:junit4]   1> 329301 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.core.SolrCoreDiscoverer  ? Looking for cores in /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/example/solr/.svn/tmp/props
[junit4:junit4]   1> 329305 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.core.SolrCoreDiscoverer  ? Looking for cores in /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/example/solr/.svn/tmp/text-base
[junit4:junit4]   1> 329308 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.core.SolrCoreDiscoverer  ? Discovered properties file /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/example/solr/collection1/core.properties, adding to cores
[junit4:junit4]   1> 329318 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.handler.component.HttpShardHandlerFactory  ? Setting socketTimeout to: 0
[junit4:junit4]   1> 329319 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.handler.component.HttpShardHandlerFactory  ? Setting urlScheme to: http://
[junit4:junit4]   1> 329320 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.handler.component.HttpShardHandlerFactory  ? Setting connTimeout to: 0
[junit4:junit4]   1> 329320 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.handler.component.HttpShardHandlerFactory  ? Setting maxConnectionsPerHost to: 20
[junit4:junit4]   1> 329321 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.handler.component.HttpShardHandlerFactory  ? Setting corePoolSize to: 0
[junit4:junit4]   1> 329321 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.handler.component.HttpShardHandlerFactory  ? Setting maximumPoolSize to: 2147483647
[junit4:junit4]   1> 329321 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.handler.component.HttpShardHandlerFactory  ? Setting maxThreadIdleTime to: 5
[junit4:junit4]   1> 329322 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.handler.component.HttpShardHandlerFactory  ? Setting sizeOfQueue to: -1
[junit4:junit4]   1> 329322 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.handler.component.HttpShardHandlerFactory  ? Setting fairnessPolicy to: false
[junit4:junit4]   1> 329323 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.client.solrj.impl.HttpClientUtil  ? Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   1> 329334 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.logging.LogWatcher  ? Registering Log Listener
[junit4:junit4]   1> 329341 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.CoreContainer  ? Creating SolrCore 'collection1' using instanceDir: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/example/solr/collection1
[junit4:junit4]   1> 329342 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.SolrResourceLoader  ? new SolrResourceLoader for directory: '/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/example/solr/collection1/'
[junit4:junit4]   1> 329388 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.SolrConfig  ? Adding specified lib dirs to ClassLoader
[junit4:junit4]   1> 329391 [coreLoadExecutor-305-thread-1] WARN  org.apache.solr.core.SolrResourceLoader  ? No files added to classloader from lib: ../../../contrib/extraction/lib (resolved as: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/example/solr/collection1/../../../contrib/extraction/lib).
[junit4:junit4]   1> 329393 [coreLoadExecutor-305-thread-1] WARN  org.apache.solr.core.SolrResourceLoader  ? Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/example/solr/collection1/../../../dist).
[junit4:junit4]   1> 329394 [coreLoadExecutor-305-thread-1] WARN  org.apache.solr.core.SolrResourceLoader  ? No files added to classloader from lib: ../../../contrib/clustering/lib/ (resolved as: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/example/solr/collection1/../../../contrib/clustering/lib).
[junit4:junit4]   1> 329394 [coreLoadExecutor-305-thread-1] WARN  org.apache.solr.core.SolrResourceLoader  ? Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/example/solr/collection1/../../../dist).
[junit4:junit4]   1> 329400 [coreLoadExecutor-305-thread-1] WARN  org.apache.solr.core.SolrResourceLoader  ? No files added to classloader from lib: ../../../contrib/langid/lib/ (resolved as: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/example/solr/collection1/../../../contrib/langid/lib).
[junit4:junit4]   1> 329401 [coreLoadExecutor-305-thread-1] WARN  org.apache.solr.core.SolrResourceLoader  ? Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/example/solr/collection1/../../../dist).
[junit4:junit4]   1> 329402 [coreLoadExecutor-305-thread-1] WARN  org.apache.solr.core.SolrResourceLoader  ? No files added to classloader from lib: ../../../contrib/velocity/lib (resolved as: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/example/solr/collection1/../../../contrib/velocity/lib).
[junit4:junit4]   1> 329403 [coreLoadExecutor-305-thread-1] WARN  org.apache.solr.core.SolrResourceLoader  ? Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/example/solr/collection1/../../../dist).
[junit4:junit4]   1> 329403 [coreLoadExecutor-305-thread-1] WARN  org.apache.solr.core.SolrResourceLoader  ? Can't find (or read) directory to add to classloader: /non/existent/dir/yields/warning (resolved as: /non/existent/dir/yields/warning).
[junit4:junit4]   1> 329484 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.SolrConfig  ? Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   1> 329713 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.Config  ? Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   1> 329716 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.schema.IndexSchema  ? Reading Solr Schema from schema.xml
[junit4:junit4]   1> 329748 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.schema.IndexSchema  ? [collection1] Schema name=example
[junit4:junit4]   1> 332054 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.schema.IndexSchema  ? unique key field: id
[junit4:junit4]   1> 332087 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.schema.FileExchangeRateProvider  ? Reloading exchange rates from file currency.xml
[junit4:junit4]   1> 332103 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.schema.FileExchangeRateProvider  ? Reloading exchange rates from file currency.xml
[junit4:junit4]   1> 332157 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.SolrCore  ? org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   1> 332158 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.SolrCore  ? [collection1] Opening new SolrCore at /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/example/solr/collection1/, dataDir=/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-solrj/test/J0/solrtest-TestBatchUpdate-1368295586275/
[junit4:junit4]   1> 332159 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.JmxMonitoredMap  ? JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@23627751
[junit4:junit4]   1> 332160 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.SolrCore  ? [collection1] Added SolrEventListener for newSearcher: org.apache.solr.core.QuerySenderListener{queries=[]}
[junit4:junit4]   1> 332160 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.SolrCore  ? [collection1] Added SolrEventListener for firstSearcher: org.apache.solr.core.QuerySenderListener{queries=[{q=static firstSearcher warming in solrconfig.xml}]}
[junit4:junit4]   1> 332161 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.SolrCore  ? org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   1> 332162 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.CachingDirectoryFactory  ? return new directory for /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-solrj/test/J0/solrtest-TestBatchUpdate-1368295586275
[junit4:junit4]   1> 332163 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.SolrCore  ? New index directory detected: old=null new=/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-solrj/test/J0/solrtest-TestBatchUpdate-1368295586275/index/
[junit4:junit4]   1> 332163 [coreLoadExecutor-305-thread-1] WARN  org.apache.solr.core.SolrCore  ? [collection1] Solr index directory '/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-solrj/test/J0/solrtest-TestBatchUpdate-1368295586275/index' doesn't exist. Creating new index...
[junit4:junit4]   1> 332164 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.CachingDirectoryFactory  ? return new directory for /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-solrj/test/J0/solrtest-TestBatchUpdate-1368295586275/index
[junit4:junit4]   1> 332169 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.SolrCore  ? SolrDeletionPolicy.onCommit: commits: num=1
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@4202c80e lockFactory=org.apache.lucene.store.NativeFSLockFactory@46a7cb06),segFN=segments_1,generation=1}
[junit4:junit4]   1> 332169 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.SolrCore  ? newest commit generation = 1
[junit4:junit4]   1> 332171 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.SolrCore  ? created json: solr.JSONResponseWriter
[junit4:junit4]   1> 332172 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.SolrCore  ? adding lazy queryResponseWriter: solr.VelocityResponseWriter
[junit4:junit4]   1> 332172 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.SolrCore  ? created velocity: solr.VelocityResponseWriter
[junit4:junit4]   1> 332173 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.SolrCore  ? created xslt: solr.XSLTResponseWriter
[junit4:junit4]   1> 332174 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.response.XSLTResponseWriter  ? xsltCacheLifetimeSeconds=5
[junit4:junit4]   1> 332180 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.RequestHandlers  ? created /select: solr.SearchHandler
[junit4:junit4]   1> 332181 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.RequestHandlers  ? created /query: solr.SearchHandler
[junit4:junit4]   1> 332182 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.RequestHandlers  ? created /get: solr.RealTimeGetHandler
[junit4:junit4]   1> 332183 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.RequestHandlers  ? created /browse: solr.SearchHandler
[junit4:junit4]   1> 332185 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.RequestHandlers  ? created /update: solr.UpdateRequestHandler
[junit4:junit4]   1> 332186 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.RequestHandlers  ? created /update/json: solr.JsonUpdateRequestHandler
[junit4:junit4]   1> 332188 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.RequestHandlers  ? created /update/csv: solr.CSVRequestHandler
[junit4:junit4]   1> 332188 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.RequestHandlers  ? adding lazy requestHandler: solr.extraction.ExtractingRequestHandler
[junit4:junit4]   1> 332189 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.RequestHandlers  ? created /update/extract: solr.extraction.ExtractingRequestHandler
[junit4:junit4]   1> 332189 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.RequestHandlers  ? adding lazy requestHandler: solr.FieldAnalysisRequestHandler
[junit4:junit4]   1> 332190 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.RequestHandlers  ? created /analysis/field: solr.FieldAnalysisRequestHandler
[junit4:junit4]   1> 332191 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.RequestHandlers  ? adding lazy requestHandler: solr.DocumentAnalysisRequestHandler
[junit4:junit4]   1> 332192 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.RequestHandlers  ? created /analysis/document: solr.DocumentAnalysisRequestHandler
[junit4:junit4]   1> 332193 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.RequestHandlers  ? created /admin/: solr.admin.AdminHandlers
[junit4:junit4]   1> 332195 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.RequestHandlers  ? created /admin/ping: solr.PingRequestHandler
[junit4:junit4]   1> 332197 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.RequestHandlers  ? created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   1> 332199 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.RequestHandlers  ? created /replication: solr.ReplicationHandler
[junit4:junit4]   1> 332199 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.RequestHandlers  ? adding lazy requestHandler: solr.SearchHandler
[junit4:junit4]   1> 332200 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.RequestHandlers  ? created /spell: solr.SearchHandler
[junit4:junit4]   1> 332201 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.RequestHandlers  ? adding lazy requestHandler: solr.SearchHandler
[junit4:junit4]   1> 332202 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.RequestHandlers  ? created /tvrh: solr.SearchHandler
[junit4:junit4]   1> 332203 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.RequestHandlers  ? adding lazy requestHandler: solr.SearchHandler
[junit4:junit4]   1> 332203 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.RequestHandlers  ? created /terms: solr.SearchHandler
[junit4:junit4]   1> 332205 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.RequestHandlers  ? adding lazy requestHandler: solr.SearchHandler
[junit4:junit4]   1> 332205 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.RequestHandlers  ? created /elevate: solr.SearchHandler
[junit4:junit4]   1> 332231 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.handler.loader.XMLLoader  ? xsltCacheLifetimeSeconds=60
[junit4:junit4]   1> 332235 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.handler.loader.XMLLoader  ? xsltCacheLifetimeSeconds=60
[junit4:junit4]   1> 332239 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.handler.loader.XMLLoader  ? xsltCacheLifetimeSeconds=60
[junit4:junit4]   1> 332253 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.search.SolrIndexSearcher  ? Opening Searcher@35844fae main
[junit4:junit4]   1> 332255 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.update.UpdateHandler  ? Clearing tlog files, tlogDir=/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-solrj/test/J0/solrtest-TestBatchUpdate-1368295586275/tlog
[junit4:junit4]   1> 332257 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.SolrCore  ? Hard AutoCommit: if uncommited for 15000ms; 
[junit4:junit4]   1> 332258 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.SolrCore  ? Soft AutoCommit: disabled
[junit4:junit4]   1> 332259 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.handler.component.SpellCheckComponent  ? Initializing spell checkers
[junit4:junit4]   1> 332259 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.spelling.DirectSolrSpellChecker  ? init: {name=default,field=text,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4,maxQueryFrequency=0.01}
[junit4:junit4]   1> 332260 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.handler.component.SpellCheckComponent  ? No queryConverter defined, using default converter
[junit4:junit4]   1> 332262 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.handler.component.QueryElevationComponent  ? Loading QueryElevation from: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/example/solr/collection1/conf/elevate.xml
[junit4:junit4]   1> 332308 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.handler.ReplicationHandler  ? Commits will be reserved for  10000
[junit4:junit4]   1> 332309 [searcherExecutor-306-thread-1] INFO  org.apache.solr.core.SolrCore  ? QuerySenderListener sending requests to Searcher@35844fae main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   1> 332318 [searcherExecutor-306-thread-1] INFO  org.apache.solr.core.SolrCore  ? [collection1] webapp=null path=null params={event=firstSearcher&q=static+firstSearcher+warming+in+solrconfig.xml&distrib=false} hits=0 status=0 QTime=2 
[junit4:junit4]   1> 332318 [searcherExecutor-306-thread-1] INFO  org.apache.solr.core.SolrCore  ? QuerySenderListener done.
[junit4:junit4]   1> 332319 [searcherExecutor-306-thread-1] INFO  org.apache.solr.handler.component.SpellCheckComponent  ? Loading spell index for spellchecker: default
[junit4:junit4]   1> 332320 [searcherExecutor-306-thread-1] INFO  org.apache.solr.handler.component.SpellCheckComponent  ? Loading spell index for spellchecker: wordbreak
[junit4:junit4]   1> 332322 [searcherExecutor-306-thread-1] INFO  org.apache.solr.core.SolrCore  ? [collection1] Registered new searcher Searcher@35844fae main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   1> 332325 [coreLoadExecutor-305-thread-1] INFO  org.apache.solr.core.CoreContainer  ? registering core: collection1
[junit4:junit4]   1> 332327 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.servlet.SolrDispatchFilter  ? user.dir=/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-solrj/test/J0
[junit4:junit4]   1> 332327 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.servlet.SolrDispatchFilter  ? SolrDispatchFilter.init() done
[junit4:junit4]   1> 332328 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.SolrJettyTestBase  ? Jetty Assigned Port#52094
[junit4:junit4]   2> Creating dataDir: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-solrj/test/J0/./solrtest-TestBatchUpdate-1368295586275
[junit4:junit4]   1> 332339 [TEST-TestBatchUpdate.testWithBinaryBean-seed#[B806D0A318EEA810]] INFO  org.apache.solr.SolrTestCaseJ4  ? ###Starting testWithBinaryBean
[junit4:junit4]   1> 332339 [TEST-TestBatchUpdate.testWithBinaryBean-seed#[B806D0A318EEA810]] INFO  org.apache.solr.client.solrj.impl.HttpClientUtil  ? Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   1> 332429 [qtp28033893-559] INFO  org.apache.solr.core.SolrCore  ? SolrDeletionPolicy.onInit: commits: num=1
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@4202c80e lockFactory=org.apache.lucene.store.NativeFSLockFactory@46a7cb06),segFN=segments_1,generation=1}
[junit4:junit4]   1> 332431 [qtp28033893-559] INFO  org.apache.solr.core.SolrCore  ? newest commit generation = 1
[junit4:junit4]   1> 332435 [qtp28033893-559] INFO  org.apache.solr.search.SolrIndexSearcher  ? Opening Searcher@1da890 realtime
[junit4:junit4]   1> 332436 [qtp28033893-559] INFO  org.apache.solr.update.processor.LogUpdateProcessor  ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1434761916231712768)} 0 14
[junit4:junit4]   1> 334068 [qtp28033893-560] INFO  org.apache.solr.update.processor.LogUpdateProcessor  ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1 (1434761916322938880), 2 (1434761916326084608), 3 (1434761916327133184), 4 (1434761916333424640), 5 (1434761916334473216), 6 (1434761916335521792), 7 (1434761916336570368), 8 (1434761916337618944), 9 (1434761916337618945), 10 (1434761916349153280), ... (1000 adds)]} 0 1559
[junit4:junit4]   1> 334076 [qtp28033893-564] INFO  org.apache.solr.update.UpdateHandler  ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 334164 [qtp28033893-564] INFO  org.apache.solr.core.SolrCore  ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@4202c80e lockFactory=org.apache.lucene.store.NativeFSLockFactory@46a7cb06),segFN=segments_1,generation=1}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@4202c80e lockFactory=org.apache.lucene.store.NativeFSLockFactory@46a7cb06),segFN=segments_2,generation=2}
[junit4:junit4]   1> 334165 [qtp28033893-564] INFO  org.apache.solr.core.SolrCore  ? newest commit generation = 2
[junit4:junit4]   1> 334168 [qtp28033893-564] INFO  org.apache.solr.search.SolrIndexSearcher  ? Opening Searcher@6ab943b8 main
[junit4:junit4]   1> 334169 [searcherExecutor-306-thread-1] INFO  org.apache.solr.core.SolrCore  ? QuerySenderListener sending requests to Searcher@6ab943b8 main{StandardDirectoryReader(segments_2:3:nrt _0(5.0):C1000)}
[junit4:junit4]   1> 334179 [searcherExecutor-306-thread-1] INFO  org.apache.solr.core.SolrCore  ? QuerySenderListener done.
[junit4:junit4]   1> 334182 [searcherExecutor-306-thread-1] INFO  org.apache.solr.core.SolrCore  ? [collection1] Registered new searcher Searcher@6ab943b8 main{StandardDirectoryReader(segments_2:3:nrt _0(5.0):C1000)}
[junit4:junit4]   1> 334175 [qtp28033893-564] INFO  org.apache.solr.update.UpdateHandler  ? end_commit_flush
[junit4:junit4]   1> 334194 [qtp28033893-564] INFO  org.apache.solr.update.processor.LogUpdateProcessor  ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 118
[junit4:junit4]   1> 334229 [qtp28033893-561] INFO  org.apache.solr.core.SolrCore  ? [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=1000 status=0 QTime=1 
[junit4:junit4]   1> 334247 [TEST-TestBatchUpdate.testWithBinaryBean-seed#[B806D0A318EEA810]] INFO  org.apache.solr.SolrTestCaseJ4  ? ###Ending testWithBinaryBean
[junit4:junit4]   1> 334370 [TEST-TestBatchUpdate.testWithXml-seed#[B806D0A318EEA810]] INFO  org.apache.solr.SolrTestCaseJ4  ? ###Starting testWithXml
[junit4:junit4]   1> 334417 [qtp28033893-562] INFO  org.apache.solr.search.SolrIndexSearcher  ? Opening Searcher@304be746 realtime
[junit4:junit4]   1> 334418 [qtp28033893-562] INFO  org.apache.solr.update.processor.LogUpdateProcessor  ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1434761918291116032)} 0 33
[junit4:junit4]   1> 335508 [qtp28033893-563] INFO  org.apache.solr.update.processor.LogUpdateProcessor  ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1 (1434761918389682176), 2 (1434761918392827904), 3 (1434761918393876480), 4 (1434761918397022208), 5 (1434761918404362240), 6 (1434761918409605120), 7 (1434761918410653696), 8 (1434761918411702272), 9 (1434761918411702273), 10 (1434761918412750848), ... (1000 adds)]} 0 1028
[junit4:junit4]   1> 335516 [qtp28033893-559] INFO  org.apache.solr.update.UpdateHandler  ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 335595 [qtp28033893-559] INFO  org.apache.solr.core.SolrCore  ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@4202c80e lockFactory=org.apache.lucene.store.NativeFSLockFactory@46a7cb06),segFN=segments_2,generation=2}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@4202c80e lockFactory=org.apache.lucene.store.NativeFSLockFactory@46a7cb06),segFN=segments_3,generation=3}
[junit4:junit4]   1> 335598 [qtp28033893-559] INFO  org.apache.solr.core.SolrCore  ? newest commit generation = 3
[junit4:junit4]   1> 335602 [qtp28033893-559] INFO  org.apache.solr.search.SolrIndexSearcher  ? Opening Searcher@399f3146 main
[junit4:junit4]   1> 335605 [qtp28033893-559] INFO  org.apache.solr.update.UpdateHandler  ? end_commit_flush
[junit4:junit4]   1> 335607 [searcherExecutor-306-thread-1] INFO  org.apache.solr.core.SolrCore  ? QuerySenderListener sending requests to Searcher@399f3146 main{StandardDirectoryReader(segments_3:7:nrt _1(5.0):C1000)}
[junit4:junit4]   1> 335608 [searcherExecutor-306-thread-1] INFO  org.apache.solr.core.SolrCore  ? QuerySenderListener done.
[junit4:junit4]   1> 335613 [searcherExecutor-306-thread-1] INFO  org.apache.solr.core.SolrCore  ? [collection1] Registered new searcher Searcher@399f3146 main{StandardDirectoryReader(segments_3:7:nrt _1(5.0):C1000)}
[junit4:junit4]   1> 335672 [qtp28033893-559] INFO  org.apache.solr.update.processor.LogUpdateProcessor  ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 157
[junit4:junit4]   1> 335679 [qtp28033893-562] INFO  org.apache.solr.core.SolrCore  ? [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=1000 status=0 QTime=1 
[junit4:junit4]   1> 335690 [TEST-TestBatchUpdate.testWithXml-seed#[B806D0A318EEA810]] INFO  org.apache.solr.SolrTestCaseJ4  ? ###Ending testWithXml
[junit4:junit4]   1> 335706 [TEST-TestBatchUpdate.testWithBinary-seed#[B806D0A318EEA810]] INFO  org.apache.solr.SolrTestCaseJ4  ? ###Starting testWithBinary
[junit4:junit4]   1> 335740 [qtp28033893-560] INFO  org.apache.solr.search.SolrIndexSearcher  ? Opening Searcher@14506a0c realtime
[junit4:junit4]   1> 335741 [qtp28033893-560] INFO  org.apache.solr.update.processor.LogUpdateProcessor  ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1434761919681527808)} 0 29
[junit4:junit4]   1> 336747 [qtp28033893-564] INFO  org.apache.solr.update.processor.LogUpdateProcessor  ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1 (1434761919752830976), 2 (1434761919754928128), 3 (1434761919754928129), 4 (1434761919755976704), 5 (1434761919755976705), 6 (1434761919757025280), 7 (1434761919757025281), 8 (1434761919757025282), 9 (1434761919758073856), 10 (1434761919758073857), ... (1000 adds)]} 0 969
[junit4:junit4]   1> 350742 [commitScheduler-308-thread-1] INFO  org.apache.solr.update.UpdateHandler  ? start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 350779 [commitScheduler-308-thread-1] INFO  org.apache.solr.core.SolrCore  ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@4202c80e lockFactory=org.apache.lucene.store.NativeFSLockFactory@46a7cb06),segFN=segments_3,generation=3}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@4202c80e lockFactory=org.apache.lucene.store.NativeFSLockFactory@46a7cb06),segFN=segments_4,generation=4}
[junit4:junit4]   1> 350781 [commitScheduler-308-thread-1] INFO  org.apache.solr.core.SolrCore  ? newest commit generation = 4
[junit4:junit4]   1> 350784 [commitScheduler-308-thread-1] INFO  org.apache.solr.search.SolrIndexSearcher  ? Opening Searcher@789ca9b3 realtime
[junit4:junit4]   1> 350792 [commitScheduler-308-thread-1] INFO  org.apache.solr.update.UpdateHandler  ? end_commit_flush
[junit4:junit4]   1> 536841 [qtp28033893-560] INFO  org.apache.solr.update.UpdateHandler  ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 536843 [TEST-TestBatchUpdate.testWithBinary-seed#[B806D0A318EEA810]] INFO  org.apache.solr.SolrTestCaseJ4  ? ###Ending testWithBinary
[junit4:junit4]   1> 536844 [qtp28033893-560] INFO  org.apache.solr.core.SolrCore  ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@4202c80e lockFactory=org.apache.lucene.store.NativeFSLockFactory@46a7cb06),segFN=segments_4,generation=4}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@4202c80e lockFactory=org.apache.lucene.store.NativeFSLockFactory@46a7cb06),segFN=segments_5,generation=5}
[junit4:junit4]   1> 536860 [qtp28033893-560] INFO  org.apache.solr.core.SolrCore  ? newest commit generation = 5
[junit4:junit4]   1> 536861 [qtp28033893-560] INFO  org.apache.solr.search.SolrIndexSearcher  ? Opening Searcher@286a4df5 main
[junit4:junit4]   1> 536863 [qtp28033893-560] INFO  org.apache.solr.update.UpdateHandler  ? end_commit_flush
[junit4:junit4]   1> 536864 [searcherExecutor-306-thread-1] INFO  org.apache.solr.core.SolrCore  ? QuerySenderListener sending requests to Searcher@286a4df5 main{StandardDirectoryReader(segments_4:11:nrt _2(5.0):C1000)}
[junit4:junit4]   1> 536864 [searcherExecutor-306-thread-1] INFO  org.apache.solr.core.SolrCore  ? QuerySenderListener done.
[junit4:junit4]   1> 536866 [searcherExecutor-306-thread-1] INFO  org.apache.solr.core.SolrCore  ? [collection1] Registered new searcher Searcher@286a4df5 main{StandardDirectoryReader(segments_4:11:nrt _2(5.0):C1000)}
[junit4:junit4]   1> 536868 [qtp28033893-560] INFO  org.apache.solr.update.processor.LogUpdateProcessor  ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 27
[junit4:junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestBatchUpdate -Dtests.method=testWithBinary -Dtests.seed=B806D0A318EEA810 -Dtests.slow=true -Dtests.locale=ro_RO -Dtests.timezone=Europe/Sofia -Dtests.file.encoding=US-ASCII
[junit4:junit4] ERROR    201s | TestBatchUpdate.testWithBinary <<<
[junit4:junit4]    > Throwable #1: org.apache.solr.client.solrj.SolrServerException: IOException occured when talking to server at: https://127.0.0.1:52094/solr/collection1
[junit4:junit4]    > 	at __randomizedtesting.SeedInfo.seed([B806D0A318EEA810:EA709EBC9F017203]:0)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:435)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:180)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.request.AbstractUpdateRequest.process(AbstractUpdateRequest.java:117)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.SolrServer.commit(SolrServer.java:168)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.SolrServer.commit(SolrServer.java:146)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.TestBatchUpdate.doIt(TestBatchUpdate.java:130)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.TestBatchUpdate.testWithBinary(TestBatchUpdate.java:62)
[junit4:junit4]    > 	at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]    > Caused by: org.apache.http.NoHttpResponseException: The target server failed to respond
[junit4:junit4]    > 	at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:95)
[junit4:junit4]    > 	at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:62)
[junit4:junit4]    > 	at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:254)
[junit4:junit4]    > 	at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:289)
[junit4:junit4]    > 	at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:252)
[junit4:junit4]    > 	at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:191)
[junit4:junit4]    > 	at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:300)
[junit4:junit4]    > 	at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:127)
[junit4:junit4]    > 	at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:717)
[junit4:junit4]    > 	at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:522)
[junit4:junit4]    > 	at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:906)
[junit4:junit4]    > 	at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:805)
[junit4:junit4]    > 	at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:784)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:365)
[junit4:junit4]    > 	... 46 more
[junit4:junit4]   1> 537090 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.core.CoreContainer  ? Shutting down CoreContainer instance=26099611
[junit4:junit4]   1> 537092 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.core.SolrCore  ? [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@73ac331b
[junit4:junit4]   1> 537121 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.update.UpdateHandler  ? closing DirectUpdateHandler2{commits=4,autocommit maxTime=15000ms,autocommits=1,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=3000,cumulative_deletesById=0,cumulative_deletesByQuery=3,cumulative_errors=0}
[junit4:junit4]   1> 537123 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.update.SolrCoreState  ? Closing SolrCoreState
[junit4:junit4]   1> 537124 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.update.DefaultSolrCoreState  ? SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   1> 537124 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.update.DefaultSolrCoreState  ? closing IndexWriter with IndexWriterCloser
[junit4:junit4]   1> 537130 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.core.SolrCore  ? [collection1] Closing main searcher on request.
[junit4:junit4]   1> 537131 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.core.CachingDirectoryFactory  ? Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4:junit4]   1> 537132 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.core.CachingDirectoryFactory  ? looking to close /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-solrj/test/J0/solrtest-TestBatchUpdate-1368295586275/index [CachedDir<<refCount=0;path=/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-solrj/test/J0/solrtest-TestBatchUpdate-1368295586275/index;done=false>>]
[junit4:junit4]   1> 537132 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.core.CachingDirectoryFactory  ? Closing directory: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-solrj/test/J0/solrtest-TestBatchUpdate-1368295586275/index
[junit4:junit4]   1> 537134 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.core.CachingDirectoryFactory  ? looking to close /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-solrj/test/J0/solrtest-TestBatchUpdate-1368295586275 [CachedDir<<refCount=0;path=/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-solrj/test/J0/solrtest-TestBatchUpdate-1368295586275;done=false>>]
[junit4:junit4]   1> 537135 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.core.CachingDirectoryFactory  ? Closing directory: /Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-solrj/test/J0/solrtest-TestBatchUpdate-1368295586275
[junit4:junit4]   1> 537136 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.eclipse.jetty.server.handler.ContextHandler  ? stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4]   1> 537190 [SUITE-TestBatchUpdate-seed#[B806D0A318EEA810]-worker] INFO  org.apache.solr.SolrTestCaseJ4  ? ###deleteCore
[junit4:junit4]   2> NOTE: test params are: codec=Lucene42: {}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=false,coord=no): {}, locale=ro_RO, timezone=Europe/Sofia
[junit4:junit4]   2> NOTE: Mac OS X 10.8.3 x86_64/Oracle Corporation 1.7.0_21 (64-bit)/cpus=2,threads=1,free=183512328,total=255852544
[junit4:junit4]   2> NOTE: All tests run in this JVM: [ContentStreamTest, TestNamedListCodec, SolrExampleJettyTest, TestLBHttpSolrServer, TestDocumentObjectBinder, LargeVolumeBinaryJettyTest, ClientUtilsTest, SolrParamTest, SolrExampleStreamingBinaryTest, TestCoreAdmin, MultiCoreExampleJettyTest, FieldAnalysisResponseTest, TermsResponseTest, MultiCoreEmbeddedTest, SolrQueryTest, LargeVolumeJettyTest, SolrExampleStreamingTest, SolrExampleXMLTest, LargeVolumeEmbeddedTest, NamedListTest, BasicHttpSolrServerTest, TestEmbeddedSolrServer, CloudSolrServerTest, SolrExampleBinaryTest, SolrExampleEmbeddedTest, TestBatchUpdate]
[junit4:junit4] Completed in 208.21s, 3 tests, 1 error <<< FAILURES!

[...truncated 63 lines...]
BUILD FAILED
/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/build.xml:377: The following error occurred while executing this line:
/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/build.xml:357: The following error occurred while executing this line:
/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/build.xml:39: The following error occurred while executing this line:
/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/build.xml:194: The following error occurred while executing this line:
/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/solr/common-build.xml:437: The following error occurred while executing this line:
/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:1240: The following error occurred while executing this line:
/Users/jenkins/jenkins-slave/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:884: There were test failures: 45 suites, 268 tests, 1 error

Total time: 140 minutes 53 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 64bit/jdk1.7.0 -XX:-UseCompressedOops -XX:+UseG1GC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure