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 2015/04/07 09:58:04 UTC
[JENKINS] Lucene-Solr-5.x-Linux (32bit/jdk1.8.0_60-ea-b06) - Build
# 12058 - Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Linux/12058/
Java: 32bit/jdk1.8.0_60-ea-b06 -server -XX:+UseConcMarkSweepGC
1 tests failed.
FAILED: org.apache.solr.DistributedIntervalFacetingTest.test
Error Message:
Timeout occured while waiting response from server at: https://127.0.0.1:58921//collection1
Stack Trace:
org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: https://127.0.0.1:58921//collection1
at __randomizedtesting.SeedInfo.seed([29E3B8E95C13BC65:A1B78733F2EFD19D]:0)
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:568)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:233)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:225)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:135)
at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:174)
at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:139)
at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:153)
at org.apache.solr.BaseDistributedSearchTestCase.indexDoc(BaseDistributedSearchTestCase.java:484)
at org.apache.solr.BaseDistributedSearchTestCase.indexr(BaseDistributedSearchTestCase.java:466)
at org.apache.solr.DistributedIntervalFacetingTest.testRandom(DistributedIntervalFacetingTest.java:145)
at org.apache.solr.DistributedIntervalFacetingTest.test(DistributedIntervalFacetingTest.java:45)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:497)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:982)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:935)
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.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
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:365)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792)
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 com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
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 com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
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:365)
at java.lang.Thread.run(Thread.java:745)
Caused by: java.net.SocketTimeoutException: Read timed out
at java.net.SocketInputStream.socketRead0(Native Method)
at java.net.SocketInputStream.socketRead(SocketInputStream.java:116)
at java.net.SocketInputStream.read(SocketInputStream.java:170)
at java.net.SocketInputStream.read(SocketInputStream.java:141)
at sun.security.ssl.InputRecord.readFully(InputRecord.java:465)
at sun.security.ssl.InputRecord.read(InputRecord.java:503)
at sun.security.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:961)
at sun.security.ssl.SSLSocketImpl.readDataRecord(SSLSocketImpl.java:918)
at sun.security.ssl.AppInputStream.read(AppInputStream.java:105)
at org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160)
at org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84)
at org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273)
at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140)
at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261)
at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283)
at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251)
at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197)
at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272)
at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124)
at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685)
at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487)
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.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107)
at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:462)
... 51 more
Build Log:
[...truncated 10638 lines...]
[junit4] Suite: org.apache.solr.DistributedIntervalFacetingTest
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/init-core-data-001
[junit4] 2> 820625 T4705 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (true) and clientAuth (false)
[junit4] 2> 820626 T4705 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /
[junit4] 2> 820706 T4705 oas.SolrTestCaseJ4.writeCoreProperties Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/control/cores/collection1
[junit4] 2> 820707 T4705 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 820739 T4705 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2]
[junit4] 2> 820742 T4705 oejs.AbstractConnector.doStart Started SslSelectChannelConnector@127.0.0.1:58921
[junit4] 2> 820742 T4705 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {schema=schema-distrib-interval-faceting.xml, solrconfig=solrconfig-basic.xml, hostContext=/, hostPort=58921, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/control/cores}
[junit4] 2> 820744 T4705 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@e2f2a
[junit4] 2> 820744 T4705 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/control/'
[junit4] 2> 820760 T4705 oasc.SolrXmlConfig.fromFile Loading container configuration from /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/control/solr.xml
[junit4] 2> 820773 T4705 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/control/cores
[junit4] 2> 820774 T4705 oasc.CoreContainer.<init> New CoreContainer 20704140
[junit4] 2> 820774 T4705 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/control/]
[junit4] 2> 820775 T4705 oasc.CoreContainer.load loading shared library: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/control/lib
[junit4] 2> 820775 T4705 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: lib (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/control/lib).
[junit4] 2> 820783 T4705 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 820784 T4705 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: https
[junit4] 2> 820784 T4705 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 820784 T4705 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 820785 T4705 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000
[junit4] 2> 820785 T4705 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 820786 T4705 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 820786 T4705 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 820786 T4705 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 820787 T4705 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 820787 T4705 oashc.HttpShardHandlerFactory.getParameter Setting useRetries to: false
[junit4] 2> 820789 T4705 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 820791 T4705 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 820791 T4705 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 820792 T4705 oasc.CoreContainer.load Node Name: 127.0.0.1
[junit4] 2> 820793 T4705 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/control/cores
[junit4] 2> 820793 T4705 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {name=collection1, config=solrconfig-basic.xml, transient=false, schema=schema-distrib-interval-faceting.xml, loadOnStartup=true, instanceDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/control/cores/collection1, absoluteInstDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/control/cores/collection1/, configSet=collection1, dataDir=data/}
[junit4] 2> 820793 T4705 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/control/cores/collection1/
[junit4] 2> 820794 T4705 oasc.CorePropertiesLocator.discover Found 1 core definitions
[junit4] 2> 820794 T4715 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 820795 T4715 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 820795 T4715 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 820810 T4715 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
[junit4] 2> 820815 T4715 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0
[junit4] 2> 820840 T4715 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
[junit4] 2> 820841 T4715 oass.IndexSchema.readSchema Reading Solr Schema from /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema-distrib-interval-faceting.xml
[junit4] 2> 820844 T4715 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 820862 T4715 oass.IndexSchema.readSchema default search field in schema is id
[junit4] 2> 820862 T4715 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 820863 T4715 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from configset /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1
[junit4] 2> 820863 T4715 c:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 820863 T4715 c:collection1 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/, dataDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/control/cores/collection1/data/
[junit4] 2> 820863 T4715 c:collection1 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 820864 T4715 c:collection1 oasc.CachingDirectoryFactory.get return new directory for /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/control/cores/collection1/data
[junit4] 2> 820864 T4715 c:collection1 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/control/cores/collection1/data/index/
[junit4] 2> 820864 T4715 c:collection1 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/control/cores/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 820865 T4715 c:collection1 oasc.CachingDirectoryFactory.get return new directory for /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/control/cores/collection1/data/index
[junit4] 2> 820865 T4715 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=44, maxMergeAtOnceExplicit=10, maxMergedSegmentMB=2.7197265625, floorSegmentMB=1.28125, forceMergeDeletesPctAllowed=29.314348376076637, segmentsPerTier=19.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6171905057941136
[junit4] 2> 820866 T4715 c:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@140bd8c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@11cc659),segFN=segments_1,generation=1}
[junit4] 2> 820866 T4715 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 820867 T4715 c:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 820870 T4715 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 820871 T4715 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 820871 T4715 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 820872 T4715 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 820875 T4715 c:collection1 oasc.RequestHandlers.initHandlersFromConfig Registered paths: /admin/mbeans,standard,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
[junit4] 2> 820876 T4715 c:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 820877 T4715 c:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 820877 T4715 c:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 820877 T4715 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=33, maxMergeAtOnceExplicit=37, maxMergedSegmentMB=46.7578125, floorSegmentMB=1.314453125, forceMergeDeletesPctAllowed=26.90135216644676, segmentsPerTier=31.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.3083023775425378
[junit4] 2> 820878 T4715 c:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@140bd8c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@11cc659),segFN=segments_1,generation=1}
[junit4] 2> 820878 T4715 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 820878 T4715 c:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@1c1478b[collection1] main
[junit4] 2> 820879 T4715 c:collection1 oasr.ManagedResourceStorage.newStorageIO WARN Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 820879 T4715 c:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {}
[junit4] 2> 820879 T4715 c:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 820879 T4715 c:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 820879 T4715 c:collection1 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 820880 T4716 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1c1478b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 820880 T4715 c:collection1 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 820893 T4705 oass.SolrDispatchFilter.init user.dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0
[junit4] 2> 820894 T4705 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 820975 T4705 oas.SolrTestCaseJ4.writeCoreProperties Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/shard0/cores/collection1
[junit4] 2> 820976 T4705 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 820985 T4705 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2]
[junit4] 2> 820992 T4705 oejs.AbstractConnector.doStart Started SslSelectChannelConnector@127.0.0.1:56592
[junit4] 2> 820993 T4705 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {schema=schema-distrib-interval-faceting.xml, solrconfig=solrconfig-basic.xml, hostContext=/, hostPort=56592, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/shard0/cores}
[junit4] 2> 820994 T4705 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@e2f2a
[junit4] 2> 820994 T4705 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/shard0/'
[junit4] 2> 821005 T4705 oasc.SolrXmlConfig.fromFile Loading container configuration from /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/shard0/solr.xml
[junit4] 2> 821009 T4705 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/shard0/cores
[junit4] 2> 821010 T4705 oasc.CoreContainer.<init> New CoreContainer 12484276
[junit4] 2> 821010 T4705 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/shard0/]
[junit4] 2> 821010 T4705 oasc.CoreContainer.load loading shared library: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/shard0/lib
[junit4] 2> 821011 T4705 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: lib (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/shard0/lib).
[junit4] 2> 821016 T4705 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 821017 T4705 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: https
[junit4] 2> 821017 T4705 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 821017 T4705 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 821017 T4705 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000
[junit4] 2> 821018 T4705 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 821018 T4705 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 821018 T4705 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 821018 T4705 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 821019 T4705 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 821019 T4705 oashc.HttpShardHandlerFactory.getParameter Setting useRetries to: false
[junit4] 2> 821021 T4705 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 821023 T4705 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 821023 T4705 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 821024 T4705 oasc.CoreContainer.load Node Name: 127.0.0.1
[junit4] 2> 821024 T4705 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/shard0/cores
[junit4] 2> 821025 T4705 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {name=collection1, config=solrconfig-basic.xml, transient=false, schema=schema-distrib-interval-faceting.xml, loadOnStartup=true, instanceDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/shard0/cores/collection1, absoluteInstDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/shard0/cores/collection1/, configSet=collection1, dataDir=data/}
[junit4] 2> 821026 T4705 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/shard0/cores/collection1/
[junit4] 2> 821026 T4705 oasc.CorePropertiesLocator.discover Found 1 core definitions
[junit4] 2> 821051 T4727 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 821052 T4727 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 821052 T4727 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 821069 T4727 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
[junit4] 2> 821090 T4727 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0
[junit4] 2> 821102 T4727 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
[junit4] 2> 821103 T4727 oass.IndexSchema.readSchema Reading Solr Schema from /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema-distrib-interval-faceting.xml
[junit4] 2> 821105 T4727 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 821109 T4727 oass.IndexSchema.readSchema default search field in schema is id
[junit4] 2> 821116 T4727 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 821117 T4727 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from configset /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1
[junit4] 2> 821117 T4727 c:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 821117 T4727 c:collection1 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/, dataDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/shard0/cores/collection1/data/
[junit4] 2> 821118 T4727 c:collection1 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 821118 T4727 c:collection1 oasc.CachingDirectoryFactory.get return new directory for /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/shard0/cores/collection1/data
[junit4] 2> 821118 T4727 c:collection1 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/shard0/cores/collection1/data/index/
[junit4] 2> 821119 T4727 c:collection1 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/shard0/cores/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 821119 T4727 c:collection1 oasc.CachingDirectoryFactory.get return new directory for /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001/tempDir-001/shard0/cores/collection1/data/index
[junit4] 2> 821119 T4727 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=44, maxMergeAtOnceExplicit=10, maxMergedSegmentMB=2.7197265625, floorSegmentMB=1.28125, forceMergeDeletesPctAllowed=29.314348376076637, segmentsPerTier=19.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6171905057941136
[junit4] 2> 821120 T4727 c:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@163b0eb lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6e1daf),segFN=segments_1,generation=1}
[junit4] 2> 821120 T4727 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 821122 T4727 c:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 821124 T4727 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 821125 T4727 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 821126 T4727 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 821127 T4727 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 821128 T4727 c:collection1 oasc.RequestHandlers.initHandlersFromConfig Registered paths: /admin/mbeans,standard,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
[junit4] 2> 821129 T4727 c:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 821129 T4727 c:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 821129 T4727 c:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 821129 T4727 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=33, maxMergeAtOnceExplicit=37, maxMergedSegmentMB=46.7578125, floorSegmentMB=1.314453125, forceMergeDeletesPctAllowed=26.90135216644676, segmentsPerTier=31.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.3083023775425378
[junit4] 2> 821139 T4727 c:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@163b0eb lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6e1daf),segFN=segments_1,generation=1}
[junit4] 2> 821140 T4727 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 821140 T4727 c:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@1c85226[collection1] main
[junit4] 2> 821140 T4727 c:collection1 oasr.ManagedResourceStorage.newStorageIO WARN Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 821141 T4727 c:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {}
[junit4] 2> 821141 T4727 c:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 821141 T4727 c:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 821141 T4727 c:collection1 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 821142 T4728 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1c85226[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 821142 T4727 c:collection1 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 821156 T4705 oass.SolrDispatchFilter.init user.dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0
[junit4] 2> 821157 T4705 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 821159 T4705 oas.SolrTestCaseJ4.setUp ###Starting test
[junit4] 2> ASYNC NEW_CORE C6981 name=collection1 org.apache.solr.core.SolrCore@ac335b
[junit4] 2> 821239 T4713 c:collection1 C6981 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 821239 T4713 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {deleteByQuery=*:*} 0 1
[junit4] 2> ASYNC NEW_CORE C6982 name=collection1 org.apache.solr.core.SolrCore@15bd2c3
[junit4] 2> 821312 T4726 c:collection1 C6982 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 821313 T4726 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {deleteByQuery=*:*} 0 1
[junit4] 2> 821316 T4714 c:collection1 C6981 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 821317 T4714 c:collection1 C6981 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@140bd8c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@11cc659),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@140bd8c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@11cc659),segFN=segments_2,generation=2}
[junit4] 2> 821317 T4714 c:collection1 C6981 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 821318 T4714 c:collection1 C6981 oass.SolrIndexSearcher.<init> Opening Searcher@22192c[collection1] main
[junit4] 2> 821318 T4714 c:collection1 C6981 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 821318 T4716 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@22192c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 821319 T4714 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 3
[junit4] 2> 821321 T4725 c:collection1 C6982 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 821321 T4725 c:collection1 C6982 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@163b0eb lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6e1daf),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@163b0eb lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6e1daf),segFN=segments_2,generation=2}
[junit4] 2> 821322 T4725 c:collection1 C6982 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 821322 T4725 c:collection1 C6982 oass.SolrIndexSearcher.<init> Opening Searcher@bc29ad[collection1] main
[junit4] 2> 821323 T4725 c:collection1 C6982 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 821323 T4728 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@bc29ad[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 821323 T4725 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 2
[junit4] 2> 821345 T4713 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[0]} 0 12
[junit4] 2> 821348 T4726 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[0]} 0 1
[junit4] 2> 821356 T4714 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[1]} 0 5
[junit4] 2> 821363 T4725 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[1]} 0 4
[junit4] 2> 821367 T4713 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[2]} 0 1
[junit4] 2> 821370 T4726 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[2]} 0 1
[junit4] 2> 821373 T4714 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[3]} 0 0
[junit4] 2> 821376 T4725 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[3]} 0 0
[junit4] 2> 821380 T4714 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[4]} 0 1
[junit4] 2> 821385 T4726 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[4]} 0 2
[junit4] 2> 821388 T4713 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[5]} 0 0
[junit4] 2> 821394 T4725 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[5]} 0 1
[junit4] 2> 821397 T4714 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[6]} 0 1
[junit4] 2> 821410 T4730 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[6]} 0 1
[junit4] 2> 821413 T4713 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {deleteByQuery=id:6} 0 1
[junit4] 2> 821422 T4725 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {deleteByQuery=id:6} 0 1
[junit4] 2> 821425 T4714 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[7]} 0 0
[junit4] 2> 821430 T4730 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[7]} 0 1
[junit4] 2> 821445 T4714 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[8]} 0 12
[junit4] 2> 821451 T4725 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[8]} 0 0
[junit4] 2> 821456 T4713 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[9]} 0 1
[junit4] 2> 821461 T4730 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[9]} 0 1
[junit4] 2> 821464 T4714 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[10]} 0 1
[junit4] 2> 821467 T4725 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[10]} 0 0
[junit4] 2> 821470 T4713 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[11]} 0 0
[junit4] 2> 821473 T4730 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[11]} 0 0
[junit4] 2> 821483 T4714 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[12]} 0 0
[junit4] 2> 821486 T4725 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[12]} 0 0
[junit4] 2> 821489 T4713 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[13]} 0 0
[junit4] 2> 821492 T4730 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[13]} 0 0
[junit4] 2> 821496 T4714 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[14]} 0 1
[junit4] 2> 821499 T4725 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[14]} 0 0
[junit4] 2> 821503 T4713 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[15]} 0 1
[junit4] 2> 821506 T4730 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[15]} 0 1
[junit4] 2> 821509 T4714 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[16]} 0 0
[junit4] 2> 821512 T4725 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[16]} 0 0
[junit4] 2> 821515 T4713 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[17]} 0 0
[junit4] 2> 821518 T4730 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[17]} 0 1
[junit4] 2> 821521 T4714 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[18]} 0 1
[junit4] 2> 821524 T4725 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[18]} 0 1
[junit4] 2> 821527 T4713 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[19]} 0 1
[junit4] 2> 821530 T4730 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[19]} 0 1
[junit4] 2> 821534 T4714 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[20]} 0 1
[junit4] 2> 821537 T4725 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[20]} 0 1
[junit4] 2> 821540 T4713 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[21]} 0 1
[junit4] 2> 821543 T4730 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[21]} 0 1
[junit4] 2> 821546 T4714 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[22]} 0 0
[junit4] 2> 821549 T4725 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[22]} 0 0
[junit4] 2> 821553 T4714 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[23]} 0 1
[junit4] 2> 821556 T4730 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[23]} 0 1
[junit4] 2> 821559 T4714 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[24]} 0 0
[junit4] 2> 821562 T4725 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[24]} 0 0
[junit4] 2> 821566 T4713 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[25]} 0 1
[junit4] 2> 821569 T4730 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[25]} 0 1
[junit4] 2> 821572 T4714 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[26]} 0 1
[junit4] 2> 821575 T4725 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[26]} 0 1
[junit4] 2> 821578 T4713 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[27]} 0 1
[junit4] 2> 821581 T4730 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[27]} 0 0
[junit4] 2> 821589 T4714 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[28]} 0 5
[junit4] 2> 821592 T4725 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[28]} 0 0
[junit4] 2> 821595 T4713 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[29]} 0 0
[junit4] 2> 821599 T4725 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[29]} 0 1
[junit4] 2> 821602 T4714 c:collection1 C6981 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[30]} 0 1
[junit4] 2> 821605 T4725 c:collection1 C6982 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[30]} 0 0
[junit4] 2> ASYNC NEW_CORE C6983 name=collection1 org.apache.solr.core.SolrCore@ac335b
[junit4] 2> 821659 T4713 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[31]} 0 50
[junit4] 2> ASYNC NEW_CORE C6984 name=collection1 org.apache.solr.core.SolrCore@15bd2c3
[junit4] 2> 821662 T4730 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[31]} 0 1
[junit4] 2> 821665 T4714 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[32]} 0 1
[junit4] 2> 821671 T4725 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[32]} 0 0
[junit4] 2> 821681 T4713 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[33]} 0 0
[junit4] 2> 821687 T4730 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[33]} 0 0
[junit4] 2> 821691 T4714 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[34]} 0 1
[junit4] 2> 821694 T4725 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[34]} 0 1
[junit4] 2> 821699 T4714 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[35]} 0 0
[junit4] 2> 821705 T4730 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[35]} 0 1
[junit4] 2> 821727 T4714 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[36]} 0 16
[junit4] 2> 821731 T4725 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[36]} 0 1
[junit4] 2> 821733 T4713 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[37]} 0 0
[junit4] 2> 821737 T4730 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[37]} 0 1
[junit4] 2> 821740 T4714 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[38]} 0 1
[junit4] 2> 821743 T4725 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[38]} 0 1
[junit4] 2> 821746 T4713 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[39]} 0 0
[junit4] 2> 821749 T4730 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[39]} 0 0
[junit4] 2> 821752 T4714 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[40]} 0 0
[junit4] 2> 821756 T4725 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[40]} 0 1
[junit4] 2> 821759 T4713 c:collection1 C6983 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 821786 T4713 c:collection1 C6983 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@140bd8c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@11cc659),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@140bd8c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@11cc659),segFN=segments_3,generation=3}
[junit4] 2> 821787 T4713 c:collection1 C6983 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
[junit4] 2> 821787 T4713 c:collection1 C6983 oass.SolrIndexSearcher.<init> Opening Searcher@1faa9c4[collection1] main
[junit4] 2> 821788 T4716 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1faa9c4[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):C41/1:delGen=1)))}
[junit4] 2> 821788 T4713 c:collection1 C6983 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 821788 T4713 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 30
[junit4] 2> 821790 T4730 c:collection1 C6984 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 821810 T4730 c:collection1 C6984 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@163b0eb lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6e1daf),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@163b0eb lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6e1daf),segFN=segments_3,generation=3}
[junit4] 2> 821811 T4730 c:collection1 C6984 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
[junit4] 2> 821811 T4730 c:collection1 C6984 oass.SolrIndexSearcher.<init> Opening Searcher@1d9a3ad[collection1] main
[junit4] 2> 821811 T4730 c:collection1 C6984 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 821811 T4728 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1d9a3ad[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):C41/1:delGen=1)))}
[junit4] 2> 821812 T4730 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 22
[junit4] 2> 821816 T4714 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[41]} 0 1
[junit4] 2> 821820 T4725 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[41]} 0 1
[junit4] 2> 821823 T4713 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[42]} 0 0
[junit4] 2> 821826 T4730 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[42]} 0 0
[junit4] 2> 821830 T4714 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[43]} 0 1
[junit4] 2> 821834 T4730 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[43]} 0 1
[junit4] 2> 821837 T4713 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[44]} 0 1
[junit4] 2> 821840 T4725 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[44]} 0 1
[junit4] 2> 821843 T4714 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[45]} 0 0
[junit4] 2> 821851 T4730 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[45]} 0 1
[junit4] 2> 821854 T4713 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[46]} 0 1
[junit4] 2> 821856 T4725 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[46]} 0 0
[junit4] 2> 821877 T4714 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[47]} 0 1
[junit4] 2> 821880 T4730 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[47]} 0 0
[junit4] 2> 821884 T4713 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[48]} 0 1
[junit4] 2> 821887 T4725 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[48]} 0 0
[junit4] 2> 821890 T4714 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[49]} 0 0
[junit4] 2> 821893 T4730 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[49]} 0 0
[junit4] 2> 821896 T4713 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[50]} 0 0
[junit4] 2> 821899 T4725 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[50]} 0 0
[junit4] 2> 821902 T4714 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[51]} 0 0
[junit4] 2> 821905 T4730 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[51]} 0 0
[junit4] 2> 821910 T4713 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[52]} 0 0
[junit4] 2> 821914 T4725 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[52]} 0 1
[junit4] 2> 821917 T4714 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[53]} 0 0
[junit4] 2> 821920 T4730 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[53]} 0 0
[junit4] 2> 821923 T4713 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[54]} 0 0
[junit4] 2> 821926 T4725 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[54]} 0 0
[junit4] 2> 821929 T4714 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[55]} 0 0
[junit4] 2> 821933 T4730 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[55]} 0 1
[junit4] 2> 821936 T4713 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[56]} 0 1
[junit4] 2> 821939 T4725 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[56]} 0 0
[junit4] 2> 821942 T4714 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[57]} 0 0
[junit4] 2> 821945 T4730 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[57]} 0 0
[junit4] 2> 821949 T4713 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[58]} 0 1
[junit4] 2> 821952 T4725 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[58]} 0 1
[junit4] 2> 821955 T4713 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[59]} 0 0
[junit4] 2> 821958 T4730 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[59]} 0 1
[junit4] 2> 821966 T4713 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[60]} 0 5
[junit4] 2> 821970 T4730 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[60]} 0 1
[junit4] 2> 821974 T4713 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[61]} 0 1
[junit4] 2> 821977 T4725 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[61]} 0 0
[junit4] 2> 821982 T4714 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[62]} 0 1
[junit4] 2> 821985 T4730 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[62]} 0 0
[junit4] 2> 821989 T4714 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[63]} 0 1
[junit4] 2> 821992 T4725 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[63]} 0 1
[junit4] 2> 821995 T4714 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[64]} 0 1
[junit4] 2> 821998 T4725 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[64]} 0 0
[junit4] 2> 822006 T4714 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[65]} 0 1
[junit4] 2> 822010 T4725 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[65]} 0 1
[junit4] 2> 822013 T4713 c:collection1 C6983 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[66]} 0 1
[junit4] 2> 822017 T4725 c:collection1 C6984 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[66]} 0 1
[junit4] 2> ASYNC NEW_CORE C6985 name=collection1 org.apache.solr.core.SolrCore@ac335b
[junit4] 2> 822045 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[67]} 0 1
[junit4] 2> ASYNC NEW_CORE C6986 name=collection1 org.apache.solr.core.SolrCore@15bd2c3
[junit4] 2> 822049 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[67]} 0 1
[junit4] 2> 822052 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[68]} 0 1
[junit4] 2> 822055 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[68]} 0 0
[junit4] 2> 822059 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[69]} 0 0
[junit4] 2> 822062 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[69]} 0 1
[junit4] 2> 822067 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[70]} 0 2
[junit4] 2> 822070 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[70]} 0 1
[junit4] 2> 822074 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[71]} 0 1
[junit4] 2> 822089 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[71]} 0 0
[junit4] 2> 822094 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[72]} 0 1
[junit4] 2> 822097 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[72]} 0 0
[junit4] 2> 822101 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[73]} 0 1
[junit4] 2> 822104 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[73]} 0 1
[junit4] 2> 822108 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[74]} 0 1
[junit4] 2> 822111 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[74]} 0 1
[junit4] 2> 822114 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[75]} 0 1
[junit4] 2> 822117 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[75]} 0 0
[junit4] 2> 822121 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[76]} 0 1
[junit4] 2> 822124 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[76]} 0 1
[junit4] 2> 822127 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[77]} 0 0
[junit4] 2> 822141 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[77]} 0 11
[junit4] 2> 822149 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[78]} 0 0
[junit4] 2> 822154 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[78]} 0 1
[junit4] 2> 822157 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[79]} 0 0
[junit4] 2> 822166 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[79]} 0 1
[junit4] 2> 822169 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[80]} 0 1
[junit4] 2> 822172 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[80]} 0 1
[junit4] 2> 822175 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[81]} 0 0
[junit4] 2> 822190 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[81]} 0 0
[junit4] 2> 822193 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[82]} 0 0
[junit4] 2> 822196 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[82]} 0 0
[junit4] 2> 822199 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[83]} 0 0
[junit4] 2> 822202 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[83]} 0 0
[junit4] 2> 822205 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[84]} 0 0
[junit4] 2> 822208 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[84]} 0 0
[junit4] 2> 822211 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[85]} 0 0
[junit4] 2> 822214 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[85]} 0 1
[junit4] 2> 822217 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[86]} 0 1
[junit4] 2> 822219 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[86]} 0 0
[junit4] 2> 822222 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[87]} 0 0
[junit4] 2> 822225 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[87]} 0 0
[junit4] 2> 822228 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[88]} 0 0
[junit4] 2> 822231 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[88]} 0 1
[junit4] 2> 822234 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[89]} 0 1
[junit4] 2> 822236 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[89]} 0 0
[junit4] 2> 822239 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[90]} 0 0
[junit4] 2> 822243 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[90]} 0 1
[junit4] 2> 822246 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[91]} 0 1
[junit4] 2> 822248 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[91]} 0 0
[junit4] 2> 822253 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[92]} 0 0
[junit4] 2> 822256 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[92]} 0 0
[junit4] 2> 822259 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[93]} 0 0
[junit4] 2> 822262 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[93]} 0 1
[junit4] 2> 822264 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[94]} 0 0
[junit4] 2> 822267 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[94]} 0 0
[junit4] 2> 822270 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[95]} 0 1
[junit4] 2> 822272 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[95]} 0 0
[junit4] 2> 822275 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[96]} 0 0
[junit4] 2> 822277 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[96]} 0 0
[junit4] 2> 822280 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[97]} 0 0
[junit4] 2> 822283 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[97]} 0 0
[junit4] 2> 822289 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[98]} 0 0
[junit4] 2> 822292 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[98]} 0 0
[junit4] 2> 822295 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[99]} 0 0
[junit4] 2> 822298 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[99]} 0 1
[junit4] 2> 822301 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[100]} 0 1
[junit4] 2> 822307 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[100]} 0 1
[junit4] 2> 822310 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[101]} 0 1
[junit4] 2> 822313 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[101]} 0 1
[junit4] 2> 822316 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[102]} 0 1
[junit4] 2> 822318 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[102]} 0 0
[junit4] 2> 822321 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[103]} 0 0
[junit4] 2> 822324 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[103]} 0 0
[junit4] 2> 822327 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[104]} 0 1
[junit4] 2> 822329 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[104]} 0 0
[junit4] 2> 822332 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[105]} 0 0
[junit4] 2> 822335 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[105]} 0 0
[junit4] 2> 822338 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[106]} 0 0
[junit4] 2> 822341 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[106]} 0 1
[junit4] 2> 822349 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[107]} 0 0
[junit4] 2> 822352 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[107]} 0 0
[junit4] 2> 822355 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[108]} 0 0
[junit4] 2> 822358 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[108]} 0 0
[junit4] 2> 822361 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[109]} 0 0
[junit4] 2> 822363 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[109]} 0 0
[junit4] 2> 822366 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[110]} 0 0
[junit4] 2> 822369 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[110]} 0 0
[junit4] 2> 822372 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[111]} 0 1
[junit4] 2> 822375 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[111]} 0 1
[junit4] 2> 822377 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[112]} 0 0
[junit4] 2> 822380 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[112]} 0 0
[junit4] 2> 822383 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[113]} 0 0
[junit4] 2> 822386 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[113]} 0 1
[junit4] 2> 822389 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[114]} 0 1
[junit4] 2> 822391 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[114]} 0 0
[junit4] 2> 822398 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[115]} 0 1
[junit4] 2> 822401 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[115]} 0 1
[junit4] 2> 822405 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[116]} 0 0
[junit4] 2> 822408 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[116]} 0 0
[junit4] 2> 822411 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[117]} 0 0
[junit4] 2> 822415 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[117]} 0 0
[junit4] 2> 822418 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[118]} 0 1
[junit4] 2> 822420 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[118]} 0 0
[junit4] 2> 822423 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[119]} 0 0
[junit4] 2> 822426 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[119]} 0 0
[junit4] 2> 822429 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[120]} 0 1
[junit4] 2> 822431 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[120]} 0 0
[junit4] 2> 822442 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[121]} 0 1
[junit4] 2> 822445 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[121]} 0 1
[junit4] 2> 822448 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[122]} 0 1
[junit4] 2> 822451 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[122]} 0 1
[junit4] 2> 822456 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[123]} 0 1
[junit4] 2> 822459 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[123]} 0 0
[junit4] 2> 822462 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[124]} 0 1
[junit4] 2> 822465 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[124]} 0 0
[junit4] 2> 822468 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[125]} 0 0
[junit4] 2> 822471 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[125]} 0 0
[junit4] 2> 822473 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[126]} 0 0
[junit4] 2> 822477 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[126]} 0 0
[junit4] 2> 822481 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[127]} 0 0
[junit4] 2> 822485 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[127]} 0 0
[junit4] 2> 822488 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[128]} 0 0
[junit4] 2> 822491 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[128]} 0 0
[junit4] 2> 822494 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[129]} 0 0
[junit4] 2> 822497 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[129]} 0 0
[junit4] 2> 822508 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[130]} 0 1
[junit4] 2> 822510 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[130]} 0 0
[junit4] 2> 822513 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[131]} 0 0
[junit4] 2> 822516 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[131]} 0 1
[junit4] 2> 822518 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[132]} 0 0
[junit4] 2> 822521 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[132]} 0 1
[junit4] 2> 822524 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[133]} 0 1
[junit4] 2> 822527 T4725 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[133]} 0 0
[junit4] 2> 822530 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[134]} 0 0
[junit4] 2> 822533 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[134]} 0 1
[junit4] 2> 822535 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[135]} 0 0
[junit4] 2> 822538 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[135]} 0 0
[junit4] 2> 822549 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[136]} 0 8
[junit4] 2> 822552 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[136]} 0 0
[junit4] 2> 822555 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[137]} 0 0
[junit4] 2> 822558 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[137]} 0 1
[junit4] 2> 822560 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[138]} 0 0
[junit4] 2> 822563 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[138]} 0 0
[junit4] 2> 822567 T4713 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[139]} 0 0
[junit4] 2> 822573 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[139]} 0 0
[junit4] 2> 822576 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[140]} 0 0
[junit4] 2> 822579 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[140]} 0 1
[junit4] 2> 822582 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[141]} 0 1
[junit4] 2> 822586 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[141]} 0 1
[junit4] 2> 822589 T4714 c:collection1 C6985 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[142]} 0 0
[junit4] 2> 822592 T4730 c:collection1 C6986 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[142]} 0 0
[junit4] 2> ASYNC NEW_CORE C6987 name=collection1 org.apache.solr.core.SolrCore@ac335b
[junit4] 2> 822644 T4713 c:collection1 C6987 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[143]} 0 0
[junit4] 2> ASYNC NEW_CORE C6988 name=collection1 org.apache.solr.core.SolrCore@15bd2c3
[junit4] 2> 822648 T4730 c:collection1 C6988 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[143]} 0 1
[junit4] 2> 822650 T4714 c:collection1 C6987 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[144]} 0 0
[junit4] 2> 822653 T4725 c:collection1 C6988 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[144]} 0 0
[junit4] 2> 822656 T4713 c:collection1 C6987 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[145]} 0 0
[junit4] 2> 822659 T4730 c:collection1 C6988 oasup.LogUpdateProce
[...truncated too long message...]
ient.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:225)
[junit4] > at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:135)
[junit4] > at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:174)
[junit4] > at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:139)
[junit4] > at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:153)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase.indexDoc(BaseDistributedSearchTestCase.java:484)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase.indexr(BaseDistributedSearchTestCase.java:466)
[junit4] > at org.apache.solr.DistributedIntervalFacetingTest.testRandom(DistributedIntervalFacetingTest.java:145)
[junit4] > at org.apache.solr.DistributedIntervalFacetingTest.test(DistributedIntervalFacetingTest.java:45)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:982)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:935)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > Caused by: java.net.SocketTimeoutException: Read timed out
[junit4] > at java.net.SocketInputStream.socketRead0(Native Method)
[junit4] > at java.net.SocketInputStream.socketRead(SocketInputStream.java:116)
[junit4] > at java.net.SocketInputStream.read(SocketInputStream.java:170)
[junit4] > at java.net.SocketInputStream.read(SocketInputStream.java:141)
[junit4] > at sun.security.ssl.InputRecord.readFully(InputRecord.java:465)
[junit4] > at sun.security.ssl.InputRecord.read(InputRecord.java:503)
[junit4] > at sun.security.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:961)
[junit4] > at sun.security.ssl.SSLSocketImpl.readDataRecord(SSLSocketImpl.java:918)
[junit4] > at sun.security.ssl.AppInputStream.read(AppInputStream.java:105)
[junit4] > at org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160)
[junit4] > at org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84)
[junit4] > at org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273)
[junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140)
[junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
[junit4] > at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261)
[junit4] > at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283)
[junit4] > at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251)
[junit4] > at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197)
[junit4] > at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272)
[junit4] > at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124)
[junit4] > at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685)
[junit4] > at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487)
[junit4] > at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882)
[junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
[junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107)
[junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:462)
[junit4] > ... 51 more
[junit4] 2> 917217 T4705 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.DistributedIntervalFacetingTest 29E3B8E95C13BC65-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene50): {test_ds_dv=PostingsFormat(name=Memory doPackFST= true), n_l1=PostingsFormat(name=Direct), test_fs_dv=PostingsFormat(name=LuceneVarGapFixedInterval), n_dt1=Lucene50(blocksize=128), n_td1=Lucene50(blocksize=128), n_d1=PostingsFormat(name=Direct), n_f1=Lucene50(blocksize=128), n_ti1=PostingsFormat(name=LuceneVarGapFixedInterval), rnd_b=PostingsFormat(name=LuceneVarGapFixedInterval), n_tl1=Lucene50(blocksize=128), n_tf1=PostingsFormat(name=Direct), test_l_dv=Lucene50(blocksize=128), n_tdt1=Lucene50(blocksize=128), test_ls_dv=PostingsFormat(name=Memory doPackFST= true), test_f_dv=PostingsFormat(name=Direct), id=PostingsFormat(name=LuceneVarGapFixedInterval), test_d_dv=Lucene50(blocksize=128)}, docValues:{test_is_dv=DocValuesFormat(name=Asserting), id_dv=DocValuesFormat(name=Asserting), test_ds_dv=DocValuesFormat(name=Lucene50), test_ss_dv=DocValuesFormat(name=Memory), test_s_dv=DocValuesFormat(name=Direct), test_i_dv=DocValuesFormat(name=Lucene50), test_l_dv=DocValuesFormat(name=Memory), test_fs_dv=DocValuesFormat(name=Direct), test_ls_dv=DocValuesFormat(name=Lucene50), test_f_dv=DocValuesFormat(name=Asserting), test_d_dv=DocValuesFormat(name=Memory)}, sim=DefaultSimilarity, locale=mk, timezone=Africa/Dar_es_Salaam
[junit4] 2> NOTE: Linux 3.13.0-48-generic i386/Oracle Corporation 1.8.0_60-ea (32-bit)/cpus=12,threads=1,free=53222928,total=174419968
[junit4] 2> NOTE: All tests run in this JVM: [TestSchemaVersionResource, DistributedFacetPivotSmallAdvancedTest, TestPhraseSuggestions, TestRangeQuery, RequestLoggingTest, TestTrackingShardHandlerFactory, DistribJoinFromCollectionTest, TestDistributedSearch, DistributedFacetPivotLongTailTest, TestIBSimilarityFactory, ResponseHeaderTest, SolrCoreTest, DistributedSpellCheckComponentTest, TestIndexingPerformance, TestDefaultSearchFieldResource, DateFieldTest, TestDocumentBuilder, DateMathParserTest, EnumFieldTest, IndexBasedSpellCheckerTest, TestBinaryField, TestSolrIndexConfig, HighlighterConfigTest, SolrIndexConfigTest, HdfsDirectoryTest, TestReversedWildcardFilterFactory, AnalyticsMergeStrategyTest, TestJmxIntegration, TestMiniSolrCloudCluster, OverseerRolesTest, TestInitQParser, RankQueryTest, ZkStateWriterTest, SuggesterWFSTTest, SaslZkACLProviderTest, DebugComponentTest, StandardRequestHandlerTest, TestHighFrequencyDictionaryFactory, HighlighterTest, MBeansHandlerTest, TestBadConfig, ClusterStateTest, TestFieldTypeCollectionResource, TestFieldResource, HdfsDirectoryFactoryTest, TestArbitraryIndexDir, ZkNodePropsTest, BasicDistributedZkTest, UUIDFieldTest, TestCSVLoader, CursorMarkTest, InfoHandlerTest, DistribDocExpirationUpdateProcessorTest, TestSweetSpotSimilarityFactory, TestFreeTextSuggestions, TestUpdate, BasicZkTest, DistributedFacetPivotLargeTest, BlockCacheTest, SuggesterFSTTest, DistributedQueueTest, LeaderElectionIntegrationTest, HdfsCollectionsAPIDistributedZkTest, TestReplicationHandler, TestSimpleTrackingShardHandler, SolrRequestParserTest, TestSolrConfigHandler, TestRealTimeGet, VMParamsZkACLAndCredentialsProvidersTest, TestLazyCores, TermVectorComponentTest, ChaosMonkeyNothingIsSafeTest, SimpleMLTQParserTest, SharedFSAutoReplicaFailoverTest, MultiTermTest, CoreMergeIndexesAdminHandlerTest, DistributedFacetPivotSmallTest, TermsComponentTest, TestZkChroot, TestRandomDVFaceting, TestDistributedGrouping, TestJoin, PeerSyncTest, ConvertedLegacyTest, OverseerCollectionProcessorTest, CurrencyFieldXmlFileTest, TestExtendedDismaxParser, SpatialFilterTest, NoCacheHeaderTest, SchemaVersionSpecificBehaviorTest, TestWordDelimiterFilterFactory, TestRemoteStreaming, TestSurroundQueryParser, TestQueryUtils, DocumentAnalysisRequestHandlerTest, XmlUpdateRequestHandlerTest, TestSolrQueryParser, IndexSchemaTest, UniqFieldsUpdateProcessorFactoryTest, PingRequestHandlerTest, UpdateParamsTest, TestSolrDeletionPolicy2, TestElisionMultitermQuery, OutputWriterTest, SpellPossibilityIteratorTest, TestCodecSupport, TestLMJelinekMercerSimilarityFactory, TestJmxMonitoredMap, TestFastOutputStream, PrimUtilsTest, DOMUtilTest, DistributedIntervalFacetingTest]
[junit4] Completed on J0 in 96.62s, 1 test, 1 error <<< FAILURES!
[...truncated 344 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:529: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:477: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:61: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/extra-targets.xml:39: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build.xml:191: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/common-build.xml:509: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:1370: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:976: There were test failures: 479 suites, 1903 tests, 1 error, 47 ignored (20 assumptions)
Total time: 48 minutes 32 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 32bit/jdk1.8.0_60-ea-b06 -server -XX:+UseConcMarkSweepGC
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
[JENKINS] Lucene-Solr-5.x-Linux (64bit/ibm-j9-jdk7) - Build # 12059
- Still Failing!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Linux/12059/
Java: 64bit/ibm-j9-jdk7 -Xjit:exclude={org/apache/lucene/util/fst/FST.pack(IIF)Lorg/apache/lucene/util/fst/FST;}
No tests ran.
Build Log:
[...truncated 142 lines...]
ERROR: Publisher hudson.tasks.junit.JUnitResultArchiver aborted due to exception
hudson.AbortException: No test report files were found. Configuration error?
at hudson.tasks.junit.JUnitParser$ParseResultCallable.invoke(JUnitParser.java:116)
at hudson.tasks.junit.JUnitParser$ParseResultCallable.invoke(JUnitParser.java:93)
at hudson.FilePath.act(FilePath.java:989)
at hudson.FilePath.act(FilePath.java:967)
at hudson.tasks.junit.JUnitParser.parseResult(JUnitParser.java:90)
at hudson.tasks.junit.JUnitResultArchiver.parse(JUnitResultArchiver.java:120)
at hudson.tasks.junit.JUnitResultArchiver.perform(JUnitResultArchiver.java:137)
at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:74)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:761)
at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:721)
at hudson.model.Build$BuildExecution.post2(Build.java:183)
at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:670)
at hudson.model.Run.execute(Run.java:1766)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:98)
at hudson.model.Executor.run(Executor.java:374)
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any