[
https://issues.apache.org/jira/browse/SOLR-7339?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=15066735#comment-15066735
]
Ishan Chattopadhyaya commented on SOLR-7339:
--------------------------------------------
Mark, I applied your patch and ran the test, but the test still fails with the
following output. It appears to be the same as what I saw without your patch,
but the exact error isn't clear to me from that output.
{code}
[ishan@x230 solr]$ ant clean test -Dtestcase=SolrExampleStreamingBinaryTest
-Dtests.method=testUpdateField
...
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/ishan/code/lucene-solr-svn/lucene/ivy-settings.xml
resolve:
init:
compile-core:
validate:
resolve-groovy:
-init-totals:
-test:
[mkdir] Created dir:
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test
[mkdir] Created dir:
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/temp
[junit4] <JUnit4> says 今日は! Master seed: EC056F9D893F1A9A
[junit4] Executing 1 suite with 1 JVM.
[junit4]
[junit4] Started J0 PID(1129@x230).
[junit4] Suite:
org.apache.solr.client.solrj.embedded.SolrExampleStreamingBinaryTest
[junit4] 2> Creating dataDir:
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/init-core-data-001
[junit4] 2> 0 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 2 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 6 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-002/cores/core
[junit4] 2> 46 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.e.j.u.log Logging initialized @2663ms
[junit4] 2> 277 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.e.j.s.Server jetty-9.3.6.v20151106
[junit4] 2> 323 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@6ec49310{/solr,null,AVAILABLE}
[junit4] 2> 339 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@3b2c45{HTTP/1.1,[http/1.1]}{127.0.0.1:33129}
[junit4] 2> 339 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.e.j.s.Server Started @2960ms
[junit4] 2> 340 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=33129,
configSetBaseDir=/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001,
coreRootDirectory=/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-002/cores}
[junit4] 2> 349 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@4e0e2f2a
[junit4] 2> 385 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001'
[junit4] 2> 391 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 393 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.a.s.c.SolrResourceLoader using system property solr.solr.home:
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001
[junit4] 2> 401 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/solr.xml
[junit4] 2> 914 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.a.s.c.CorePropertiesLocator Config-defined core root directory:
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001
[junit4] 2> 970 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.a.s.c.CoreContainer New CoreContainer 62491411
[junit4] 2> 970 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001]
[junit4] 2> 971 WARN
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.a.s.c.CoreContainer Couldn't add files from
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/lib
to classpath:
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/lib
[junit4] 2> 997 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout :
600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections :
10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime :
5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
[junit4] 2> 1212 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=600000&connTimeout=60000&retry=true
[junit4] 2> 1217 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1219 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.a.s.l.LogWatcher Registering Log Listener [Log4j
(org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1223 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for
authorization module.
[junit4] 2> 1224 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 1337 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.a.s.c.CorePropertiesLocator Looking for core definitions underneath
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001
[junit4] 2> 1347 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1,
config=solrconfig.xml, loadOnStartup=true, schema=schema.xml,
configSetProperties=configsetprops.json, transient=false, dataDir=data/}
[junit4] 2> 1347 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.a.s.c.CorePropertiesLocator Found core collection1 in
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1
[junit4] 2> 1348 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.a.s.c.CorePropertiesLocator Found 1 core definitions
[junit4] 2> 1354 INFO (coreLoadExecutor-6-thread-1) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1'
[junit4] 2> 1354 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.a.s.s.SolrDispatchFilter
user.dir=/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0
[junit4] 2> 1354 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 1354 INFO (coreLoadExecutor-6-thread-1) [ ]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1355 INFO (coreLoadExecutor-6-thread-1) [ ]
o.a.s.c.SolrResourceLoader using system property solr.solr.home:
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001
[junit4] 2> 1541 INFO (coreLoadExecutor-6-thread-1) [ ]
o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 1548 INFO (coreLoadExecutor-6-thread-1) [ ]
o.a.s.c.SolrConfig Adding specified lib dirs to ClassLoader
[junit4] 2> 1551 WARN (coreLoadExecutor-6-thread-1) [ ]
o.a.s.c.SolrConfig Couldn't add files from
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/../../../../contrib/extraction/lib
filtered by .*\.jar to classpath:
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/../../../../contrib/extraction/lib
[junit4] 2> 1551 WARN (coreLoadExecutor-6-thread-1) [ ]
o.a.s.c.SolrConfig Couldn't add files from
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/../../../../dist
filtered by solr-cell-\d.*\.jar to classpath:
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/../../../../dist
[junit4] 2> 1551 WARN (coreLoadExecutor-6-thread-1) [ ]
o.a.s.c.SolrConfig Couldn't add files from
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/../../../../contrib/clustering/lib
filtered by .*\.jar to classpath:
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/../../../../contrib/clustering/lib
[junit4] 2> 1552 WARN (coreLoadExecutor-6-thread-1) [ ]
o.a.s.c.SolrConfig Couldn't add files from
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/../../../../dist
filtered by solr-clustering-\d.*\.jar to classpath:
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/../../../../dist
[junit4] 2> 1552 WARN (coreLoadExecutor-6-thread-1) [ ]
o.a.s.c.SolrConfig Couldn't add files from
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/../../../../contrib/langid/lib
filtered by .*\.jar to classpath:
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/../../../../contrib/langid/lib
[junit4] 2> 1552 WARN (coreLoadExecutor-6-thread-1) [ ]
o.a.s.c.SolrConfig Couldn't add files from
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/../../../../dist
filtered by solr-langid-\d.*\.jar to classpath:
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/../../../../dist
[junit4] 2> 1553 WARN (coreLoadExecutor-6-thread-1) [ ]
o.a.s.c.SolrConfig Couldn't add files from
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/../../../../contrib/velocity/lib
filtered by .*\.jar to classpath:
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/../../../../contrib/velocity/lib
[junit4] 2> 1553 WARN (coreLoadExecutor-6-thread-1) [ ]
o.a.s.c.SolrConfig Couldn't add files from
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/../../../../dist
filtered by solr-velocity-\d.*\.jar to classpath:
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/../../../../dist
[junit4] 2> 1622 INFO (coreLoadExecutor-6-thread-1) [ ]
o.a.s.u.SolrIndexConfig IndexWriter infoStream solr logging is enabled
[junit4] 2> 1641 INFO (coreLoadExecutor-6-thread-1) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 1910 INFO (coreLoadExecutor-6-thread-1) [ ]
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1980 INFO (coreLoadExecutor-6-thread-1) [ ]
o.a.s.s.IndexSchema [collection1] Schema name=example
[junit4] 2> 3186 INFO (coreLoadExecutor-6-thread-1) [ ]
o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 3567 INFO (coreLoadExecutor-6-thread-1) [ ]
o.a.s.r.RestManager Registered ManagedResource impl
org.apache.solr.rest.schema.analysis.ManagedWordSetResource for path
/schema/analysis/stopwords/english
[junit4] 2> 3569 INFO (coreLoadExecutor-6-thread-1) [ ]
o.a.s.r.RestManager Registered ManagedResource impl
org.apache.solr.rest.schema.analysis.ManagedSynonymFilterFactory$SynonymManager
for path /schema/analysis/synonyms/english
[junit4] 2> 3579 INFO (coreLoadExecutor-6-thread-1) [ ]
o.a.s.r.RestManager Added observer of type
org.apache.solr.rest.schema.analysis.ManagedStopFilterFactory to existing
ManagedResource /schema/analysis/stopwords/english
[junit4] 2> 3580 INFO (coreLoadExecutor-6-thread-1) [ ]
o.a.s.r.RestManager Added observer of type
org.apache.solr.rest.schema.analysis.ManagedSynonymFilterFactory to existing
ManagedResource /schema/analysis/synonyms/english
[junit4] 2> 3610 INFO (coreLoadExecutor-6-thread-1) [ ]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 3619 INFO (coreLoadExecutor-6-thread-1) [ ]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 3678 INFO (coreLoadExecutor-6-thread-1) [ ]
o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default
properties: Can't find resource 'configsetprops.json' in classpath or
'/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1'
[junit4] 2> 3679 INFO (coreLoadExecutor-6-thread-1) [ ]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
instancedir
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1
[junit4] 2> 3753 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 3765 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1],
dataDir=[/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/data/]
[junit4] 2> 3768 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.c.JmxMonitoredMap No JMX servers found, not exposing Solr information
with JMX.
[junit4] 2> 3782 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.c.SolrCore [[collection1] ] Added SolrEventListener for newSearcher:
[org.apache.solr.core.QuerySenderListener{queries=[]}]
[junit4] 2> 3782 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.c.SolrCore [[collection1] ] Added SolrEventListener for firstSearcher:
[org.apache.solr.core.QuerySenderListener{queries=[{q=static firstSearcher
warming in solrconfig.xml}]}]
[junit4] 2> 3816 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.c.CachingDirectoryFactory return new directory for
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/data
[junit4] 2> 3816 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.c.SolrCore New index directory detected: old=null
new=/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/data/index/
[junit4] 2> 3817 WARN (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Solr index directory
'/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 3834 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.c.CachingDirectoryFactory return new directory for
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/data/index
[junit4] 2> 3884 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-6-thread-1]: init: current
segments file is "segments";
deletionPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper@6f2663c1
[junit4] 2> 3886 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-6-thread-1]: now checkpoint ""
[0 segments ; isCommit = false]
[junit4] 2> 3886 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-6-thread-1]: 0 msec to
checkpoint
[junit4] 2> 3886 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: init: create=true
[junit4] 2> 3887 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]:
[junit4] 2> dir=MockDirectoryWrapper(RAMDirectory@6cdff2a
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3a55f217)
[junit4] 2> index=
[junit4] 2> version=6.0.0
[junit4] 2>
analyzer=org.apache.solr.update.SolrIndexConfig$DelayedSchemaAnalyzer
[junit4] 2> ramBufferSizeMB=100.0
[junit4] 2> maxBufferedDocs=-1
[junit4] 2> maxBufferedDeleteTerms=-1
[junit4] 2> mergedSegmentWarmer=null
[junit4] 2> delPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper
[junit4] 2> commit=null
[junit4] 2> openMode=CREATE
[junit4] 2>
similarity=org.apache.solr.search.similarities.SchemaSimilarityFactory$1
[junit4] 2> mergeScheduler=ConcurrentMergeScheduler: maxThreadCount=-1,
maxMergeCount=-1, ioThrottle=true
[junit4] 2> codec=Lucene60
[junit4] 2> infoStream=org.apache.solr.update.LoggingInfoStream
[junit4] 2> mergePolicy=[TieredMergePolicy: maxMergeAtOnce=10,
maxMergeAtOnceExplicit=30, maxMergedSegmentMB=5120.0, floorSegmentMB=2.0,
forceMergeDeletesPctAllowed=10.0, segmentsPerTier=10.0,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1
[junit4] 2>
indexerThreadPool=org.apache.lucene.index.DocumentsWriterPerThreadPool@7af6e178
[junit4] 2> readerPooling=false
[junit4] 2> perThreadHardLimitMB=1945
[junit4] 2> useCompoundFile=false
[junit4] 2> commitOnClose=true
[junit4] 2> writer=org.apache.solr.update.SolrIndexWriter@ae71d24
[junit4] 2>
[junit4] 2> 3901 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]:
MMapDirectory.UNMAP_SUPPORTED=true
[junit4] 2> 3902 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: now flush at close
[junit4] 2> 3902 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: start flush:
applyAllDeletes=true
[junit4] 2> 3902 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: index before
flush
[junit4] 2> 3902 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-6-thread-1]: startFullFlush
[junit4] 2> 3903 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-6-thread-1]:
coreLoadExecutor-6-thread-1 finishFullFlush success=true
[junit4] 2> 3903 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: apply all deletes
during flush
[junit4] 2> 3903 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: now apply all
deletes for all segments maxDoc=0
[junit4] 2> 3907 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-6-thread-1]: prune
sis=segments: minGen=9223372036854775807 packetCount=0
[junit4] 2> 3910 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-6-thread-1]:
initDynamicDefaults spins=true maxThreadCount=1 maxMergeCount=6
[junit4] 2> 3911 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-6-thread-1]: updateMergeThreads
ioThrottle=true targetMBPerSec=10240.0 MB/sec
[junit4] 2> 3911 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-6-thread-1]: now merge
[junit4] 2> 3911 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-6-thread-1]: index:
[junit4] 2> 3911 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-6-thread-1]: no more merges
pending; now return
[junit4] 2> 3911 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: waitForMerges
[junit4] 2> 3911 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: waitForMerges done
[junit4] 2> 3912 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: commit: start
[junit4] 2> 3912 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: commit: enter lock
[junit4] 2> 3912 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: commit: now prepare
[junit4] 2> 3912 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: prepareCommit:
flush
[junit4] 2> 3912 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: index before
flush
[junit4] 2> 3912 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-6-thread-1]: startFullFlush
[junit4] 2> 3912 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: apply all deletes
during flush
[junit4] 2> 3912 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: now apply all
deletes for all segments maxDoc=0
[junit4] 2> 3912 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-6-thread-1]: prune
sis=segments: minGen=9223372036854775807 packetCount=0
[junit4] 2> 3913 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-6-thread-1]:
coreLoadExecutor-6-thread-1 finishFullFlush success=true
[junit4] 2> 3913 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: startCommit():
start
[junit4] 2> 3913 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: startCommit index=
changeCount=2
[junit4] 2> 3921 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: startCommit: wrote
pending segments file "pending_segments_1"
[junit4] 2> 3921 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: done all syncs: []
[junit4] 2> 3921 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: commit:
pendingCommit != null
[junit4] 2> 3922 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: commit: done
writing segments file "segments_1"
[junit4] 2> 3923 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-6-thread-1]: now checkpoint ""
[0 segments ; isCommit = true]
[junit4] 2> 3928 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@6cdff2a
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3a55f217),segFN=segments_1,generation=1}
[junit4] 2> 3930 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 3930 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-6-thread-1]: 7 msec to
checkpoint
[junit4] 2> 3931 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: commit: took 18.6
msec
[junit4] 2> 3931 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: commit: done
[junit4] 2> 3931 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: rollback
[junit4] 2> 3931 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: all running merges
have aborted
[junit4] 2> 3931 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: rollback: done
finish merges
[junit4] 2> 3931 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-6-thread-1]: abort
[junit4] 2> 3931 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-6-thread-1]: done abort
success=true
[junit4] 2> 3931 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: rollback: infos=
[junit4] 2> 3932 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-6-thread-1]: now checkpoint ""
[0 segments ; isCommit = false]
[junit4] 2> 3933 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-6-thread-1]: 0 msec to
checkpoint
[junit4] 2> 3935 INFO (OldIndexDirectoryCleanupThreadForCore-collection1)
[ x:collection1] o.a.s.c.SolrCore Looking for old index directories to
cleanup for core collection1 in
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/data/
[junit4] 2> 3935 WARN (OldIndexDirectoryCleanupThreadForCore-collection1)
[ x:collection1] o.a.s.c.DirectoryFactory
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/data/
does not point to a valid data directory; skipping clean-up of old index
directories.
[junit4] 2> 3942 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.c.PluginBag queryResponseWriter : 'velocity' created with startup=lazy
[junit4] 2> 3957 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5
[junit4] 2> 4408 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating
implicit default
[junit4] 2> 4510 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 4517 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 4523 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 4524 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 4666 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.c.PluginBag requestHandler : '/update/extract' created with startup=lazy
[junit4] 2> 4666 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.c.PluginBag requestHandler : '/analysis/field' created with startup=lazy
[junit4] 2> 4666 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.c.PluginBag requestHandler : '/analysis/document' created with
startup=lazy
[junit4] 2> 4671 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.c.PluginBag requestHandler : '/spell' created with startup=lazy
[junit4] 2> 4671 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.c.PluginBag requestHandler : '/suggest' created with startup=lazy
[junit4] 2> 4671 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.c.PluginBag requestHandler : '/tvrh' created with startup=lazy
[junit4] 2> 4671 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.c.PluginBag requestHandler : '/terms' created with startup=lazy
[junit4] 2> 4672 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.c.PluginBag requestHandler : '/elevate' created with startup=lazy
[junit4] 2> 4672 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.c.RequestHandlers Registered paths:
/admin/mbeans,/browse,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/elevate,/update/json,/admin/threads,/query,/analysis/field,/analysis/document,/spell,/update/csv,/sql,/tvrh,/select,/admin/segments,/admin/system,/suggest,/replication,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file,/debug/dump,/terms,/update/extract
[junit4] 2> 4677 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.c.SolrCore Using default statsCache cache:
org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 4698 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 4698 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 4711 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 15000ms;
[junit4] 2> 4711 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 4714 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-6-thread-1]: init: current
segments file is "segments_1";
deletionPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper@6f2663c1
[junit4] 2> 4714 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-6-thread-1]: init: load commit
"segments_1"
[junit4] 2> 4714 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@6cdff2a
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3a55f217),segFN=segments_1,generation=1}
[junit4] 2> 4714 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 4715 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-6-thread-1]: now checkpoint ""
[0 segments ; isCommit = false]
[junit4] 2> 4715 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-6-thread-1]: 0 msec to
checkpoint
[junit4] 2> 4715 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: init: create=false
[junit4] 2> 4715 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]:
[junit4] 2> dir=MockDirectoryWrapper(RAMDirectory@6cdff2a
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3a55f217)
[junit4] 2> index=
[junit4] 2> version=6.0.0
[junit4] 2>
analyzer=org.apache.solr.update.SolrIndexConfig$DelayedSchemaAnalyzer
[junit4] 2> ramBufferSizeMB=100.0
[junit4] 2> maxBufferedDocs=-1
[junit4] 2> maxBufferedDeleteTerms=-1
[junit4] 2> mergedSegmentWarmer=null
[junit4] 2> delPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper
[junit4] 2> commit=null
[junit4] 2> openMode=APPEND
[junit4] 2>
similarity=org.apache.solr.search.similarities.SchemaSimilarityFactory$1
[junit4] 2> mergeScheduler=ConcurrentMergeScheduler: maxThreadCount=-1,
maxMergeCount=-1, ioThrottle=true
[junit4] 2> codec=Lucene60
[junit4] 2> infoStream=org.apache.solr.update.LoggingInfoStream
[junit4] 2> mergePolicy=[TieredMergePolicy: maxMergeAtOnce=10,
maxMergeAtOnceExplicit=30, maxMergedSegmentMB=5120.0, floorSegmentMB=2.0,
forceMergeDeletesPctAllowed=10.0, segmentsPerTier=10.0,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1
[junit4] 2>
indexerThreadPool=org.apache.lucene.index.DocumentsWriterPerThreadPool@72e55de6
[junit4] 2> readerPooling=false
[junit4] 2> perThreadHardLimitMB=1945
[junit4] 2> useCompoundFile=false
[junit4] 2> commitOnClose=true
[junit4] 2> writer=org.apache.solr.update.SolrIndexWriter@4bc2b3b8
[junit4] 2>
[junit4] 2> 4715 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]:
MMapDirectory.UNMAP_SUPPORTED=true
[junit4] 2> 4719 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: flush at getReader
[junit4] 2> 4719 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-6-thread-1]: startFullFlush
[junit4] 2> 4720 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: apply all deletes
during flush
[junit4] 2> 4720 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: now apply all
deletes for all segments maxDoc=0
[junit4] 2> 4720 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-6-thread-1]: prune
sis=segments_1: minGen=9223372036854775807 packetCount=0
[junit4] 2> 4724 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: incRefDeleter for
NRT reader version=2 segments=
[junit4] 2> 4724 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: return reader
version=2 reader=StandardDirectoryReader(segments_1:2:nrt)
[junit4] 2> 4724 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-6-thread-1]:
coreLoadExecutor-6-thread-1 finishFullFlush success=true
[junit4] 2> 4724 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-6-thread-1]: getReader took 5
msec
[junit4] 2> 4754 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening Searcher@68f8abc5[collection1] main
[junit4] 2> 4767 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir:
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/conf
[junit4] 2> 4768 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.r.RestManager Initializing RestManager with initArgs:
{storageDir=/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/conf}
[junit4] 2> 4770 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using
file:dir=/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/conf
[junit4] 2> 4774 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.r.ManagedResourceStorage Loaded LinkedHashMap at path _rest_managed.json
using
file:dir=/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/conf
[junit4] 2> 4775 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.r.ManagedResource Loaded initArgs {} for /rest/managed
[junit4] 2> 4775 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.r.RestManager Initializing 2 registered ManagedResources
[junit4] 2> 4775 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.r.ManagedResourceStorage Reading _schema_analysis_stopwords_english.json
using
file:dir=/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/conf
[junit4] 2> 4777 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.r.ManagedResourceStorage Loaded LinkedHashMap at path
_schema_analysis_stopwords_english.json using
file:dir=/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/conf
[junit4] 2> 4777 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.r.ManagedResource Loaded initArgs {ignoreCase=true} for
/schema/analysis/stopwords/english
[junit4] 2> 4777 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.r.s.a.ManagedWordSetResource Loaded 35 words for
/schema/analysis/stopwords/english
[junit4] 2> 4778 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.r.ManagedResource Notified 2 observers of
/schema/analysis/stopwords/english
[junit4] 2> 4778 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.r.ManagedResourceStorage Reading _schema_analysis_synonyms_english.json
using
file:dir=/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/conf
[junit4] 2> 4779 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.r.ManagedResourceStorage Loaded LinkedHashMap at path
_schema_analysis_synonyms_english.json using
file:dir=/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/conf
[junit4] 2> 4779 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.r.ManagedResource Loaded initArgs {ignoreCase=true,format=solr} for
/schema/analysis/synonyms/english
[junit4] 2> 4780 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.r.s.a.ManagedSynonymFilterFactory Loaded 3 synonym mappings for
/schema/analysis/synonyms/english
[junit4] 2> 4786 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.r.ManagedResource Notified 2 observers of
/schema/analysis/synonyms/english
[junit4] 2> 4806 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 4818 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.s.DirectSolrSpellChecker init:
{name=default,field=text,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4,maxQueryFrequency=0.01}
[junit4] 2> 4838 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent No queryConverter defined, using default converter
[junit4] 2> 4840 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.h.c.SuggestComponent Initializing SuggestComponent
[junit4] 2> 4846 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.s.s.SolrSuggester init:
{name=mySuggester,lookupImpl=FuzzyLookupFactory,dictionaryImpl=DocumentDictionaryFactory,field=cat,weightField=price,suggestAnalyzerFieldType=string,buildOnStartup=false}
[junit4] 2> 4915 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.s.s.SolrSuggester Dictionary loaded with params:
{name=mySuggester,lookupImpl=FuzzyLookupFactory,dictionaryImpl=DocumentDictionaryFactory,field=cat,weightField=price,suggestAnalyzerFieldType=string,buildOnStartup=false}
[junit4] 2> 4919 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.h.c.QueryElevationComponent Loading QueryElevation from:
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/conf/elevate.xml
[junit4] 2> 5012 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 5045 INFO
(searcherExecutor-7-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.QuerySenderListener QuerySenderListener sending requests to
Searcher@68f8abc5[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 5057 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets
[junit4] 2> 5058 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version
buckets from index
[junit4] 2> 5058 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket
highest value from index
[junit4] 2> 5058 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1521188368712466432
[junit4] 2> 5076 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.u.UpdateLog Took 17.0ms to seed version buckets with highest version
1521188368712466432
[junit4] 2> 5084 INFO (coreLoadExecutor-6-thread-1) [ x:collection1]
o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 5209 INFO
(searcherExecutor-7-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=static+firstSearcher+warming+in+solrconfig.xml&distrib=false&event=firstSearcher}
hits=0 status=0 QTime=158
[junit4] 2> 5210 INFO
(searcherExecutor-7-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 5210 INFO
(searcherExecutor-7-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 5211 INFO
(searcherExecutor-7-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 5212 INFO
(searcherExecutor-7-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@68f8abc5[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 5355 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.a.s.SolrJettyTestBase Jetty Assigned Port#33129
[junit4] 2> 5370 INFO
(TEST-SolrExampleStreamingBinaryTest.testUpdateField-seed#[EC056F9D893F1A9A]) [
] o.a.s.SolrTestCaseJ4 ###Starting testUpdateField
[junit4] 2> 5749 INFO (qtp1842250958-20) [ x:collection1]
o.a.s.u.LoggingInfoStream [DW][qtp1842250958-20]: anyChanges? numDocsInRam=0
deletes=true hasTickets:false pendingChangesInFullFlush: false
[junit4] 2> 5750 INFO (qtp1842250958-20) [ x:collection1]
o.a.s.u.LoggingInfoStream [DW][qtp1842250958-20]: anyChanges? numDocsInRam=0
deletes=true hasTickets:false pendingChangesInFullFlush: false
[junit4] 2> 5750 INFO (qtp1842250958-20) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-20]: nrtIsCurrent: infoVersion
matches: true; DW changes: true; BD changes: false
[junit4] 2> 5750 INFO (qtp1842250958-20) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-20]: flush at getReader
[junit4] 2> 5750 INFO (qtp1842250958-20) [ x:collection1]
o.a.s.u.LoggingInfoStream [DW][qtp1842250958-20]: startFullFlush
[junit4] 2> 5750 INFO (qtp1842250958-20) [ x:collection1]
o.a.s.u.LoggingInfoStream [DW][qtp1842250958-20]: anyChanges? numDocsInRam=0
deletes=true hasTickets:false pendingChangesInFullFlush: false
[junit4] 2> 5751 INFO (qtp1842250958-20) [ x:collection1]
o.a.s.u.LoggingInfoStream [DW][qtp1842250958-20]: qtp1842250958-20: flush naked
frozen global deletes
[junit4] 2> 5761 INFO (qtp1842250958-20) [ x:collection1]
o.a.s.u.LoggingInfoStream [BD][qtp1842250958-20]: push deletes 1 deleted
queries bytesUsed=80 segmentPrivate?=false delGen=2 packetCount=1
totBytesUsed=80
[junit4] 2> 5762 INFO (qtp1842250958-20) [ x:collection1]
o.a.s.u.LoggingInfoStream [DW][qtp1842250958-20]: flush: push buffered updates:
1 deleted queries bytesUsed=80
[junit4] 2> 5762 INFO (qtp1842250958-20) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-20]: apply all deletes during flush
[junit4] 2> 5762 INFO (qtp1842250958-20) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-20]: now apply all deletes for all
segments maxDoc=0
[junit4] 2> 5762 INFO (qtp1842250958-20) [ x:collection1]
o.a.s.u.LoggingInfoStream [BD][qtp1842250958-20]: prune sis=segments_1:
minGen=9223372036854775807 packetCount=1
[junit4] 2> 5762 INFO (qtp1842250958-20) [ x:collection1]
o.a.s.u.LoggingInfoStream [BD][qtp1842250958-20]: pruneDeletes: prune 1
packets; 0 packets remain
[junit4] 2> 5762 INFO (qtp1842250958-20) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-20]: incRefDeleter for NRT reader
version=2 segments=
[junit4] 2> 5762 INFO (qtp1842250958-20) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-20]: return reader version=2
reader=StandardDirectoryReader(segments_1:2:nrt)
[junit4] 2> 5762 INFO (qtp1842250958-20) [ x:collection1]
o.a.s.u.LoggingInfoStream [DW][qtp1842250958-20]: qtp1842250958-20
finishFullFlush success=true
[junit4] 2> 5763 INFO (qtp1842250958-20) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-20]: getReader took 13 msec
[junit4] 2> 5763 INFO (qtp1842250958-20) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-20]: decRefDeleter for NRT reader
version=2 segments=
[junit4] 2> 5781 INFO (qtp1842250958-20) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
params={wt=javabin&version=2}{deleteByQuery=*:* (-1521188369410818048)} 0 86
[junit4] 2> 5867 INFO (qtp1842250958-19) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 5868 INFO (qtp1842250958-19) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 5870 INFO (qtp1842250958-19) [ x:collection1]
o.a.s.c.SolrCore SolrIndexSearcher has not changed - not re-opening:
org.apache.solr.search.SolrIndexSearcher
[junit4] 2> 5875 INFO (qtp1842250958-19) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 5876 INFO (qtp1842250958-19) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
0 10
[junit4] 2> 6160 INFO (qtp1842250958-18) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
params={wt=javabin&version=2}{add=[unique (1521188369615290368)]} 0 250
[junit4] 2> 6164 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 6165 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-21]: commit: start
[junit4] 2> 6165 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-21]: commit: enter lock
[junit4] 2> 6165 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-21]: commit: now prepare
[junit4] 2> 6165 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-21]: prepareCommit: flush
[junit4] 2> 6165 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-21]: index before flush
[junit4] 2> 6165 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [DW][qtp1842250958-21]: startFullFlush
[junit4] 2> 6166 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [DW][qtp1842250958-21]: anyChanges? numDocsInRam=1
deletes=true hasTickets:false pendingChangesInFullFlush: false
[junit4] 2> 6166 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [DWFC][qtp1842250958-21]: addFlushableState
DocumentsWriterPerThread [pendingDeletes=gen=0, segment=_0, aborted=false,
numDocsInRAM=1, deleteQueue=DWDQ: [ generation: 2 ]]
[junit4] 2> 6170 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [DWPT][qtp1842250958-21]: flush postings as segment
_0 numDocs=1
[junit4] 2> 6209 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [DWPT][qtp1842250958-21]: new segment has 0 deleted
docs
[junit4] 2> 6209 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [DWPT][qtp1842250958-21]: new segment has no vectors;
norms; no docValues; prox; freqs
[junit4] 2> 6209 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [DWPT][qtp1842250958-21]:
flushedFiles=[_0_Lucene50_0.doc, _0_Lucene50_0.tim, _0_Lucene50_0.pos, _0.nvd,
_0.fdx, _0_Lucene50_0.tip, _0.fdt, _0.nvm, _0.fnm]
[junit4] 2> 6209 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [DWPT][qtp1842250958-21]: flushed codec=Lucene60
[junit4] 2> 6212 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [DWPT][qtp1842250958-21]: flushed: segment=_0
ramUsed=0.103 MB newFlushedSize=0.002 MB docs/MB=660.312
[junit4] 2> 6214 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [DWPT][qtp1842250958-21]: flush time 43.661953 msec
[junit4] 2> 6217 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [DW][qtp1842250958-21]: publishFlushedSegment
seg-private updates=null
[junit4] 2> 6217 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-21]: publishFlushedSegment
[junit4] 2> 6219 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [BD][qtp1842250958-21]: push deletes 1 deleted terms
(unique count=1) bytesUsed=1072 segmentPrivate?=false delGen=4 packetCount=1
totBytesUsed=1072
[junit4] 2> 6219 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-21]: publish sets newSegment
delGen=5 seg=_0(6.0.0):C1
[junit4] 2> 6220 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [IFD][qtp1842250958-21]: now checkpoint
"_0(6.0.0):C1" [1 segments ; isCommit = false]
[junit4] 2> 6220 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [IFD][qtp1842250958-21]: 0 msec to checkpoint
[junit4] 2> 6220 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-21]: apply all deletes during flush
[junit4] 2> 6220 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-21]: now apply all deletes for all
segments maxDoc=1
[junit4] 2> 6220 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [BD][qtp1842250958-21]: applyDeletes: open segment
readers took 0 msec
[junit4] 2> 6220 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [BD][qtp1842250958-21]: applyDeletes:
infos=[_0(6.0.0):C1] packetCount=1
[junit4] 2> 6221 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [BD][qtp1842250958-21]: applyDeletes took 0 msec for
1 segments, 0 newly deleted docs (query deletes), 0 visited terms,
allDeleted=null
[junit4] 2> 6221 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [BD][qtp1842250958-21]: prune sis=segments_1:
_0(6.0.0):C1 minGen=5 packetCount=1
[junit4] 2> 6221 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [BD][qtp1842250958-21]: pruneDeletes: prune 1
packets; 0 packets remain
[junit4] 2> 6221 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [DW][qtp1842250958-21]: qtp1842250958-21
finishFullFlush success=true
[junit4] 2> 6221 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [TMP][qtp1842250958-21]: findMerges: 1 segments
[junit4] 2> 6223 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [TMP][qtp1842250958-21]: seg=_0(6.0.0):C1
size=0.002 MB [floored]
[junit4] 2> 6223 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [TMP][qtp1842250958-21]: allowedSegmentCount=1 vs
count=1 (eligible count=1) tooBigCount=0
[junit4] 2> 6223 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [MS][qtp1842250958-21]: initDynamicDefaults
spins=true maxThreadCount=1 maxMergeCount=6
[junit4] 2> 6223 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [MS][qtp1842250958-21]: now merge
[junit4] 2> 6223 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [MS][qtp1842250958-21]: index: _0(6.0.0):C1
[junit4] 2> 6223 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [MS][qtp1842250958-21]: no more merges pending; now
return
[junit4] 2> 6223 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-21]: startCommit(): start
[junit4] 2> 6223 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-21]: startCommit
index=_0(6.0.0):C1 changeCount=4
[junit4] 2> 6224 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-21]: startCommit: wrote pending
segments file "pending_segments_2"
[junit4] 2> 6225 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-21]: done all syncs: [_0.si,
_0_Lucene50_0.doc, _0_Lucene50_0.tim, _0_Lucene50_0.pos, _0.nvd, _0.fdx,
_0_Lucene50_0.tip, _0.fdt, _0.nvm, _0.fnm]
[junit4] 2> 6225 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-21]: commit: pendingCommit != null
[junit4] 2> 6225 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-21]: commit: done writing segments
file "segments_2"
[junit4] 2> 6225 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [IFD][qtp1842250958-21]: now checkpoint
"_0(6.0.0):C1" [1 segments ; isCommit = true]
[junit4] 2> 6225 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@6cdff2a
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3a55f217),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@6cdff2a
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3a55f217),segFN=segments_2,generation=2}
[junit4] 2> 6225 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.c.SolrDeletionPolicy newest commit generation = 2
[junit4] 2> 6226 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [IFD][qtp1842250958-21]: deleteCommits: now decRef
commit "segments_1"
[junit4] 2> 6226 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [IFD][qtp1842250958-21]: delete "segments_1"
[junit4] 2> 6226 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [IFD][qtp1842250958-21]: 1 msec to checkpoint
[junit4] 2> 6226 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-21]: commit: took 60.7 msec
[junit4] 2> 6226 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-21]: commit: done
[junit4] 2> 6226 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-21]: nrtIsCurrent: infoVersion
matches: false; DW changes: false; BD changes: false
[junit4] 2> 6226 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-21]: flush at getReader
[junit4] 2> 6227 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [DW][qtp1842250958-21]: startFullFlush
[junit4] 2> 6227 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-21]: apply all deletes during flush
[junit4] 2> 6227 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-21]: now apply all deletes for all
segments maxDoc=1
[junit4] 2> 6227 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [BD][qtp1842250958-21]: applyDeletes: open segment
readers took 0 msec
[junit4] 2> 6227 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [BD][qtp1842250958-21]: applyDeletes: no segments;
skipping
[junit4] 2> 6227 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [BD][qtp1842250958-21]: prune sis=segments_2:
_0(6.0.0):C1 minGen=5 packetCount=0
[junit4] 2> 6255 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-21]: incRefDeleter for NRT reader
version=6 segments=_0(6.0.0):C1
[junit4] 2> 6255 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-21]: return reader version=6
reader=StandardDirectoryReader(segments_2:6:nrt _0(6.0.0):C1)
[junit4] 2> 6255 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [DW][qtp1842250958-21]: qtp1842250958-21
finishFullFlush success=true
[junit4] 2> 6255 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.LoggingInfoStream [IW][qtp1842250958-21]: getReader took 29 msec
[junit4] 2> 6258 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening Searcher@71c2b84c[collection1] main
[junit4] 2> 6261 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 6261 INFO
(searcherExecutor-7-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.QuerySenderListener QuerySenderListener sending requests to
Searcher@71c2b84c[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C1)))}
[junit4] 2> 6261 INFO
(searcherExecutor-7-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 6261 INFO
(searcherExecutor-7-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@71c2b84c[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C1)))}
[junit4] 2> 6261 INFO
(searcherExecutor-7-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.LoggingInfoStream
[IW][searcherExecutor-7-thread-1-processing-x:collection1]: decRefDeleter for
NRT reader version=2 segments=
[junit4] 2> 6261 INFO (qtp1842250958-21) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
0 98
[junit4] 2> 6286 INFO (qtp1842250958-22) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/select
params={q=*:*&fl=id,price_f,name,_version_&wt=javabin&version=2} hits=1
status=0 QTime=13
[junit4] 2> 6329 INFO (qtp1842250958-15) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
params={wt=javabin&version=2}{} 0 37
[junit4] 2> 6542 INFO
(concurrentUpdateScheduler-3-thread-1-processing-http:////127.0.0.1:33129//solr//collection1)
[ ] o.a.h.i.c.SystemDefaultHttpClient I/O exception
(java.net.SocketException) caught when processing request to
{}->http://127.0.0.1:33129: Connection reset
[junit4] 2> 6542 INFO
(concurrentUpdateScheduler-3-thread-1-processing-http:////127.0.0.1:33129//solr//collection1)
[ ] o.a.h.i.c.SystemDefaultHttpClient Retrying request to
{}->http://127.0.0.1:33129
[junit4] 2> 6545 INFO (qtp1842250958-18) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
params={wt=javabin&version=2}{} 0 1
[junit4] 2> 6793 INFO
(concurrentUpdateScheduler-3-thread-1-processing-http:////127.0.0.1:33129//solr//collection1)
[ ] o.a.h.i.c.SystemDefaultHttpClient I/O exception
(java.net.SocketException) caught when processing request to
{}->http://127.0.0.1:33129: Connection reset
[junit4] 2> 6793 INFO
(concurrentUpdateScheduler-3-thread-1-processing-http:////127.0.0.1:33129//solr//collection1)
[ ] o.a.h.i.c.SystemDefaultHttpClient Retrying request to
{}->http://127.0.0.1:33129
[junit4] 2> 6795 INFO (qtp1842250958-19) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
params={wt=javabin&version=2}{} 0 0
[junit4] 2> 7045 INFO
(concurrentUpdateScheduler-3-thread-1-processing-http:////127.0.0.1:33129//solr//collection1)
[ ] o.a.h.i.c.SystemDefaultHttpClient I/O exception
(java.net.SocketException) caught when processing request to
{}->http://127.0.0.1:33129: Connection reset
[junit4] 2> 7046 INFO
(concurrentUpdateScheduler-3-thread-1-processing-http:////127.0.0.1:33129//solr//collection1)
[ ] o.a.h.i.c.SystemDefaultHttpClient Retrying request to
{}->http://127.0.0.1:33129
[junit4] 2> 7050 INFO (qtp1842250958-16) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
params={wt=javabin&version=2}{} 0 0
[junit4] 2> 7303 INFO (qtp1842250958-20) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 7303 INFO (qtp1842250958-20) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 7303 INFO (qtp1842250958-20) [ x:collection1]
o.a.s.c.SolrCore SolrIndexSearcher has not changed - not re-opening:
org.apache.solr.search.SolrIndexSearcher
[junit4] 2> 7303 INFO (qtp1842250958-20) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 7303 INFO (qtp1842250958-20) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
0 1
[junit4] 2> 7305 INFO
(TEST-SolrExampleStreamingBinaryTest.testUpdateField-seed#[EC056F9D893F1A9A]) [
] o.a.s.SolrTestCaseJ4 ###Ending testUpdateField
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=SolrExampleStreamingBinaryTest -Dtests.method=testUpdateField
-Dtests.seed=EC056F9D893F1A9A -Dtests.slow=true -Dtests.locale=es
-Dtests.timezone=America/Dawson -Dtests.asserts=true
-Dtests.file.encoding=ISO-8859-1
[junit4] FAILURE 1.96s | SolrExampleStreamingBinaryTest.testUpdateField <<<
[junit4] > Throwable #1: java.lang.AssertionError:
ConcurrentUpdateSolrClient did not report an error
[junit4] > at
__randomizedtesting.SeedInfo.seed([EC056F9D893F1A9A:B976C5C949170A5C]:0)
[junit4] > at
org.apache.solr.client.solrj.SolrExampleTests.testUpdateField(SolrExampleTests.java:1633)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 7325 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.e.j.s.ServerConnector Stopped
ServerConnector@3b2c45{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 7326 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=62491411
[junit4] 2> 7326 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@450e9f8d
[junit4] 2> 7327 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.DirectUpdateHandler2 closing
DirectUpdateHandler2{commits=3,autocommit maxTime=15000ms,autocommits=0,soft
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=1,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0,transaction_logs_total_size=191,transaction_logs_total_number=2}
[junit4] 2> 7328 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 7329 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached
0 - closing IndexWriter
[junit4] 2> 7329 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with
IndexWriterCloser
[junit4] 2> 7334 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[IW][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]: now
flush at close
[junit4] 2> 7334 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[IW][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]:
start flush: applyAllDeletes=true
[junit4] 2> 7334 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[IW][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]:
index before flush _0(6.0.0):C1
[junit4] 2> 7334 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[DW][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]:
startFullFlush
[junit4] 2> 7334 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[DW][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]:
SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker
finishFullFlush success=true
[junit4] 2> 7334 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[IW][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]:
apply all deletes during flush
[junit4] 2> 7334 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[IW][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]: now
apply all deletes for all segments maxDoc=1
[junit4] 2> 7334 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[BD][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]:
applyDeletes: open segment readers took 0 msec
[junit4] 2> 7334 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[BD][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]:
applyDeletes: no segments; skipping
[junit4] 2> 7334 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[BD][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]:
prune sis=segments_2: _0(6.0.0):C1 minGen=5 packetCount=0
[junit4] 2> 7335 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[MS][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]:
updateMergeThreads ioThrottle=true targetMBPerSec=10240.0 MB/sec
[junit4] 2> 7335 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[MS][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]: now
merge
[junit4] 2> 7335 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[MS][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]:
index: _0(6.0.0):C1
[junit4] 2> 7335 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[MS][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]: no
more merges pending; now return
[junit4] 2> 7335 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[IW][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]:
waitForMerges
[junit4] 2> 7335 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[IW][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]:
waitForMerges done
[junit4] 2> 7335 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[IW][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]:
commit: start
[junit4] 2> 7335 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[IW][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]:
commit: enter lock
[junit4] 2> 7335 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[IW][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]:
commit: now prepare
[junit4] 2> 7335 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[IW][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]:
prepareCommit: flush
[junit4] 2> 7335 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[IW][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]:
index before flush _0(6.0.0):C1
[junit4] 2> 7335 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[DW][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]:
startFullFlush
[junit4] 2> 7336 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[IW][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]:
apply all deletes during flush
[junit4] 2> 7336 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[IW][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]: now
apply all deletes for all segments maxDoc=1
[junit4] 2> 7336 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[BD][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]:
applyDeletes: open segment readers took 0 msec
[junit4] 2> 7336 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[BD][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]:
applyDeletes: no segments; skipping
[junit4] 2> 7336 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[BD][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]:
prune sis=segments_2: _0(6.0.0):C1 minGen=5 packetCount=0
[junit4] 2> 7336 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[DW][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]:
SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker
finishFullFlush success=true
[junit4] 2> 7336 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[IW][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]:
startCommit(): start
[junit4] 2> 7336 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[IW][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]:
skip startCommit(): no changes pending
[junit4] 2> 7336 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[IW][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]:
commit: pendingCommit == null; skip
[junit4] 2> 7337 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[IW][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]:
commit: took 1.2 msec
[junit4] 2> 7337 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[IW][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]:
commit: done
[junit4] 2> 7337 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[IW][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]:
rollback
[junit4] 2> 7337 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[IW][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]: all
running merges have aborted
[junit4] 2> 7337 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[IW][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]:
rollback: done finish merges
[junit4] 2> 7337 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[DW][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]: abort
[junit4] 2> 7337 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[DW][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]: done
abort success=true
[junit4] 2> 7337 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[IW][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]:
rollback: infos=_0(6.0.0):C1
[junit4] 2> 7337 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[IFD][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]: now
checkpoint "_0(6.0.0):C1" [1 segments ; isCommit = false]
[junit4] 2> 7337 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.u.LoggingInfoStream
[IFD][SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker]: 0
msec to checkpoint
[junit4] 2> 7338 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
[junit4] 2> 7348 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2
directories currently being tracked
[junit4] 2> 7349 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.c.CachingDirectoryFactory looking to close
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/data
[CachedDir<<refCount=0;path=/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/data;done=false>>]
[junit4] 2> 7349 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory:
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/data
[junit4] 2> 7349 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.c.CachingDirectoryFactory looking to close
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/data/index
[CachedDir<<refCount=0;path=/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/data/index;done=false>>]
[junit4] 2> 7350 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory:
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001/tempDir-001/collection1/data/index
[junit4] 2> 7352 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [
x:collection1] o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@6ec49310{/solr,null,UNAVAILABLE}
[junit4] 2> 7355 INFO
(SUITE-SolrExampleStreamingBinaryTest-seed#[EC056F9D893F1A9A]-worker) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/ishan/code/lucene-solr-svn/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.embedded.SolrExampleStreamingBinaryTest_EC056F9D893F1A9A-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene60): {},
docValues:{}, sim=ClassicSimilarity, locale=es, timezone=America/Dawson
[junit4] 2> NOTE: Linux 4.2.8-300.fc23.x86_64 amd64/Oracle Corporation
1.8.0_65 (64-bit)/cpus=4,threads=1,free=131111776,total=251658240
[junit4] 2> NOTE: All tests run in this JVM:
[SolrExampleStreamingBinaryTest]
[junit4] Completed [1/1 (1!)] in 8.61s, 1 test, 1 failure <<< FAILURES!
[junit4]
[junit4]
[junit4] Tests with failures [seed: EC056F9D893F1A9A]:
[junit4] -
org.apache.solr.client.solrj.embedded.SolrExampleStreamingBinaryTest.testUpdateField
[junit4]
[junit4]
[junit4] JVM J0: 1.04 .. 10.55 = 9.51s
[junit4] Execution time total: 10 seconds
[junit4] Tests summary: 1 suite, 1 test, 1 failure
BUILD FAILED
/home/ishan/code/lucene-solr-svn/solr/build.xml:246: The following error
occurred while executing this line:
/home/ishan/code/lucene-solr-svn/solr/common-build.xml:516: The following error
occurred while executing this line:
/home/ishan/code/lucene-solr-svn/lucene/common-build.xml:1436: The following
error occurred while executing this line:
/home/ishan/code/lucene-solr-svn/lucene/common-build.xml:991: There were test
failures: 1 suite, 1 test, 1 failure [seed: EC056F9D893F1A9A]
Total time: 2 minutes 45 seconds
[ishan@x230 solr]$
{code}
> Upgrade Jetty from 9.2 to 9.3
> -----------------------------
>
> Key: SOLR-7339
> URL: https://issues.apache.org/jira/browse/SOLR-7339
> Project: Solr
> Issue Type: Improvement
> Reporter: Gregg Donovan
> Assignee: Shalin Shekhar Mangar
> Fix For: Trunk
>
> Attachments: SOLR-7339.patch, SOLR-7339.patch,
> SolrExampleStreamingBinaryTest.testUpdateField-jetty92.pcapng,
> SolrExampleStreamingBinaryTest.testUpdateField-jetty93.pcapng
>
>
> Jetty 9.3 offers support for HTTP/2. Interest in HTTP/2 or its predecessor
> SPDY was shown in [SOLR-6699|https://issues.apache.org/jira/browse/SOLR-6699]
> and [on the mailing list|http://markmail.org/message/jyhcmwexn65gbdsx].
> Among the HTTP/2 benefits over HTTP/1.1 relevant to Solr are:
> * multiplexing requests over a single TCP connection ("streams")
> * canceling a single request without closing the TCP connection
> * removing [head-of-line
> blocking|https://http2.github.io/faq/#why-is-http2-multiplexed]
> * header compression
> Caveats:
> * Jetty 9.3 is at M2, not released.
> * Full Solr support for HTTP/2 would require more work than just upgrading
> Jetty. The server configuration would need to change and a new HTTP client
> ([Jetty's own
> client|https://github.com/eclipse/jetty.project/tree/master/jetty-http2],
> [Square's OkHttp|http://square.github.io/okhttp/],
> [etc.|https://github.com/http2/http2-spec/wiki/Implementations]) would need
> to be selected and wired up. Perhaps this is worthy of a branch?
--
This message was sent by Atlassian JIRA
(v6.3.4#6332)
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
