Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/10996/
Java: 32bit/jdk1.8.0_20-ea-b23 -server -XX:+UseG1GC
2 tests failed.
FAILED:
junit.framework.TestSuite.org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta
Error Message:
1 thread leaked from SUITE scope at
org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta: 1)
Thread[id=34, name=Timer-0, state=WAITING,
group=TGRP-TestSqlEntityProcessorDelta] at java.lang.Object.wait(Native
Method) at java.lang.Object.wait(Object.java:502) at
java.util.TimerThread.mainLoop(Timer.java:526) at
java.util.TimerThread.run(Timer.java:505)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE
scope at org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta:
1) Thread[id=34, name=Timer-0, state=WAITING,
group=TGRP-TestSqlEntityProcessorDelta]
at java.lang.Object.wait(Native Method)
at java.lang.Object.wait(Object.java:502)
at java.util.TimerThread.mainLoop(Timer.java:526)
at java.util.TimerThread.run(Timer.java:505)
at __randomizedtesting.SeedInfo.seed([561931E3FDF992BB]:0)
FAILED:
junit.framework.TestSuite.org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta
Error Message:
There are still zombie threads that couldn't be terminated: 1) Thread[id=34,
name=Timer-0, state=WAITING, group=TGRP-TestSqlEntityProcessorDelta] at
java.lang.Object.wait(Native Method) at
java.lang.Object.wait(Object.java:502) at
java.util.TimerThread.mainLoop(Timer.java:526) at
java.util.TimerThread.run(Timer.java:505)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
1) Thread[id=34, name=Timer-0, state=WAITING,
group=TGRP-TestSqlEntityProcessorDelta]
at java.lang.Object.wait(Native Method)
at java.lang.Object.wait(Object.java:502)
at java.util.TimerThread.mainLoop(Timer.java:526)
at java.util.TimerThread.run(Timer.java:505)
at __randomizedtesting.SeedInfo.seed([561931E3FDF992BB]:0)
Build Log:
[...truncated 15093 lines...]
[junit4] Suite:
org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta
[junit4] 2> Creating dataDir:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001
[junit4] 2> 8680 T33 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl
(false) and clientAuth (false)
[junit4] 2> 9825 T33 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> 9825 T33 oasc.SolrResourceLoader.<init> new SolrResourceLoader
for directory:
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/core-home-001/collection1/'
[junit4] 2> 9875 T33 oasc.SolrConfig.<init> Using Lucene MatchVersion:
LUCENE_5_0
[junit4] 2> 9924 T33 oasc.SolrConfig.<init> Loaded SolrConfig:
dataimport-solrconfig.xml
[junit4] 2> 9925 T33 oass.IndexSchema.readSchema Reading Solr Schema from
dataimport-schema.xml
[junit4] 2> 9936 T33 oass.IndexSchema.readSchema [null] Schema
name=dih_test
[junit4] 2> 9980 T33 oass.IndexSchema.readSchema default search field in
schema is desc
[junit4] 2> 9981 T33 oass.IndexSchema.readSchema query parser default
operator is OR
[junit4] 2> 9981 T33 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 9982 T33 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 9982 T33 oasc.SolrResourceLoader.locateSolrHome using system
property solr.solr.home:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/core-home-001
[junit4] 2> 9983 T33 oasc.SolrResourceLoader.<init> new SolrResourceLoader
for directory:
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/core-home-001/'
[junit4] 2> 10051 T33 oasc.CoreContainer.<init> New CoreContainer 6910676
[junit4] 2> 10052 T33 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/core-home-001/]
[junit4] 2> 10052 T33 oashc.HttpShardHandlerFactory.getParameter Setting
socketTimeout to: 0
[junit4] 2> 10052 T33 oashc.HttpShardHandlerFactory.getParameter Setting
urlScheme to: null
[junit4] 2> 10053 T33 oashc.HttpShardHandlerFactory.getParameter Setting
connTimeout to: 0
[junit4] 2> 10053 T33 oashc.HttpShardHandlerFactory.getParameter Setting
maxConnectionsPerHost to: 20
[junit4] 2> 10053 T33 oashc.HttpShardHandlerFactory.getParameter Setting
corePoolSize to: 0
[junit4] 2> 10053 T33 oashc.HttpShardHandlerFactory.getParameter Setting
maximumPoolSize to: 2147483647
[junit4] 2> 10054 T33 oashc.HttpShardHandlerFactory.getParameter Setting
maxThreadIdleTime to: 5
[junit4] 2> 10054 T33 oashc.HttpShardHandlerFactory.getParameter Setting
sizeOfQueue to: -1
[junit4] 2> 10054 T33 oashc.HttpShardHandlerFactory.getParameter Setting
fairnessPolicy to: false
[junit4] 2> 10055 T33 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=30000&connTimeout=30000&retry=false
[junit4] 2> 10055 T33 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 10055 T33 oasl.LogWatcher.newRegisteredLogWatcher Registering
Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 10055 T33 oasc.CoreContainer.load Host Name:
[junit4] 2> 10059 T35 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/core-home-001/collection1/'
[junit4] 2> 10131 T35 oasc.SolrConfig.<init> Using Lucene MatchVersion:
LUCENE_5_0
[junit4] 2> 10171 T35 oasc.SolrConfig.<init> Loaded SolrConfig:
dataimport-solrconfig.xml
[junit4] 2> 10172 T35 oass.IndexSchema.readSchema Reading Solr Schema from
dataimport-schema.xml
[junit4] 2> 10182 T35 oass.IndexSchema.readSchema [collection1] Schema
name=dih_test
[junit4] 2> 10203 T35 oass.IndexSchema.readSchema default search field in
schema is desc
[junit4] 2> 10204 T35 oass.IndexSchema.readSchema query parser default
operator is OR
[junit4] 2> 10205 T35 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 10206 T35 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from instancedir
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/core-home-001/collection1/
[junit4] 2> 10206 T35 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 10206 T35 oasc.SolrCore.<init> [collection1] Opening new
SolrCore at
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/core-home-001/collection1/,
dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/
[junit4] 2> 10207 T35 oasc.SolrCore.<init> JMX monitoring not detected for
core: collection1
[junit4] 2> 10207 T35 oasc.SolrCore.initListeners [collection1] Added
SolrEventListener for newSearcher:
org.apache.solr.core.QuerySenderListener{queries=[{q=solr,start=0,rows=10},
{q=rocks,start=0,rows=10}, {q=static newSearcher warming query from
solrconfig.xml}]}
[junit4] 2> 10207 T35 oasc.SolrCore.initListeners [collection1] Added
SolrEventListener for firstSearcher:
org.apache.solr.core.QuerySenderListener{queries=[]}
[junit4] 2> 10212 T35 oasc.CachingDirectoryFactory.get return new
directory for
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001
[junit4] 2> 10213 T35 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index/
[junit4] 2> 10213 T35 oasc.SolrCore.initIndex WARN [collection1] Solr
index directory
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index'
doesn't exist. Creating new index...
[junit4] 2> 10214 T35 oasc.CachingDirectoryFactory.get return new
directory for
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index
[junit4] 2> 10215 T35 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1d30558
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index),segFN=segments_1,generation=1}
[junit4] 2> 10216 T35 oasc.SolrDeletionPolicy.updateCommits newest commit
generation = 1
[junit4] 2> 10221 T35 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "" (default)
[junit4] 2> 10222 T35 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "" (default)
[junit4] 2> 10222 T35 oasc.RequestHandlers.initHandlersFromConfig created
/update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 10222 T35 oasc.RequestHandlers.initHandlersFromConfig created
/update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 10223 T35 oasc.RequestHandlers.initHandlersFromConfig created
/update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 10223 T35 oasc.RequestHandlers.initHandlersFromConfig created
/update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 10227 T35 oasc.RequestHandlers.initHandlersFromConfig created
standard: solr.StandardRequestHandler
[junit4] 2> 10228 T35 oasc.RequestHandlers.initHandlersFromConfig created
/dataimport: org.apache.solr.handler.dataimport.DataImportHandler
[junit4] 2> 10228 T35 oasc.RequestHandlers.initHandlersFromConfig created
/search: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 10229 T35 oasc.RequestHandlers.initHandlersFromConfig WARN
Multiple requestHandler registered to the same name: /update ignoring:
org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 10229 T35 oasc.RequestHandlers.initHandlersFromConfig created
/update: solr.UpdateRequestHandler
[junit4] 2> 10232 T35 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 10234 T35 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 10235 T35 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 10236 T35 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 10238 T35 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 10240 T35 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 10240 T35 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 10241 T35 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1d30558
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index),segFN=segments_1,generation=1}
[junit4] 2> 10242 T35 oasc.SolrDeletionPolicy.updateCommits newest commit
generation = 1
[junit4] 2> 10242 T35 oass.SolrIndexSearcher.<init> Opening
Searcher@1bc779e[collection1] main
[junit4] 2> 10243 T35 oasr.ManagedResourceStorage$FileStorageIO.configure
File-based storage initialized to use dir:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/core-home-001/collection1/conf
[junit4] 2> 10243 T35 oasr.RestManager.init Initializing RestManager with
initArgs:
{storageDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/core-home-001/collection1/conf}
[junit4] 2> 10243 T35 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using
file:dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/core-home-001/collection1/conf
[junit4] 2> 10244 T35 oasr.ManagedResource.reloadFromStorage WARN No
stored data found for /rest/managed
[junit4] 2> 10244 T35 oasr.ManagedResourceStorage$JsonStorage.store Saved
JSON object to path _rest_managed.json using
file:dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/core-home-001/collection1/conf
[junit4] 2> 10245 T35 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 10245 T35 oasc.CoreContainer.registerCore registering core:
collection1
[junit4] 2> 10245 T36 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@1bc779e[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 10246 T36 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 10246 T36 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@1bc779e[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 10257 T33 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 10262 T33 oas.SolrTestCaseJ4.setUp ###Starting
testChildEntities
[junit4] 2> ASYNC NEW_CORE C4 name=collection1
org.apache.solr.core.SolrCore@fe06a9
[junit4] 2> 10279 T33 C4 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 10280 T33 C4 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:*} 0 13
[junit4] 2> 10286 T33 C4 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 10287 T33 C4 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1d30558
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index),segFN=segments_1,generation=1}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1d30558
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index),segFN=segments_2,generation=2}
[junit4] 2> 10288 T33 C4 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 2
[junit4] 2> 10289 T33 C4 oass.SolrIndexSearcher.<init> Opening
Searcher@1a11cbf[collection1] main
[junit4] 2> 10290 T36 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@1a11cbf[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 10290 T36 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 10291 T36 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 10292 T36 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=static+newSearcher+warming+query+from+solrconfig.xml&distrib=false&event=newSearcher}
hits=0 status=0 QTime=1
[junit4] 2> 10292 T36 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 10292 T36 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@1a11cbf[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 10292 T33 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 10293 T33 C4 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {commit=} 0 8
[junit4] 2> ASYNC NEW_CORE C5 name=collection1
org.apache.solr.core.SolrCore@fe06a9
[junit4] 2> 12882 T33 C5 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 12883 T33 C5 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 12884 T33 C5 oashd.DataImporter.doFullImport Starting Full
Import
[junit4] 2> 12884 T33 C5
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 12909 T33 C5 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 12916 T33 C5 oashd.JdbcDataSource$1.call Creating a connection
for entity People with URL: jdbc:derby:memory:derbyDB;territory=en_US
[junit4] 2> 12919 T33 C5 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 2
[junit4] 2> 12930 T33 C5 oashd.JdbcDataSource$1.call Creating a connection
for entity Sports with URL: jdbc:derby:memory:derbyDB;territory=en_US
[junit4] 2> 12932 T33 C5 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 1
[junit4] 2> 13153 T33 C5 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 13153 T33 C5 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 13182 T33 C5 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1d30558
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index),segFN=segments_2,generation=2}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1d30558
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index),segFN=segments_3,generation=3}
[junit4] 2> 13183 T33 C5 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 3
[junit4] 2> 13256 T33 C5 oass.SolrIndexSearcher.<init> Opening
Searcher@ae8a5c[collection1] main
[junit4] 2> 13257 T33 C5 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 13257 T36 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@ae8a5c[collection1]
main{UninvertingDirectoryReader(Uninverting(_0(5.0):C20))}
[junit4] 2> 13258 T36 C5 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=1
[junit4] 2> ASYNC NEW_CORE C6 name=collection1
org.apache.solr.core.SolrCore@fe06a9
[junit4] 2> 13271 T36 C6 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=1
[junit4] 2> 13272 T36 C6 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=static+newSearcher+warming+query+from+solrconfig.xml&distrib=false&event=newSearcher}
hits=0 status=0 QTime=1
[junit4] 2> 13272 T36 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 13272 T36 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@ae8a5c[collection1]
main{UninvertingDirectoryReader(Uninverting(_0(5.0):C20))}
[junit4] 2> 13273 T33 C6
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 13274 T33 C6 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 13274 T33 C6 oashd.DocBuilder.execute Time taken = 0:0:0.388
[junit4] 2> 13274 T33 C6 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null
params={indent=true&synchronous=true&commit=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/tempDir-001"+filename%3D"the.properties"+/>%0a<dataSource+name%3D"hsqldb"+driver%3D"org.hsqldb.jdbcDriver"+url%3D"jdbc:hsqldb:mem:."+/>+%0a<dataSource+name%3D"derby"+driver%3D"org.apache.derby.jdbc.EmbeddedDriver"+url%3D"jdbc:derby:memory:derbyDB;territory%3Den_US"+/>+%0a<document+name%3D"TestSqlEntityProcessor">+%0a<entity+name%3D"People"+pk%3D"ID"+processor%3D"SqlEntityProcessor"+dataSource%3D"derby"+query%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+WHERE+DELETED+!%3D+'Y'+"+deletedPkQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED%3D'Y'+AND+last_modified+%26gt;%3D'${dih.People.last_index_time}'+"+deltaImportQuery%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+where+ID%3D${dih.delta.ID}+"+deltaQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+last_modified+%26gt;%3D'${dih.People.last_index_time}'+"+>+%0a<field+column%3D"NAME"+name%3D"NAME_mult_s"+/>+%0a<field+column%3D"COUNTRY_CODE"+name%3D"COUNTRY_CODES_mult_s"+/>+%0a<entity+name%3D"Sports"+dataSource%3D"derby"+processor%3D"SqlEntityProcessor"+query%3D"SELECT+ID,+SPORT_NAME+FROM+PEOPLE_SPORTS+WHERE+DELETED+!%3D+'Y'+AND+PERSON_ID%3D${People.ID}+ORDER+BY+ID"+>+%0a<field+column%3D"SPORT_NAME"+name%3D"SPORT_NAME_mult_s"+/>+%0a<field+column%3D"id"+name%3D"SPORT_ID_mult_s"+/>+%0a</entity>+%0a</entity>+%0a</document>+%0a</dataConfig>+%0a&clean=true&command=full-import}
{deleteByQuery=*:*,add=[1, 2, 3, 4, 5, 6, 7, 8, 9, 10, ... (20 adds)],commit=}
0 395
[junit4] 2> 13282 T33 C6 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=*:*&qt=standard&start=0&rows=20&version=2.2} hits=20
status=0 QTime=4
[junit4] 2> 13293 T33 C6 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=SPORT_NAME_mult_s:Sailing&qt=standard&start=0&rows=20&version=2.2}
hits=2 status=0 QTime=4
[junit4] 2> 13340 T33 C6 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=NAME_mult_s:Michael&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=2
[junit4] 2> 13343 T33 C6 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 13344 T33 C6 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 13345 T33 oashd.SimplePropertiesWriter.readIndexerProperties
Read the.properties
[junit4] 2> 13386 T33 C6 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 13387 T33 C6 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 13387 T33 C6 oashd.DataImporter.doDeltaImport Starting Delta
Import
[junit4] 2> 13388 T33 C6
oashd.SimplePropertiesWriter.readIndexerProperties Read the.properties
[junit4] 2> 13389 T33 C6 oashd.DocBuilder.doDelta Starting delta
collection.
[junit4] 2> 13390 T33 C6 oashd.DocBuilder.collectDelta Running
ModifiedRowKey() for Entity: Sports
[junit4] 2> 13390 T33 C6 oashd.DocBuilder.collectDelta Completed
ModifiedRowKey for Entity: Sports rows obtained : 0
[junit4] 2> 13390 T33 C6 oashd.DocBuilder.collectDelta Completed
DeletedRowKey for Entity: Sports rows obtained : 0
[junit4] 2> 13391 T33 C6 oashd.DocBuilder.collectDelta Completed
parentDeltaQuery for Entity: Sports
[junit4] 2> 13391 T33 C6 oashd.DocBuilder.collectDelta Running
ModifiedRowKey() for Entity: People
[junit4] 2> 13392 T33 C6 oashd.JdbcDataSource$1.call Creating a connection
for entity People with URL: jdbc:derby:memory:derbyDB;territory=en_US
[junit4] 2> 13393 T33 C6 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 13418 T33 C6 oashd.DocBuilder.findMatchingPkColumn Resolving
deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 13424 T33 C6 oashd.DocBuilder.collectDelta Completed
ModifiedRowKey for Entity: People rows obtained : 4
[junit4] 2> 13424 T33 C6 oashd.DocBuilder.collectDelta Completed
DeletedRowKey for Entity: People rows obtained : 8
[junit4] 2> 13425 T33 C6 oashd.DocBuilder.collectDelta Completed
parentDeltaQuery for Entity: People
[junit4] 2> 13425 T33 C6 oashd.DocBuilder.deleteAll Deleting stale
documents
[junit4] 2> 13425 T33 C6 oashd.DocBuilder.findMatchingPkColumn Resolving
deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 13426 T33 C6 oashd.SolrWriter.deleteDoc Deleting document: 13
[junit4] 2> 13426 T33 C6 oashd.DocBuilder.findMatchingPkColumn Resolving
deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 13426 T33 C6 oashd.SolrWriter.deleteDoc Deleting document: 2
[junit4] 2> 13427 T33 C6 oashd.DocBuilder.findMatchingPkColumn Resolving
deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 13427 T33 C6 oashd.SolrWriter.deleteDoc Deleting document: 1
[junit4] 2> 13427 T33 C6 oashd.DocBuilder.findMatchingPkColumn Resolving
deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 13427 T33 C6 oashd.SolrWriter.deleteDoc Deleting document: 4
[junit4] 2> 13428 T33 C6 oashd.DocBuilder.findMatchingPkColumn Resolving
deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 13428 T33 C6 oashd.SolrWriter.deleteDoc Deleting document: 20
[junit4] 2> 13429 T33 C6 oashd.DocBuilder.findMatchingPkColumn Resolving
deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 13429 T33 C6 oashd.SolrWriter.deleteDoc Deleting document: 11
[junit4] 2> 13430 T33 C6 oashd.DocBuilder.findMatchingPkColumn Resolving
deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 13430 T33 C6 oashd.SolrWriter.deleteDoc Deleting document: 10
[junit4] 2> 13431 T33 C6 oashd.DocBuilder.findMatchingPkColumn Resolving
deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 13431 T33 C6 oashd.SolrWriter.deleteDoc Deleting document: 15
[junit4] 2> 13438 T33 C6 oashd.JdbcDataSource$1.call Creating a connection
for entity Sports with URL: jdbc:derby:memory:derbyDB;territory=en_US
[junit4] 2> 13439 T33 C6 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 13465 T33 C6 oashd.DocBuilder.doDelta Delta Import completed
successfully
[junit4] 2> 13465 T33 C6 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 13465 T33 C6 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 13472 T33 C6 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1d30558
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index),segFN=segments_3,generation=3}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1d30558
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index),segFN=segments_4,generation=4}
[junit4] 2> 13473 T33 C6 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 4
[junit4] 2> 13477 T33 C6 oass.SolrIndexSearcher.<init> Opening
Searcher@1cfebca[collection1] main
[junit4] 2> 13478 T33 C6 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 13480 T36 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@1cfebca[collection1]
main{UninvertingDirectoryReader(Uninverting(_0(5.0):C20/11:delGen=1)
Uninverting(_1(5.0):C4))}
[junit4] 2> 13480 T36 C6 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 13481 T36 C6 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=1
[junit4] 2> 13481 T36 C6 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=static+newSearcher+warming+query+from+solrconfig.xml&distrib=false&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 13481 T36 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 13482 T36 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@1cfebca[collection1]
main{UninvertingDirectoryReader(Uninverting(_0(5.0):C20/11:delGen=1)
Uninverting(_1(5.0):C4))}
[junit4] 2> 13482 T33 C6
oashd.SimplePropertiesWriter.readIndexerProperties Read the.properties
[junit4] 2> 13483 T33 C6 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 13483 T33 C6 oashd.DocBuilder.execute Time taken = 0:0:0.94
[junit4] 2> 13484 T33 C6 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null
params={indent=true&synchronous=true&commit=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/tempDir-001"+filename%3D"the.properties"+/>%0a<dataSource+name%3D"hsqldb"+driver%3D"org.hsqldb.jdbcDriver"+url%3D"jdbc:hsqldb:mem:."+/>+%0a<dataSource+name%3D"derby"+driver%3D"org.apache.derby.jdbc.EmbeddedDriver"+url%3D"jdbc:derby:memory:derbyDB;territory%3Den_US"+/>+%0a<document+name%3D"TestSqlEntityProcessor">+%0a<entity+name%3D"People"+pk%3D"People.ID"+processor%3D"SqlEntityProcessor"+dataSource%3D"derby"+transformer%3D"AddAColumnTransformer"+query%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+WHERE+DELETED+!%3D+'Y'+"+deletedPkQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED%3D'Y'+AND+last_modified+%26gt;%3D'${dih.People.last_index_time}'+"+deltaImportQuery%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+where+ID%3D${dih.delta.ID}+"+deltaQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+last_modified+%26gt;%3D'${dih.People.last_index_time}'+"+>+%0a<field+column%3D"NAME"+name%3D"NAME_mult_s"+/>+%0a<field+column%3D"COUNTRY_CODE"+name%3D"COUNTRY_CODES_mult_s"+/>+%0a<entity+name%3D"Sports"+dataSource%3D"derby"+processor%3D"SqlEntityProcessor"+query%3D"SELECT+ID,+SPORT_NAME+FROM+PEOPLE_SPORTS+WHERE+DELETED+!%3D+'Y'+AND+PERSON_ID%3D${People.ID}+ORDER+BY+ID"+>+%0a<field+column%3D"SPORT_NAME"+name%3D"SPORT_NAME_mult_s"+/>+%0a<field+column%3D"id"+name%3D"SPORT_ID_mult_s"+/>+%0a</entity>+%0a</entity>+%0a</document>+%0a</dataConfig>+%0a&clean=false&command=delta-import}
{delete=[13, 2, 1, 4, 20, 11, 10, 15],add=[1011, 18, 7, 9],commit=} 0 101
[junit4] 2> 13487 T33 C6 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=*:*&qt=standard&start=0&rows=20&version=2.2} hits=13
status=0 QTime=1
[junit4] 2> 13494 T33 C6 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=NAME_mult_s:Michael&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=0
[junit4] 2> 13497 T33 C6 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:1011&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=1
[junit4] 2> 13498 T33 C6 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:1&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=0
[junit4] 2> 13500 T33 C6 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:2&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=1
[junit4] 2> 13501 T33 C6 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:20&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=1
[junit4] 2> 13502 T33 C6 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:4&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=0
[junit4] 2> 13503 T33 C6 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:10&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=0
[junit4] 2> 13504 T33 C6 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:11&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=0
[junit4] 2> 13506 T33 C6 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:13&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=1
[junit4] 2> 13507 T33 C6 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:15&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=1
[junit4] 2> 13508 T33 C6 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:18&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=0
[junit4] 2> 13510 T33 C6 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:7&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=0
[junit4] 2> 13511 T33 C6 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:9&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=0
[junit4] 2> 14042 T33 oas.SolrTestCaseJ4.tearDown ###Ending
testChildEntities
[junit4] 2> 14079 T33 oas.SolrTestCaseJ4.setUp ###Starting
testWithComplexTransformer
[junit4] 2> ASYNC NEW_CORE C7 name=collection1
org.apache.solr.core.SolrCore@fe06a9
[junit4] 2> 14081 T33 C7 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 14081 T33 C7 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> 14083 T33 C7 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 14084 T33 C7 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1d30558
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index),segFN=segments_4,generation=4}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1d30558
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index),segFN=segments_5,generation=5}
[junit4] 2> 14084 T33 C7 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 5
[junit4] 2> 14085 T33 C7 oass.SolrIndexSearcher.<init> Opening
Searcher@511f0d[collection1] main
[junit4] 2> 14085 T33 C7 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 14086 T36 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@511f0d[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 14087 T36 C7 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=1
[junit4] 2> 14087 T36 C7 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 14088 T36 C7 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=static+newSearcher+warming+query+from+solrconfig.xml&distrib=false&event=newSearcher}
hits=0 status=0 QTime=1
[junit4] 2> 14088 T36 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 14088 T36 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@511f0d[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 14095 T33 C7 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {commit=} 0 12
[junit4] 2> ASYNC NEW_CORE C8 name=collection1
org.apache.solr.core.SolrCore@fe06a9
[junit4] 2> 14390 T33 C8 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 14391 T33 C8 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 14391 T33 C8 oashd.DataImporter.doFullImport Starting Full
Import
[junit4] 2> 14392 T33 C8
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 14393 T33 C8 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 14394 T33 C8 oashd.JdbcDataSource$1.call Creating a connection
for entity People with URL: jdbc:hsqldb:mem:.
[junit4] 2> 14395 T33 C8 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 14463 T33 C8 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 14463 T33 C8 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 14477 T33 C8 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1d30558
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index),segFN=segments_5,generation=5}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1d30558
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index),segFN=segments_6,generation=6}
[junit4] 2> 14478 T33 C8 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 6
[junit4] 2> 14482 T33 C8 oass.SolrIndexSearcher.<init> Opening
Searcher@10efb5d[collection1] main
[junit4] 2> 14483 T33 C8 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 14485 T36 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@10efb5d[collection1]
main{UninvertingDirectoryReader(Uninverting(_2(5.0):C60))}
[junit4] 2> 14486 T36 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=1
[junit4] 2> 14486 T36 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 14487 T36 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=static+newSearcher+warming+query+from+solrconfig.xml&distrib=false&event=newSearcher}
hits=0 status=0 QTime=1
[junit4] 2> 14487 T36 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 14487 T36 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@10efb5d[collection1]
main{UninvertingDirectoryReader(Uninverting(_2(5.0):C60))}
[junit4] 2> 14488 T33 C8
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 14489 T33 C8 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 14489 T33 C8 oashd.DocBuilder.execute Time taken = 0:0:0.96
[junit4] 2> 14490 T33 C8 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null
params={indent=true&synchronous=true&commit=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/tempDir-001"+filename%3D"the.properties"+/>%0a<dataSource+name%3D"hsqldb"+driver%3D"org.hsqldb.jdbcDriver"+url%3D"jdbc:hsqldb:mem:."+/>+%0a<dataSource+name%3D"derby"+driver%3D"org.apache.derby.jdbc.EmbeddedDriver"+url%3D"jdbc:derby:memory:derbyDB;territory%3Den_US"+/>+%0a<document+name%3D"TestSqlEntityProcessor">+%0a<entity+name%3D"People"+pk%3D"People.ID"+processor%3D"SqlEntityProcessor"+dataSource%3D"hsqldb"+transformer%3D"TripleThreatTransformer"+query%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+WHERE+DELETED+!%3D+'Y'+"+deletedPkQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED%3D'Y'+AND+last_modified+%26gt;%3D'${dih.People.last_index_time}'+"+deltaImportQuery%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+where+ID%3D${dih.delta.ID}+"+deltaQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+last_modified+%26gt;%3D'${dih.People.last_index_time}'+UNION+DISTINCT+SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+COUNTRY_CODE+IN+(SELECT+CODE+FROM+COUNTRIES+WHERE+last_modified+%26gt;%3D'${dih.People.last_index_time}')+"+>+%0a<field+column%3D"NAME"+name%3D"NAME_mult_s"+/>+%0a<field+column%3D"COUNTRY_CODE"+name%3D"COUNTRY_CODES_mult_s"+/>+%0a</entity>+%0a</document>+%0a</dataConfig>+%0a&clean=true&command=full-import}
{deleteByQuery=*:*,add=[1, TripleThreat-1-1, TripleThreat-2-1, 2,
TripleThreat-1-2, TripleThreat-2-2, 3, TripleThreat-1-3, TripleThreat-2-3, 4,
... (60 adds)],commit=} 0 102
[junit4] 2> 14624 T33 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=*:*&sort=id+asc&rows=60} hits=60 status=0 QTime=128
[junit4] 2> 14656 T33 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=id:TripleThreat-1-*&qt=standard&start=0&rows=20&version=2.2} hits=20
status=0 QTime=15
[junit4] 2> 14661 T33 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=id:TripleThreat-2-*&qt=standard&start=0&rows=20&version=2.2} hits=20
status=0 QTime=1
[junit4] 2> 14670 T33 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=%2Bid:TripleThreat-1-3+%2BNAME_mult_s:Michael+%2BNAME_mult_s:leahciM++%2BCOUNTRY_CODES_mult_s:NR+%2BCOUNTRY_CODES_mult_s:RN&qt=standard&start=0&rows=20&version=2.2}
hits=1 status=0 QTime=4
[junit4] 2> 14673 T33 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=AddAColumn_s:Added&qt=standard&start=0&rows=20&version=2.2}
hits=20 status=0 QTime=1
[junit4] 2> 14677 T33 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=1
[junit4] 2> 14677 T33 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 14678 T33 oashd.SimplePropertiesWriter.readIndexerProperties
Read the.properties
[junit4] 2> 14685 T33 C8 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 14701 T33 C8 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 14701 T33 C8 oashd.DataImporter.doDeltaImport Starting Delta
Import
[junit4] 2> 14702 T33 C8
oashd.SimplePropertiesWriter.readIndexerProperties Read the.properties
[junit4] 2> 14703 T33 C8 oashd.DocBuilder.doDelta Starting delta
collection.
[junit4] 2> 14704 T33 C8 oashd.DocBuilder.collectDelta Running
ModifiedRowKey() for Entity: People
[junit4] 2> 14704 T33 C8 oashd.JdbcDataSource$1.call Creating a connection
for entity People with URL: jdbc:hsqldb:mem:.
[junit4] 2> 14705 T33 C8 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 14711 T33 C8 oashd.DocBuilder.findMatchingPkColumn Resolving
deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 14713 T33 C8 oashd.DocBuilder.collectDelta Completed
ModifiedRowKey for Entity: People rows obtained : 6
[junit4] 2> 14713 T33 C8 oashd.DocBuilder.collectDelta Completed
DeletedRowKey for Entity: People rows obtained : 4
[junit4] 2> 14714 T33 C8 oashd.DocBuilder.collectDelta Completed
parentDeltaQuery for Entity: People
[junit4] 2> 14714 T33 C8 oashd.DocBuilder.deleteAll Deleting stale
documents
[junit4] 2> 14715 T33 C8 oashd.DocBuilder.findMatchingPkColumn Resolving
deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 14715 T33 C8 oashd.SolrWriter.deleteDoc Deleting document: 9
[junit4] 2> 14716 T33 C8 oashd.DocBuilder.findMatchingPkColumn Resolving
deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 14716 T33 C8 oashd.SolrWriter.deleteDoc Deleting document: 1
[junit4] 2> 14717 T33 C8 oashd.DocBuilder.findMatchingPkColumn Resolving
deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 14717 T33 C8 oashd.SolrWriter.deleteDoc Deleting document: 7
[junit4] 2> 14718 T33 C8 oashd.DocBuilder.findMatchingPkColumn Resolving
deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 14718 T33 C8 oashd.SolrWriter.deleteDoc Deleting document: 5
[junit4] 2> 14736 T33 C8 oashd.DocBuilder.doDelta Delta Import completed
successfully
[junit4] 2> 14737 T33 C8 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 14738 T33 C8 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 14796 T33 C8 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1d30558
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index),segFN=segments_6,generation=6}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1d30558
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index),segFN=segments_7,generation=7}
[junit4] 2> 14797 T33 C8 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 7
[junit4] 2> 14800 T33 C8 oass.SolrIndexSearcher.<init> Opening
Searcher@a2536d[collection1] main
[junit4] 2> 14800 T33 C8 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 14807 T36 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@a2536d[collection1]
main{UninvertingDirectoryReader(Uninverting(_2(5.0):C60/16:delGen=1)
Uninverting(_3(5.0):C18))}
[junit4] 2> 14808 T36 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 14808 T36 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 14809 T36 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=static+newSearcher+warming+query+from+solrconfig.xml&distrib=false&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 14809 T36 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 14809 T36 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@a2536d[collection1]
main{UninvertingDirectoryReader(Uninverting(_2(5.0):C60/16:delGen=1)
Uninverting(_3(5.0):C18))}
[junit4] 2> 14810 T33 C8
oashd.SimplePropertiesWriter.readIndexerProperties Read the.properties
[junit4] 2> 14811 T33 C8 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 14811 T33 C8 oashd.DocBuilder.execute Time taken = 0:0:0.108
[junit4] 2> 14812 T33 C8 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null
params={indent=true&synchronous=true&commit=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/tempDir-001"+filename%3D"the.properties"+/>%0a<dataSource+name%3D"hsqldb"+driver%3D"org.hsqldb.jdbcDriver"+url%3D"jdbc:hsqldb:mem:."+/>+%0a<dataSource+name%3D"derby"+driver%3D"org.apache.derby.jdbc.EmbeddedDriver"+url%3D"jdbc:derby:memory:derbyDB;territory%3Den_US"+/>+%0a<document+name%3D"TestSqlEntityProcessor">+%0a<entity+name%3D"People"+pk%3D"People.ID"+processor%3D"SqlEntityProcessor"+dataSource%3D"hsqldb"+transformer%3D"TripleThreatTransformer"+query%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+WHERE+DELETED+!%3D+'Y'+"+deletedPkQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED%3D'Y'+AND+last_modified+%26gt;%3D'${dih.People.last_index_time}'+"+deltaImportQuery%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+where+ID%3D${dih.delta.ID}+"+deltaQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+last_modified+%26gt;%3D'${dih.People.last_index_time}'+UNION+DISTINCT+SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+COUNTRY_CODE+IN+(SELECT+CODE+FROM+COUNTRIES+WHERE+last_modified+%26gt;%3D'${dih.People.last_index_time}')+"+>+%0a<field+column%3D"NAME"+name%3D"NAME_mult_s"+/>+%0a<field+column%3D"COUNTRY_CODE"+name%3D"COUNTRY_CODES_mult_s"+/>+%0a</entity>+%0a</document>+%0a</dataConfig>+%0a&clean=false&command=delta-import}
{delete=[9, 1, 7, 5],add=[11, TripleThreat-1-11, TripleThreat-2-11, 1006,
TripleThreat-1-1006, TripleThreat-2-1006, 13, TripleThreat-1-13,
TripleThreat-2-13, 19, ... (18 adds)],commit=} 0 130
[junit4] 2> 14816 T33 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=*:*&sort=id+asc&rows=54} hits=62 status=0 QTime=2
[junit4] 2> 14829 T33 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=id:TripleThreat-1-*&qt=standard&start=0&rows=20&version=2.2} hits=22
status=0 QTime=0
[junit4] 2> 14833 T33 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=id:TripleThreat-2-*&qt=standard&start=0&rows=20&version=2.2} hits=22
status=0 QTime=0
[junit4] 2> 14838 T33 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=%2Bid:TripleThreat-1-3+%2BNAME_mult_s:Michael+%2BNAME_mult_s:leahciM++%2BCOUNTRY_CODES_mult_s:NR+%2BCOUNTRY_CODES_mult_s:RN&qt=standard&start=0&rows=20&version=2.2}
hits=1 status=0 QTime=0
[junit4] 2> 14840 T33 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=AddAColumn_s:Added&qt=standard&start=0&rows=20&version=2.2}
hits=22 status=0 QTime=0
[junit4] 2> 14843 T33 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 14844 T33 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 14845 T33 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:1013&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=0
[junit4] 2> 14848 T33 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:1006&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=0
[junit4] 2> 14849 T33 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:1&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=0
[junit4] 2> 14851 T33 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:5&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=0
[junit4] 2> 14853 T33 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:7&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=0
[junit4] 2> 14854 T33 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:9&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=0
[junit4] 2> 14856 T33 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:19&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=0
[junit4] 2> 14859 T33 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:6&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=1
[junit4] 2> 14861 T33 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:11&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=0
[junit4] 2> ASYNC NEW_CORE C9 name=collection1
org.apache.solr.core.SolrCore@fe06a9
[junit4] 2> 14881 T33 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:13&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=0
[junit4] 2> 14888 T33 oas.SolrTestCaseJ4.tearDown ###Ending
testWithComplexTransformer
[junit4] 2> 14896 T33 oas.SolrTestCaseJ4.setUp ###Starting
testDeltaImportWithoutInitialFullImport
[junit4] 2> 14898 T33 C9 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 14898 T33 C9 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> 14900 T33 C9 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 14901 T33 C9 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1d30558
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index),segFN=segments_7,generation=7}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1d30558
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index),segFN=segments_8,generation=8}
[junit4] 2> 14901 T33 C9 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 8
[junit4] 2> 14903 T33 C9 oass.SolrIndexSearcher.<init> Opening
Searcher@beec4e[collection1] main
[junit4] 2> 14904 T33 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 14905 T36 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@beec4e[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 14906 T36 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=1
[junit4] 2> 14906 T36 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 14907 T36 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=static+newSearcher+warming+query+from+solrconfig.xml&distrib=false&event=newSearcher}
hits=0 status=0 QTime=1
[junit4] 2> 14907 T36 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 14907 T36 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@beec4e[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 14909 T33 C9 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {commit=} 0 9
[junit4] 2> 14928 T33 C9 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 14929 T33 C9 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 14929 T33 C9 oashd.DataImporter.doDeltaImport Starting Delta
Import
[junit4] 2> 14930 T33 C9
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 14931 T33 C9 oashd.DocBuilder.doDelta Starting delta
collection.
[junit4] 2> 14931 T33 C9 oashd.DocBuilder.collectDelta Running
ModifiedRowKey() for Entity: People
[junit4] 2> 14931 T33 C9 oashd.JdbcDataSource$1.call Creating a connection
for entity People with URL: jdbc:hsqldb:mem:.
[junit4] 2> 14932 T33 C9 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 14934 T33 C9 oashd.DocBuilder.collectDelta Completed
ModifiedRowKey for Entity: People rows obtained : 20
[junit4] 2> 14934 T33 C9 oashd.DocBuilder.collectDelta Completed
DeletedRowKey for Entity: People rows obtained : 0
[junit4] 2> 14934 T33 C9 oashd.DocBuilder.collectDelta Completed
parentDeltaQuery for Entity: People
[junit4] 2> 14947 T33 C9 oashd.DocBuilder.doDelta Delta Import completed
successfully
[junit4] 2> 14948 T33 C9 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 14948 T33 C9 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 14957 T33 C9 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1d30558
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index),segFN=segments_8,generation=8}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1d30558
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index),segFN=segments_9,generation=9}
[junit4] 2> 14958 T33 C9 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 9
[junit4] 2> 14960 T33 C9 oass.SolrIndexSearcher.<init> Opening
Searcher@b56423[collection1] main
[junit4] 2> 14961 T33 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 14963 T36 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@b56423[collection1]
main{UninvertingDirectoryReader(Uninverting(_4(5.0):C20))}
[junit4] 2> 14963 T36 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 14964 T36 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 14964 T36 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=static+newSearcher+warming+query+from+solrconfig.xml&distrib=false&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 14964 T36 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 14964 T36 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@b56423[collection1]
main{UninvertingDirectoryReader(Uninverting(_4(5.0):C20))}
[junit4] 2> 14965 T33 C9
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 14966 T33 C9 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 14966 T33 C9 oashd.DocBuilder.execute Time taken = 0:0:0.36
[junit4] 2> 14967 T33 C9 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null
params={indent=true&synchronous=true&commit=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/tempDir-001"+filename%3D"the.properties"+/>%0a<dataSource+name%3D"hsqldb"+driver%3D"org.hsqldb.jdbcDriver"+url%3D"jdbc:hsqldb:mem:."+/>+%0a<dataSource+name%3D"derby"+driver%3D"org.apache.derby.jdbc.EmbeddedDriver"+url%3D"jdbc:derby:memory:derbyDB;territory%3Den_US"+/>+%0a<document+name%3D"TestSqlEntityProcessor">+%0a<entity+name%3D"People"+pk%3D"ID"+processor%3D"SqlEntityProcessor"+dataSource%3D"hsqldb"+query%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+WHERE+DELETED+!%3D+'Y'+"+deletedPkQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED%3D'Y'+AND+last_modified+%26gt;%3D'${dih.People.last_index_time}'+"+deltaImportQuery%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+where+ID%3D${dih.delta.ID}+"+deltaQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+last_modified+%26gt;%3D'${dih.People.last_index_time}'+UNION+DISTINCT+SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+COUNTRY_CODE+IN+(SELECT+CODE+FROM+COUNTRIES+WHERE+last_modified+%26gt;%3D'${dih.People.last_index_time}')+"+>+%0a<field+column%3D"NAME"+name%3D"NAME_mult_s"+/>+%0a<field+column%3D"COUNTRY_CODE"+name%3D"COUNTRY_CODES_mult_s"+/>+%0a</entity>+%0a</document>+%0a</dataConfig>+%0a&clean=false&command=delta-import}
{add=[19, 18, 17, 16, 20, 11, 10, 9, 8, 15, ... (20 adds)],commit=} 0 45
[junit4] 2> 14969 T33 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=*:*&qt=standard&start=0&rows=20&version=2.2} hits=20
status=0 QTime=1
[junit4] 2> 14973 T33 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 14974 T33 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 14975 T33 oas.SolrTestCaseJ4.tearDown ###Ending
testDeltaImportWithoutInitialFullImport
[junit4] 2> 14983 T33 oas.SolrTestCaseJ4.setUp ###Starting testSingleEntity
[junit4] 2> 14984 T33 C9 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 14985 T33 C9 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> 14986 T33 C9 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 14987 T33 C9 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1d30558
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index),segFN=segments_9,generation=9}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1d30558
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index),segFN=segments_a,generation=10}
[junit4] 2> 14988 T33 C9 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 10
[junit4] 2> 14989 T33 C9 oass.SolrIndexSearcher.<init> Opening
Searcher@fb5e72[collection1] main
[junit4] 2> 14989 T33 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 14990 T36 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@fb5e72[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 14991 T36 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=1
[junit4] 2> 14991 T36 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 14992 T36 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=static+newSearcher+warming+query+from+solrconfig.xml&distrib=false&event=newSearcher}
hits=0 status=0 QTime=1
[junit4] 2> 14992 T36 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 14992 T36 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@fb5e72[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 14993 T33 C9 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {commit=} 0 7
[junit4] 2> 15010 T33 C9 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 15011 T33 C9 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 15011 T33 C9 oashd.DataImporter.doFullImport Starting Full
Import
[junit4] 2> 15012 T33 C9
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 15013 T33 C9 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 15014 T33 C9 oashd.JdbcDataSource$1.call Creating a connection
for entity People with URL: jdbc:hsqldb:mem:.
[junit4] 2> 15015 T33 C9 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 15021 T33 C9 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 15021 T33 C9 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 15027 T33 C9 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1d30558
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index),segFN=segments_a,generation=10}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1d30558
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index),segFN=segments_b,generation=11}
[junit4] 2> 15027 T33 C9 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 11
[junit4] 2> 15030 T33 C9 oass.SolrIndexSearcher.<init> Opening
Searcher@1746fff[collection1] main
[junit4] 2> 15030 T33 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 15033 T36 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@1746fff[collection1]
main{UninvertingDirectoryReader(Uninverting(_5(5.0):C20))}
[junit4] 2> 15033 T36 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 15033 T36 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 15034 T36 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=static+newSearcher+warming+query+from+solrconfig.xml&distrib=false&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 15034 T36 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 15034 T36 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@1746fff[collection1]
main{UninvertingDirectoryReader(Uninverting(_5(5.0):C20))}
[junit4] 2> 15035 T33 C9
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 15035 T33 C9 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 15036 T33 C9 oashd.DocBuilder.execute Time taken = 0:0:0.23
[junit4] 2> 15036 T33 C9 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null
params={indent=true&synchronous=true&commit=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/tempDir-001"+filename%3D"the.properties"+/>%0a<dataSource+name%3D"hsqldb"+driver%3D"org.hsqldb.jdbcDriver"+url%3D"jdbc:hsqldb:mem:."+/>+%0a<dataSource+name%3D"derby"+driver%3D"org.apache.derby.jdbc.EmbeddedDriver"+url%3D"jdbc:derby:memory:derbyDB;territory%3Den_US"+/>+%0a<document+name%3D"TestSqlEntityProcessor">+%0a<entity+name%3D"People"+pk%3D"ID"+processor%3D"SqlEntityProcessor"+dataSource%3D"hsqldb"+query%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+WHERE+DELETED+!%3D+'Y'+"+deletedPkQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED%3D'Y'+AND+last_modified+%26gt;%3D'${dih.People.last_index_time}'+"+deltaImportQuery%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+where+ID%3D${dih.delta.ID}+"+deltaQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+last_modified+%26gt;%3D'${dih.People.last_index_time}'+UNION+DISTINCT+SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+COUNTRY_CODE+IN+(SELECT+CODE+FROM+COUNTRIES+WHERE+last_modified+%26gt;%3D'${dih.People.last_index_time}')+"+>+%0a<field+column%3D"NAME"+name%3D"NAME_mult_s"+/>+%0a<field+column%3D"COUNTRY_CODE"+name%3D"COUNTRY_CODES_mult_s"+/>+%0a</entity>+%0a</document>+%0a</dataConfig>+%0a&clean=true&command=full-import}
{deleteByQuery=*:*,add=[1, 2, 3, 4, 5, 6, 7, 8, 9, 10, ... (20 adds)],commit=}
0 29
[junit4] 2> 15038 T33 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=*:*&qt=standard&start=0&rows=20&version=2.2} hits=20
status=0 QTime=0
[junit4] 2> 15043 T33 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 15044 T33 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 15044 T33 oashd.SimplePropertiesWriter.readIndexerProperties
Read the.properties
[junit4] 2> 15049 T33 C9 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 15049 T33 C9 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 15050 T33 C9 oashd.DataImporter.doDeltaImport Starting Delta
Import
[junit4] 2> 15050 T33 C9
oashd.SimplePropertiesWriter.readIndexerProperties Read the.properties
[junit4] 2> 15051 T33 C9 oashd.DocBuilder.doDelta Starting delta
collection.
[junit4] 2> 15052 T33 C9 oashd.DocBuilder.collectDelta Running
ModifiedRowKey() for Entity: People
[junit4] 2> 15053 T33 C9 oashd.JdbcDataSource$1.call Creating a connection
for entity People with URL: jdbc:hsqldb:mem:.
[junit4] 2> 15053 T33 C9 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 15055 T33 C9 oashd.DocBuilder.collectDelta Completed
ModifiedRowKey for Entity: People rows obtained : 7
[junit4] 2> 15056 T33 C9 oashd.DocBuilder.collectDelta Completed
DeletedRowKey for Entity: People rows obtained : 2
[junit4] 2> 15056 T33 C9 oashd.DocBuilder.collectDelta Completed
parentDeltaQuery for Entity: People
[junit4] 2> 15056 T33 C9 oashd.DocBuilder.deleteAll Deleting stale
documents
[junit4] 2> 15057 T33 C9 oashd.SolrWriter.deleteDoc Deleting document: 15
[junit4] 2> 15057 T33 C9 oashd.SolrWriter.deleteDoc Deleting document: 6
[junit4] 2> 15060 T33 C9 oashd.DocBuilder.doDelta Delta Import completed
successfully
[junit4] 2> 15061 T33 C9 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 15061 T33 C9 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 15066 T33 C9 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1d30558
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index),segFN=segments_b,generation=11}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1d30558
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index),segFN=segments_c,generation=12}
[junit4] 2> 15066 T33 C9 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 12
[junit4] 2> 15068 T33 C9 oass.SolrIndexSearcher.<init> Opening
Searcher@452fe3[collection1] main
[junit4] 2> 15069 T33 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 15073 T36 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@452fe3[collection1]
main{UninvertingDirectoryReader(Uninverting(_5(5.0):C20/9:delGen=1)
Uninverting(_6(5.0):C7))}
[junit4] 2> 15074 T36 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 15074 T36 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 15075 T36 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=static+newSearcher+warming+query+from+solrconfig.xml&distrib=false&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 15075 T36 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 15076 T36 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@452fe3[collection1]
main{UninvertingDirectoryReader(Uninverting(_5(5.0):C20/9:delGen=1)
Uninverting(_6(5.0):C7))}
[junit4] 2> 15076 T33 C9
oashd.SimplePropertiesWriter.readIndexerProperties Read the.properties
[junit4] 2> 15077 T33 C9 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 15078 T33 C9 oashd.DocBuilder.execute Time taken = 0:0:0.26
[junit4] 2> 15078 T33 C9 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null
params={indent=true&synchronous=true&commit=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/tempDir-001"+filename%3D"the.properties"+/>%0a<dataSource+name%3D"hsqldb"+driver%3D"org.hsqldb.jdbcDriver"+url%3D"jdbc:hsqldb:mem:."+/>+%0a<dataSource+name%3D"derby"+driver%3D"org.apache.derby.jdbc.EmbeddedDriver"+url%3D"jdbc:derby:memory:derbyDB;territory%3Den_US"+/>+%0a<document+name%3D"TestSqlEntityProcessor">+%0a<entity+name%3D"People"+pk%3D"ID"+processor%3D"SqlEntityProcessor"+dataSource%3D"hsqldb"+query%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+WHERE+DELETED+!%3D+'Y'+"+deletedPkQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED%3D'Y'+AND+last_modified+%26gt;%3D'${dih.People.last_index_time}'+"+deltaImportQuery%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+where+ID%3D${dih.delta.ID}+"+deltaQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+last_modified+%26gt;%3D'${dih.People.last_index_time}'+UNION+DISTINCT+SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+COUNTRY_CODE+IN+(SELECT+CODE+FROM+COUNTRIES+WHERE+last_modified+%26gt;%3D'${dih.People.last_index_time}')+"+>+%0a<field+column%3D"NAME"+name%3D"NAME_mult_s"+/>+%0a<field+column%3D"COUNTRY_CODE"+name%3D"COUNTRY_CODES_mult_s"+/>+%0a</entity>+%0a</document>+%0a</dataConfig>+%0a&clean=false&command=delta-import}
{delete=[15, 6],add=[10, 9, 8, 19, 17, 7, 5],commit=} 0 32
[junit4] 2> 15081 T33 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=*:*&qt=standard&start=0&rows=20&version=2.2} hits=18
status=0 QTime=1
[junit4] 2> 15085 T33 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 15086 T33 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 15087 T33 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:6&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=1
[junit4] 2> 15088 T33 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:15&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=0
[junit4] 2> 15090 T33 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:17&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=1
[junit4] 2> 15092 T33 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:19&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=0
[junit4] 2> 15094 T33 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:5&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=0
[junit4] 2> 15097 T33 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:7&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=1
[junit4] 2> 15099 T33 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:8&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=1
[junit4] 2> 15101 T33 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:9&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=0
[junit4] 2> 15103 T33 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:10&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=0
[junit4] 2> 15105 T33 oas.SolrTestCaseJ4.tearDown ###Ending
testSingleEntity
[junit4] 2> 15112 T33 oas.SolrTestCaseJ4.setUp ###Starting
testWithSimpleTransformer
[junit4] 2> 15114 T33 C9 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 15114 T33 C9 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> 15116 T33 C9 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 15116 T33 C9 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1d30558
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index),segFN=segments_c,generation=12}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1d30558
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index),segFN=segments_d,generation=13}
[junit4] 2> 15117 T33 C9 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 13
[junit4] 2> 15118 T33 C9 oass.SolrIndexSearcher.<init> Opening
Searcher@735510[collection1] main
[junit4] 2> 15118 T33 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 15120 T36 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@735510[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 15120 T36 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 15121 T36 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=1
[junit4] 2> 15121 T36 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=static+newSearcher+warming+query+from+solrconfig.xml&distrib=false&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 15121 T36 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 15122 T36 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@735510[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 15123 T33 C9 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {commit=} 0 8
[junit4] 2> 15139 T33 C9 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 15139 T33 C9 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 15140 T33 C9 oashd.DataImporter.doFullImport Starting Full
Import
[junit4] 2> 15141 T33 C9
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 15142 T33 C9 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 15143 T33 C9 oashd.JdbcDataSource$1.call Creating a connection
for entity People with URL: jdbc:hsqldb:mem:.
[junit4] 2> 15143 T33 C9 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 15155 T33 C9 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 15155 T33 C9 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 15159 T33 C9 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1d30558
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index),segFN=segments_d,generation=13}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1d30558
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index),segFN=segments_e,generation=14}
[junit4] 2> 15159 T33 C9 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 14
[junit4] 2> 15162 T33 C9 oass.SolrIndexSearcher.<init> Opening
Searcher@a1c95f[collection1] main
[junit4] 2> 15163 T33 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 15167 T36 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@a1c95f[collection1]
main{UninvertingDirectoryReader(Uninverting(_7(5.0):C20))}
[junit4] 2> 15167 T36 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 15168 T36 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 15168 T36 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=static+newSearcher+warming+query+from+solrconfig.xml&distrib=false&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 15168 T36 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 15169 T36 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@a1c95f[collection1]
main{UninvertingDirectoryReader(Uninverting(_7(5.0):C20))}
[junit4] 2> 15169 T33 C9
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 15170 T33 C9 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 15170 T33 C9 oashd.DocBuilder.execute Time taken = 0:0:0.28
[junit4] 2> 15170 T33 C9 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null
params={indent=true&synchronous=true&commit=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/tempDir-001"+filename%3D"the.properties"+/>%0a<dataSource+name%3D"hsqldb"+driver%3D"org.hsqldb.jdbcDriver"+url%3D"jdbc:hsqldb:mem:."+/>+%0a<dataSource+name%3D"derby"+driver%3D"org.apache.derby.jdbc.EmbeddedDriver"+url%3D"jdbc:derby:memory:derbyDB;territory%3Den_US"+/>+%0a<document+name%3D"TestSqlEntityProcessor">+%0a<entity+name%3D"People"+pk%3D"ID"+processor%3D"SqlEntityProcessor"+dataSource%3D"hsqldb"+transformer%3D"AddAColumnTransformer"+query%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+WHERE+DELETED+!%3D+'Y'+"+deletedPkQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED%3D'Y'+AND+last_modified+%26gt;%3D'${dih.People.last_index_time}'+"+deltaImportQuery%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+where+ID%3D${dih.delta.ID}+"+deltaQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+last_modified+%26gt;%3D'${dih.People.last_index_time}'+UNION+DISTINCT+SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+COUNTRY_CODE+IN+(SELECT+CODE+FROM+COUNTRIES+WHERE+last_modified+%26gt;%3D'${dih.People.last_index_time}')+"+>+%0a<field+column%3D"NAME"+name%3D"NAME_mult_s"+/>+%0a<field+column%3D"COUNTRY_CODE"+name%3D"COUNTRY_CODES_mult_s"+/>+%0a</entity>+%0a</document>+%0a</dataConfig>+%0a&clean=true&command=full-import}
{deleteByQuery=*:*,add=[1, 2, 3, 4, 5, 6, 7, 8, 9, 10, ... (20 adds)],commit=}
0 34
[junit4] 2> 15172 T33 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=AddAColumn_s:Added&qt=standard&start=0&rows=20&version=2.2}
hits=20 status=0 QTime=1
[junit4] 2> 15175 T33 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 15176 T33 C9 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 15176 T33 oashd.SimplePropertiesWriter.readIndexerProperties
Read the.properties
[junit4] 2> 15179 T33 C9 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 15179 T33 C9 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 15179 T33 C9 oashd.DataImporter.doDeltaImport Starting Delta
Import
[junit4] 2> 15180 T33 C9
oashd.SimplePropertiesWriter.readIndexerProperties Read the.properties
[junit4] 2> 15181 T33 C9 oashd.DocBuilder.doDelta Starting delta
collection.
[junit4] 2> 15181 T33 C9 oashd.DocBuilder.collectDelta Running
ModifiedRowKey() for Entity: People
[junit4] 2> 15181 T33 C9 oashd.JdbcDataSource$1.call Creating a connection
for entity People with URL: jdbc:hsqldb:mem:.
[junit4] 2> 15182 T33 C9 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 15183 T33 C9 oashd.DocBuilder.findMatchingPkColumn Resolving
deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 15184 T33 C9 oashd.DocBuilder.collectDelta Completed
ModifiedRowKey for Entity: People rows obtained : 3
[junit4] 2> 15184 T33 C9 oashd.DocBuilder.collectDelta Completed
DeletedRowKey for Entity: People rows obtained : 8
[junit4] 2> 15184 T33 C9 oashd.DocBuilder.collectDelta Completed
parentDeltaQuery for Entity: People
[junit4] 2> 15185 T33 C9 oash
[...truncated too long message...]
9&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 15234 T33 C10 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:5&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=0
[junit4] 2> 15236 T33 C10 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:7&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=0
[junit4] 2> 15237 T33 C10 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:8&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=0
[junit4] 2> 15238 T33 C10 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:9&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=0
[junit4] 2> 15240 T33 C10 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:11&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=0
[junit4] 2> 15242 T33 C10 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:12&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=1
[junit4] 2> 15243 T33 C10 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:13&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=0
[junit4] 2> 15244 T33 C10 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:3&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=0
[junit4] 2> 15246 T33 C10 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:10&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=0
[junit4] 2> 15249 T33 oas.SolrTestCaseJ4.tearDown ###Ending
testWithSimpleTransformer
[junit4] 2> 15285 T33 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 15285 T33 oasc.CoreContainer.shutdown Shutting down
CoreContainer instance=6910676
[junit4] 2> 15286 T33 oasc.SolrCore.close [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@fe06a9
[junit4] 2> 15286 T33 oasu.DirectUpdateHandler2.close closing
DirectUpdateHandler2{commits=14,autocommits=0,soft
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=172,cumulative_deletesById=22,cumulative_deletesByQuery=9,cumulative_errors=0}
[junit4] 2> 15286 T33 oasu.SolrCoreState.decrefSolrCoreState Closing
SolrCoreState
[junit4] 2> 15287 T33 oasu.DefaultSolrCoreState.closeIndexWriter
SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 15287 T33 oasu.DefaultSolrCoreState.closeIndexWriter closing
IndexWriter with IndexWriterCloser
[junit4] 2> 15288 T33 oasc.SolrCore.closeSearcher [collection1] Closing
main searcher on request.
[junit4] 2> 15289 T33 oasc.CachingDirectoryFactory.close Closing
MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 15289 T33 oasc.CachingDirectoryFactory.closeCacheValue looking
to close
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index
[CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index;done=false>>]
[junit4] 2> 15290 T33 oasc.CachingDirectoryFactory.close Closing
directory:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001/index
[junit4] 2> 15290 T33 oasc.CachingDirectoryFactory.closeCacheValue looking
to close
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001
[CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001;done=false>>]
[junit4] 2> 15291 T33 oasc.CachingDirectoryFactory.close Closing
directory:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-561931E3FDF992BB-001/init-core-data-001
[junit4] 2> 6627 T32 ccr.ThreadLeakControl.checkThreadLeaks WARNING Will
linger awaiting termination of 1 leaked thread(s).
[junit4] 2> 26679 T32 ccr.ThreadLeakControl.checkThreadLeaks SEVERE 1
thread leaked from SUITE scope at
org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta:
[junit4] 2> 1) Thread[id=34, name=Timer-0, state=WAITING,
group=TGRP-TestSqlEntityProcessorDelta]
[junit4] 2> at java.lang.Object.wait(Native Method)
[junit4] 2> at java.lang.Object.wait(Object.java:502)
[junit4] 2> at
java.util.TimerThread.mainLoop(Timer.java:526)
[junit4] 2> at java.util.TimerThread.run(Timer.java:505)
[junit4] 2> 26680 T32 ccr.ThreadLeakControl.tryToInterruptAll Starting to
interrupt leaked threads:
[junit4] 2> 1) Thread[id=34, name=Timer-0, state=WAITING,
group=TGRP-TestSqlEntityProcessorDelta]
[junit4] 2> 29685 T32 ccr.ThreadLeakControl.tryToInterruptAll SEVERE There
are still zombie threads that couldn't be terminated:
[junit4] 2> 1) Thread[id=34, name=Timer-0, state=WAITING,
group=TGRP-TestSqlEntityProcessorDelta]
[junit4] 2> at java.lang.Object.wait(Native Method)
[junit4] 2> at java.lang.Object.wait(Object.java:502)
[junit4] 2> at
java.util.TimerThread.mainLoop(Timer.java:526)
[junit4] 2> at java.util.TimerThread.run(Timer.java:505)
[junit4] 2> NOTE: test params are: codec=Lucene49:
{NAME_mult_s=PostingsFormat(name=Direct), AddAColumn_s=Pulsing41(freqCutoff=3
minBlockSize=2 maxBlockSize=38), id=PostingsFormat(name=Memory doPackFST=
false), SPORT_NAME_mult_s=Pulsing41(freqCutoff=8 minBlockSize=2
maxBlockSize=38), COUNTRY_CODES_mult_s=PostingsFormat(name=Direct),
timestamp=Pulsing41(freqCutoff=3 minBlockSize=2 maxBlockSize=38)},
docValues:{}, sim=RandomSimilarityProvider(queryNorm=false,coord=crazy): {},
locale=iw_IL, timezone=Pacific/Saipan
[junit4] 2> NOTE: Linux 3.13.0-32-generic i386/Oracle Corporation
1.8.0_20-ea (32-bit)/cpus=8,threads=2,free=23953856,total=55574528
[junit4] 2> NOTE: All tests run in this JVM: [TestDocBuilder,
TestDocBuilder2, TestNumberFormatTransformer, TestSolrEntityProcessorUnit,
TestFileListEntityProcessor, TestFieldReader, TestEntityProcessorBase,
TestScriptTransformer, TestSqlEntityProcessorDelta]
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=TestSqlEntityProcessorDelta -Dtests.seed=561931E3FDF992BB
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=iw_IL
-Dtests.timezone=Pacific/Saipan -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J1 | TestSqlEntityProcessorDelta (suite) <<<
[junit4] > Throwable #1:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE
scope at org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta:
[junit4] > 1) Thread[id=34, name=Timer-0, state=WAITING,
group=TGRP-TestSqlEntityProcessorDelta]
[junit4] > at java.lang.Object.wait(Native Method)
[junit4] > at java.lang.Object.wait(Object.java:502)
[junit4] > at java.util.TimerThread.mainLoop(Timer.java:526)
[junit4] > at java.util.TimerThread.run(Timer.java:505)
[junit4] > at
__randomizedtesting.SeedInfo.seed([561931E3FDF992BB]:0)Throwable #2:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
[junit4] > 1) Thread[id=34, name=Timer-0, state=WAITING,
group=TGRP-TestSqlEntityProcessorDelta]
[junit4] > at java.lang.Object.wait(Native Method)
[junit4] > at java.lang.Object.wait(Object.java:502)
[junit4] > at java.util.TimerThread.mainLoop(Timer.java:526)
[junit4] > at java.util.TimerThread.run(Timer.java:505)
[junit4] > at
__randomizedtesting.SeedInfo.seed([561931E3FDF992BB]:0)
[junit4] Completed on J1 in 29.80s, 5 tests, 2 errors <<< FAILURES!
[...truncated 91 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:474: The following
error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:454: The following
error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:45: The following
error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/extra-targets.xml:37: The
following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build.xml:209: The
following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/common-build.xml:440:
The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/common-build.xml:496:
The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:1307:
The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:922:
There were test failures: 37 suites, 148 tests, 2 suite-level errors, 93 ignored
Total time: 93 minutes 47 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 32bit/jdk1.8.0_20-ea-b23 -server
-XX:+UseG1GC
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
