Build: https://builds.apache.org/job/Lucene-Solr-Tests-trunk-Java7/4794/
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=37, name=Timer-0, state=WAITING,
group=TGRP-TestSqlEntityProcessorDelta] at java.lang.Object.wait(Native
Method) at java.lang.Object.wait(Object.java:503) 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=37, name=Timer-0, state=WAITING,
group=TGRP-TestSqlEntityProcessorDelta]
at java.lang.Object.wait(Native Method)
at java.lang.Object.wait(Object.java:503)
at java.util.TimerThread.mainLoop(Timer.java:526)
at java.util.TimerThread.run(Timer.java:505)
at __randomizedtesting.SeedInfo.seed([BC001C04DD767F58]: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=37,
name=Timer-0, state=WAITING, group=TGRP-TestSqlEntityProcessorDelta] at
java.lang.Object.wait(Native Method) at
java.lang.Object.wait(Object.java:503) 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=37, name=Timer-0, state=WAITING,
group=TGRP-TestSqlEntityProcessorDelta]
at java.lang.Object.wait(Native Method)
at java.lang.Object.wait(Object.java:503)
at java.util.TimerThread.mainLoop(Timer.java:526)
at java.util.TimerThread.run(Timer.java:505)
at __randomizedtesting.SeedInfo.seed([BC001C04DD767F58]:0)
Build Log:
[...truncated 15598 lines...]
[junit4] Suite:
org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta
[junit4] 2> Creating dataDir:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001
[junit4] 2> 20316 T36 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl
(true) and clientAuth (true)
[junit4] 2> 23744 T36 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> 23745 T36 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/core-home-001/collection1/'
[junit4] 2> 23882 T36 oasc.SolrConfig.<init> Using Lucene MatchVersion:
LUCENE_5_0
[junit4] 2> 23954 T36 oasc.SolrConfig.<init> Loaded SolrConfig:
dataimport-solrconfig.xml
[junit4] 2> 23956 T36 oass.IndexSchema.readSchema Reading Solr Schema from
dataimport-schema.xml
[junit4] 2> 23983 T36 oass.IndexSchema.readSchema [null] Schema
name=dih_test
[junit4] 2> 24044 T36 oass.IndexSchema.readSchema default search field in
schema is desc
[junit4] 2> 24046 T36 oass.IndexSchema.readSchema query parser default
operator is OR
[junit4] 2> 24047 T36 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 24050 T36 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 24050 T36 oasc.SolrResourceLoader.locateSolrHome using system
property solr.solr.home:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/core-home-001
[junit4] 2> 24051 T36 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/core-home-001/'
[junit4] 2> 24127 T36 oasc.CoreContainer.<init> New CoreContainer
2114944958
[junit4] 2> 24128 T36 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/core-home-001/]
[junit4] 2> 24129 T36 oashc.HttpShardHandlerFactory.getParameter Setting
socketTimeout to: 0
[junit4] 2> 24130 T36 oashc.HttpShardHandlerFactory.getParameter Setting
urlScheme to: null
[junit4] 2> 24130 T36 oashc.HttpShardHandlerFactory.getParameter Setting
connTimeout to: 0
[junit4] 2> 24131 T36 oashc.HttpShardHandlerFactory.getParameter Setting
maxConnectionsPerHost to: 20
[junit4] 2> 24131 T36 oashc.HttpShardHandlerFactory.getParameter Setting
corePoolSize to: 0
[junit4] 2> 24132 T36 oashc.HttpShardHandlerFactory.getParameter Setting
maximumPoolSize to: 2147483647
[junit4] 2> 24132 T36 oashc.HttpShardHandlerFactory.getParameter Setting
maxThreadIdleTime to: 5
[junit4] 2> 24133 T36 oashc.HttpShardHandlerFactory.getParameter Setting
sizeOfQueue to: -1
[junit4] 2> 24133 T36 oashc.HttpShardHandlerFactory.getParameter Setting
fairnessPolicy to: false
[junit4] 2> 24139 T36 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=30000&connTimeout=30000&retry=false
[junit4] 2> 24142 T36 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 24143 T36 oasl.LogWatcher.newRegisteredLogWatcher Registering
Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 24143 T36 oasc.CoreContainer.load Host Name:
[junit4] 2> 24150 T38 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/core-home-001/collection1/'
[junit4] 2> 24209 T38 oasc.SolrConfig.<init> Using Lucene MatchVersion:
LUCENE_5_0
[junit4] 2> 24263 T38 oasc.SolrConfig.<init> Loaded SolrConfig:
dataimport-solrconfig.xml
[junit4] 2> 24265 T38 oass.IndexSchema.readSchema Reading Solr Schema from
dataimport-schema.xml
[junit4] 2> 24285 T38 oass.IndexSchema.readSchema [collection1] Schema
name=dih_test
[junit4] 2> 24342 T38 oass.IndexSchema.readSchema default search field in
schema is desc
[junit4] 2> 24344 T38 oass.IndexSchema.readSchema query parser default
operator is OR
[junit4] 2> 24352 T38 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 24354 T38 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from instancedir
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/core-home-001/collection1/
[junit4] 2> 24354 T38 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 24355 T38 oasc.SolrCore.<init> [collection1] Opening new
SolrCore at
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/core-home-001/collection1/,
dataDir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/
[junit4] 2> 24355 T38 oasc.SolrCore.<init> JMX monitoring not detected for
core: collection1
[junit4] 2> 24355 T38 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> 24356 T38 oasc.SolrCore.initListeners [collection1] Added
SolrEventListener for firstSearcher:
org.apache.solr.core.QuerySenderListener{queries=[]}
[junit4] 2> 24379 T38 oasc.CachingDirectoryFactory.get return new
directory for
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001
[junit4] 2> 24379 T38 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index/
[junit4] 2> 24380 T38 oasc.SolrCore.initIndex WARN [collection1] Solr
index directory
'/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index'
doesn't exist. Creating new index...
[junit4] 2> 24380 T38 oasc.CachingDirectoryFactory.get return new
directory for
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index
[junit4] 2> 24384 T38 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@19f594a
lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index),segFN=segments_1,generation=1}
[junit4] 2> 24384 T38 oasc.SolrDeletionPolicy.updateCommits newest commit
generation = 1
[junit4] 2> 24386 T38 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "" (default)
[junit4] 2> 24386 T38 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "" (default)
[junit4] 2> 24387 T38 oasc.RequestHandlers.initHandlersFromConfig created
/update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 24388 T38 oasc.RequestHandlers.initHandlersFromConfig created
/update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 24388 T38 oasc.RequestHandlers.initHandlersFromConfig created
/update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 24388 T38 oasc.RequestHandlers.initHandlersFromConfig created
/update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 24389 T38 oasc.RequestHandlers.initHandlersFromConfig created
standard: solr.StandardRequestHandler
[junit4] 2> 24389 T38 oasc.RequestHandlers.initHandlersFromConfig created
/dataimport: org.apache.solr.handler.dataimport.DataImportHandler
[junit4] 2> 24390 T38 oasc.RequestHandlers.initHandlersFromConfig created
/search: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 24390 T38 oasc.RequestHandlers.initHandlersFromConfig WARN
Multiple requestHandler registered to the same name: /update ignoring:
org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 24391 T38 oasc.RequestHandlers.initHandlersFromConfig created
/update: solr.UpdateRequestHandler
[junit4] 2> 24411 T38 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 24413 T38 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 24416 T38 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 24418 T38 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 24420 T38 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 24423 T38 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 24423 T38 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 24425 T38 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@19f594a
lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index),segFN=segments_1,generation=1}
[junit4] 2> 24425 T38 oasc.SolrDeletionPolicy.updateCommits newest commit
generation = 1
[junit4] 2> 24426 T38 oass.SolrIndexSearcher.<init> Opening
Searcher@201ab564[collection1] main
[junit4] 2> 24427 T38 oasr.ManagedResourceStorage$FileStorageIO.configure
File-based storage initialized to use dir:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/core-home-001/collection1/conf
[junit4] 2> 24428 T38 oasr.RestManager.init Initializing RestManager with
initArgs:
{storageDir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/core-home-001/collection1/conf}
[junit4] 2> 24428 T38 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using
file:dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/core-home-001/collection1/conf
[junit4] 2> 24429 T38 oasr.ManagedResource.reloadFromStorage WARN No
stored data found for /rest/managed
[junit4] 2> 24430 T38 oasr.ManagedResourceStorage$JsonStorage.store Saved
JSON object to path _rest_managed.json using
file:dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/core-home-001/collection1/conf
[junit4] 2> 24431 T38 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 24431 T39 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@201ab564[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 24431 T38 oasc.CoreContainer.registerCore registering core:
collection1
[junit4] 2> 24432 T39 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 24432 T39 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@201ab564[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 24434 T36 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 24446 T36 oas.SolrTestCaseJ4.setUp ###Starting
testChildEntities
[junit4] 2> ASYNC NEW_CORE C2 name=collection1
org.apache.solr.core.SolrCore@7cac5ecd
[junit4] 2> 24894 T36 C2 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 24904 T36 C2 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:*} 0 449
[junit4] 2> 24937 T36 C2 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 24939 T36 C2 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@19f594a
lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index),segFN=segments_1,generation=1}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@19f594a
lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index),segFN=segments_2,generation=2}
[junit4] 2> 24940 T36 C2 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 2
[junit4] 2> 24941 T36 C2 oass.SolrIndexSearcher.<init> Opening
Searcher@5e460b57[collection1] main
[junit4] 2> 24942 T36 C2 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 24942 T39 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@5e460b57[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 24944 T39 C2 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=solr&rows=10&distrib=false&event=newSearcher}
hits=0 status=0 QTime=1
[junit4] 2> 24944 T39 C2 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=rocks&rows=10&distrib=false&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 24945 T39 C2 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> 24946 T39 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 24946 T39 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@5e460b57[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 24946 T36 C2 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {commit=} 0 10
[junit4] 2> ASYNC NEW_CORE C3 name=collection1
org.apache.solr.core.SolrCore@7cac5ecd
[junit4] 2> 31389 T36 C3 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 31390 T36 C3 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 31390 T36 C3 oashd.DataImporter.doFullImport Starting Full
Import
[junit4] 2> 31454 T36 C3
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 31456 T36 C3 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 31470 T36 C3 oashd.JdbcDataSource$1.call Creating a connection
for entity People with URL: jdbc:derby:memory:derbyDB;territory=en_US
[junit4] 2> 31472 T36 C3 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 2
[junit4] 2> 31557 T36 C3 oashd.JdbcDataSource$1.call Creating a connection
for entity Sports with URL: jdbc:derby:memory:derbyDB;territory=en_US
[junit4] 2> 31559 T36 C3 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 1
[junit4] 2> 31900 T36 C3 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 31900 T36 C3 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 31916 T36 C3 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@19f594a
lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index),segFN=segments_2,generation=2}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@19f594a
lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index),segFN=segments_3,generation=3}
[junit4] 2> 31917 T36 C3 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 3
[junit4] 2> 31919 T36 C3 oass.SolrIndexSearcher.<init> Opening
Searcher@2aae91f8[collection1] main
[junit4] 2> 31920 T36 C3 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 31921 T39 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@2aae91f8[collection1]
main{UninvertingDirectoryReader(Uninverting(_0(5.0):C20))}
[junit4] 2> 31922 T39 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=solr&rows=10&distrib=false&event=newSearcher}
hits=0 status=0 QTime=1
[junit4] 2> 31922 T39 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=rocks&rows=10&distrib=false&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 31923 T39 C3 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> 31924 T39 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 31924 T39 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@2aae91f8[collection1]
main{UninvertingDirectoryReader(Uninverting(_0(5.0):C20))}
[junit4] 2> 31925 T36 C3
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 31926 T36 C3 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 31927 T36 C3 oashd.DocBuilder.execute Time taken = 0:0:0.471
[junit4] 2> 31927 T36 C3 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null
params={command=full-import&indent=true&synchronous=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-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"+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+name%3D"Sports"+dataSource%3D"derby"+transformer%3D"AddAColumnTransformer"+newColumnName%3D"sportsAdded_s"+newColumnValue%3D"sport_added"+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&commit=true&clean=true}
{deleteByQuery=*:*,add=[1, 2, 3, 4, 5, 6, 7, 8, 9, 10, ... (20 adds)],commit=}
0 554
[junit4] 2> 31935 T36 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=*:*&rows=20&version=2.2&qt=standard} hits=20
status=0 QTime=3
[junit4] 2> 32001 T36 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=AddAColumn_s:Added&rows=20&version=2.2&qt=standard}
hits=20 status=0 QTime=22
[junit4] 2> 32014 T36 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={start=0&q=SPORT_NAME_mult_s:Sailing&rows=20&version=2.2&qt=standard}
hits=2 status=0 QTime=1
[junit4] 2> 32093 T36 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={start=0&q=NAME_mult_s:Michael&rows=20&version=2.2&qt=standard} hits=1
status=0 QTime=1
[junit4] 2> 32103 T36 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={start=0&q=sportsAdded_s:sport_added&rows=20&version=2.2&qt=standard}
hits=20 status=0 QTime=3
[junit4] 2> 32115 T36 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 32116 T36 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 32117 T36 oashd.SimplePropertiesWriter.readIndexerProperties
Read the.properties
[junit4] 2> 32203 T36 C3 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 32204 T36 C3 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 32204 T36 C3 oashd.DataImporter.doDeltaImport Starting Delta
Import
[junit4] 2> 32205 T36 C3
oashd.SimplePropertiesWriter.readIndexerProperties Read the.properties
[junit4] 2> 32207 T36 C3 oashd.DocBuilder.doDelta Starting delta
collection.
[junit4] 2> 32208 T36 C3 oashd.DocBuilder.collectDelta Running
ModifiedRowKey() for Entity: Sports
[junit4] 2> 32208 T36 C3 oashd.DocBuilder.collectDelta Completed
ModifiedRowKey for Entity: Sports rows obtained : 0
[junit4] 2> 32209 T36 C3 oashd.DocBuilder.collectDelta Completed
DeletedRowKey for Entity: Sports rows obtained : 0
[junit4] 2> 32209 T36 C3 oashd.DocBuilder.collectDelta Completed
parentDeltaQuery for Entity: Sports
[junit4] 2> 32210 T36 C3 oashd.DocBuilder.collectDelta Running
ModifiedRowKey() for Entity: People
[junit4] 2> 32210 T36 C3 oashd.JdbcDataSource$1.call Creating a connection
for entity People with URL: jdbc:derby:memory:derbyDB;territory=en_US
[junit4] 2> 32212 T36 C3 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 1
[junit4] 2> 32284 T36 C3 oashd.DocBuilder.collectDelta Completed
ModifiedRowKey for Entity: People rows obtained : 7
[junit4] 2> 32285 T36 C3 oashd.DocBuilder.collectDelta Completed
DeletedRowKey for Entity: People rows obtained : 5
[junit4] 2> 32285 T36 C3 oashd.DocBuilder.collectDelta Completed
parentDeltaQuery for Entity: People
[junit4] 2> 32286 T36 C3 oashd.DocBuilder.deleteAll Deleting stale
documents
[junit4] 2> 32287 T36 C3 oashd.SolrWriter.deleteDoc Deleting document: 7
[junit4] 2> 32287 T36 C3 oashd.SolrWriter.deleteDoc Deleting document: 17
[junit4] 2> 32288 T36 C3 oashd.SolrWriter.deleteDoc Deleting document: 10
[junit4] 2> 32289 T36 C3 oashd.SolrWriter.deleteDoc Deleting document: 14
[junit4] 2> 32289 T36 C3 oashd.SolrWriter.deleteDoc Deleting document: 8
[junit4] 2> 32298 T36 C3 oashd.JdbcDataSource$1.call Creating a connection
for entity Sports with URL: jdbc:derby:memory:derbyDB;territory=en_US
[junit4] 2> 32300 T36 C3 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 1
[junit4] 2> 32356 T36 C3 oashd.DocBuilder.doDelta Delta Import completed
successfully
[junit4] 2> 32356 T36 C3 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 32357 T36 C3 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 32426 T36 C3 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@19f594a
lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index),segFN=segments_3,generation=3}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@19f594a
lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index),segFN=segments_4,generation=4}
[junit4] 2> 32427 T36 C3 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 4
[junit4] 2> 32440 T36 C3 oass.SolrIndexSearcher.<init> Opening
Searcher@41d4f636[collection1] main
[junit4] 2> 32441 T36 C3 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 32446 T39 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@41d4f636[collection1]
main{UninvertingDirectoryReader(Uninverting(_0(5.0):C20/12:delGen=1)
Uninverting(_1(5.0):C7))}
[junit4] 2> 32448 T39 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=solr&rows=10&distrib=false&event=newSearcher}
hits=0 status=0 QTime=1
[junit4] 2> 32449 T39 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=rocks&rows=10&distrib=false&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 32450 T39 C3 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> 32450 T39 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 32451 T39 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@41d4f636[collection1]
main{UninvertingDirectoryReader(Uninverting(_0(5.0):C20/12:delGen=1)
Uninverting(_1(5.0):C7))}
[junit4] 2> 32452 T36 C3
oashd.SimplePropertiesWriter.readIndexerProperties Read the.properties
[junit4] 2> 32454 T36 C3 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 32454 T36 C3 oashd.DocBuilder.execute Time taken = 0:0:0.248
[junit4] 2> 32455 T36 C3 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null
params={command=delta-import&indent=true&synchronous=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-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"+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+name%3D"Sports"+dataSource%3D"derby"+transformer%3D"AddAColumnTransformer"+newColumnName%3D"sportsAdded_s"+newColumnValue%3D"sport_added"+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&commit=true&clean=false}
{delete=[7, 17, 10, 14, 8],add=[4, 11, 20, 16, 3, 18, 6],commit=} 0 266
[junit4] 2> 32461 T36 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=*:*&rows=20&version=2.2&qt=standard} hits=15
status=0 QTime=2
[junit4] 2> 32482 T36 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={start=0&q=NAME_mult_s:MODIFIED\+Michael&rows=20&version=2.2&qt=standard}
hits=1 status=0 QTime=1
[junit4] 2> 32490 T36 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:17&rows=20&version=2.2&qt=standard} hits=0
status=0 QTime=0
[junit4] 2> 32494 T36 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:7&rows=20&version=2.2&qt=standard} hits=0
status=0 QTime=1
[junit4] 2> 32497 T36 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:10&rows=20&version=2.2&qt=standard} hits=0
status=0 QTime=0
[junit4] 2> 32501 T36 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:8&rows=20&version=2.2&qt=standard} hits=0
status=0 QTime=1
[junit4] 2> 32504 T36 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:14&rows=20&version=2.2&qt=standard} hits=0
status=0 QTime=0
[junit4] 2> 32508 T36 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:6&rows=20&version=2.2&qt=standard} hits=1
status=0 QTime=1
[junit4] 2> 32513 T36 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:20&rows=20&version=2.2&qt=standard} hits=1
status=0 QTime=0
[junit4] 2> 32519 T36 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:4&rows=20&version=2.2&qt=standard} hits=1
status=0 QTime=1
[junit4] 2> 32524 T36 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:3&rows=20&version=2.2&qt=standard} hits=1
status=0 QTime=1
[junit4] 2> 32529 T36 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:18&rows=20&version=2.2&qt=standard} hits=1
status=0 QTime=0
[junit4] 2> 32534 T36 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:16&rows=20&version=2.2&qt=standard} hits=1
status=0 QTime=0
[junit4] 2> 32540 T36 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:11&rows=20&version=2.2&qt=standard} hits=1
status=0 QTime=1
[junit4] 2> 33172 T36 oas.SolrTestCaseJ4.tearDown ###Ending
testChildEntities
[junit4] 2> 33191 T36 oas.SolrTestCaseJ4.setUp ###Starting
testWithSimpleTransformer
[junit4] 2> 33194 T36 C3 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 33195 T36 C3 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> 33202 T36 C3 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 33203 T36 C3 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@19f594a
lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index),segFN=segments_4,generation=4}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@19f594a
lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index),segFN=segments_5,generation=5}
[junit4] 2> 33204 T36 C3 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 5
[junit4] 2> 33205 T36 C3 oass.SolrIndexSearcher.<init> Opening
Searcher@5d1e597f[collection1] main
[junit4] 2> 33206 T36 C3 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 33207 T39 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@5d1e597f[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 33209 T39 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=solr&rows=10&distrib=false&event=newSearcher}
hits=0 status=0 QTime=1
[junit4] 2> 33210 T39 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=rocks&rows=10&distrib=false&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 33212 T39 C3 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> 33212 T39 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 33213 T39 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@5d1e597f[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 33216 T36 C3 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {commit=} 0 14
[junit4] 2> ASYNC NEW_CORE C4 name=collection1
org.apache.solr.core.SolrCore@7cac5ecd
[junit4] 2> 34296 T36 C4 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 34296 T36 C4 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 34297 T36 C4 oashd.DataImporter.doFullImport Starting Full
Import
[junit4] 2> 34298 T36 C4
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 34299 T36 C4 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 34302 T36 C4 oashd.JdbcDataSource$1.call Creating a connection
for entity People with URL: jdbc:hsqldb:mem:.
[junit4] 2> 34302 T36 C4 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 34358 T36 C4 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 34359 T36 C4 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 34368 T36 C4 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@19f594a
lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index),segFN=segments_5,generation=5}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@19f594a
lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index),segFN=segments_6,generation=6}
[junit4] 2> 34369 T36 C4 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 6
[junit4] 2> 34371 T36 C4 oass.SolrIndexSearcher.<init> Opening
Searcher@7058ceb0[collection1] main
[junit4] 2> 34372 T36 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 34377 T39 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@7058ceb0[collection1]
main{UninvertingDirectoryReader(Uninverting(_2(5.0):C20))}
[junit4] 2> 34377 T39 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=solr&rows=10&distrib=false&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 34378 T39 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=rocks&rows=10&distrib=false&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 34380 T39 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=2
[junit4] 2> 34380 T39 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 34381 T39 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@7058ceb0[collection1]
main{UninvertingDirectoryReader(Uninverting(_2(5.0):C20))}
[junit4] 2> 34382 T36 C4
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 34383 T36 C4 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 34383 T36 C4 oashd.DocBuilder.execute Time taken = 0:0:0.84
[junit4] 2> 34384 T36 C4 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null
params={command=full-import&indent=true&synchronous=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-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"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&commit=true&clean=true}
{deleteByQuery=*:*,add=[1, 2, 3, 4, 5, 6, 7, 8, 9, 10, ... (20 adds)],commit=}
0 103
[junit4] 2> 34395 T36 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=AddAColumn_s:Added&rows=20&version=2.2&qt=standard}
hits=20 status=0 QTime=1
[junit4] 2> 34413 T36 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 34414 T36 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 34416 T36 oashd.SimplePropertiesWriter.readIndexerProperties
Read the.properties
[junit4] 2> 34427 T36 C4 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 34428 T36 C4 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 34428 T36 C4 oashd.DataImporter.doDeltaImport Starting Delta
Import
[junit4] 2> 34429 T36 C4
oashd.SimplePropertiesWriter.readIndexerProperties Read the.properties
[junit4] 2> 34431 T36 C4 oashd.DocBuilder.doDelta Starting delta
collection.
[junit4] 2> 34432 T36 C4 oashd.DocBuilder.collectDelta Running
ModifiedRowKey() for Entity: People
[junit4] 2> 34432 T36 C4 oashd.JdbcDataSource$1.call Creating a connection
for entity People with URL: jdbc:hsqldb:mem:.
[junit4] 2> 34433 T36 C4 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 34445 T36 C4 oashd.DocBuilder.collectDelta Completed
ModifiedRowKey for Entity: People rows obtained : 3
[junit4] 2> 34445 T36 C4 oashd.DocBuilder.collectDelta Completed
DeletedRowKey for Entity: People rows obtained : 3
[junit4] 2> 34446 T36 C4 oashd.DocBuilder.collectDelta Completed
parentDeltaQuery for Entity: People
[junit4] 2> 34447 T36 C4 oashd.DocBuilder.deleteAll Deleting stale
documents
[junit4] 2> 34447 T36 C4 oashd.SolrWriter.deleteDoc Deleting document: 17
[junit4] 2> 34448 T36 C4 oashd.SolrWriter.deleteDoc Deleting document: 5
[junit4] 2> 34448 T36 C4 oashd.SolrWriter.deleteDoc Deleting document: 8
[junit4] 2> 34453 T36 C4 oashd.DocBuilder.doDelta Delta Import completed
successfully
[junit4] 2> 34454 T36 C4 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 34454 T36 C4 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 34461 T36 C4 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@19f594a
lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index),segFN=segments_6,generation=6}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@19f594a
lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index),segFN=segments_7,generation=7}
[junit4] 2> 34462 T36 C4 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 7
[junit4] 2> 34465 T36 C4 oass.SolrIndexSearcher.<init> Opening
Searcher@496f9903[collection1] main
[junit4] 2> 34466 T36 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 34473 T39 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@496f9903[collection1]
main{UninvertingDirectoryReader(Uninverting(_2(5.0):C20/6:delGen=1)
Uninverting(_3(5.0):C3))}
[junit4] 2> 34473 T39 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=solr&rows=10&distrib=false&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 34474 T39 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=rocks&rows=10&distrib=false&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 34475 T39 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> 34475 T39 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 34476 T39 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@496f9903[collection1]
main{UninvertingDirectoryReader(Uninverting(_2(5.0):C20/6:delGen=1)
Uninverting(_3(5.0):C3))}
[junit4] 2> 34477 T36 C4
oashd.SimplePropertiesWriter.readIndexerProperties Read the.properties
[junit4] 2> 34478 T36 C4 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 34478 T36 C4 oashd.DocBuilder.execute Time taken = 0:0:0.48
[junit4] 2> 34479 T36 C4 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null
params={command=delta-import&indent=true&synchronous=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-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&commit=true&clean=false}
{delete=[17, 5, 8],add=[3, 18, 6],commit=} 0 56
[junit4] 2> 34482 T36 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=AddAColumn_s:Added&rows=20&version=2.2&qt=standard}
hits=17 status=0 QTime=1
[junit4] 2> 34493 T36 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=1
[junit4] 2> 34494 T36 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 34495 T36 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:8&rows=20&version=2.2&qt=standard} hits=0
status=0 QTime=0
[junit4] 2> 34498 T36 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:17&rows=20&version=2.2&qt=standard} hits=0
status=0 QTime=0
[junit4] 2> 34502 T36 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:5&rows=20&version=2.2&qt=standard} hits=0
status=0 QTime=1
[junit4] 2> 34506 T36 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:6&rows=20&version=2.2&qt=standard} hits=1
status=0 QTime=1
[junit4] 2> 34511 T36 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:18&rows=20&version=2.2&qt=standard} hits=1
status=0 QTime=1
[junit4] 2> 34516 T36 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:3&rows=20&version=2.2&qt=standard} hits=1
status=0 QTime=0
[junit4] 2> 34532 T36 oas.SolrTestCaseJ4.tearDown ###Ending
testWithSimpleTransformer
[junit4] 2> 34549 T36 oas.SolrTestCaseJ4.setUp ###Starting testSingleEntity
[junit4] 2> 34552 T36 C4 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 34553 T36 C4 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:*} 0 2
[junit4] 2> 34560 T36 C4 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 34561 T36 C4 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@19f594a
lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index),segFN=segments_7,generation=7}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@19f594a
lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index),segFN=segments_8,generation=8}
[junit4] 2> 34562 T36 C4 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 8
[junit4] 2> 34563 T36 C4 oass.SolrIndexSearcher.<init> Opening
Searcher@26313223[collection1] main
[junit4] 2> 34564 T36 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 34565 T39 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@26313223[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 34566 T39 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=solr&rows=10&distrib=false&event=newSearcher}
hits=0 status=0 QTime=1
[junit4] 2> 34566 T39 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=rocks&rows=10&distrib=false&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 34567 T39 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=0
[junit4] 2> 34567 T39 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 34568 T39 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@26313223[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 34569 T36 C4 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {commit=} 0 9
[junit4] 2> 34627 T36 C4 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 34628 T36 C4 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 34628 T36 C4 oashd.DataImporter.doFullImport Starting Full
Import
[junit4] 2> 34630 T36 C4
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 34631 T36 C4 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 34633 T36 C4 oashd.JdbcDataSource$1.call Creating a connection
for entity People with URL: jdbc:hsqldb:mem:.
[junit4] 2> 34634 T36 C4 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 34645 T36 C4 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 34646 T36 C4 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 34654 T36 C4 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@19f594a
lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index),segFN=segments_8,generation=8}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@19f594a
lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index),segFN=segments_9,generation=9}
[junit4] 2> 34655 T36 C4 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 9
[junit4] 2> 34657 T36 C4 oass.SolrIndexSearcher.<init> Opening
Searcher@59ec699a[collection1] main
[junit4] 2> 34658 T36 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 34663 T39 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@59ec699a[collection1]
main{UninvertingDirectoryReader(Uninverting(_4(5.0):C20))}
[junit4] 2> 34664 T39 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=solr&rows=10&distrib=false&event=newSearcher}
hits=0 status=0 QTime=1
[junit4] 2> 34664 T39 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=rocks&rows=10&distrib=false&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 34665 T39 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=0
[junit4] 2> 34665 T39 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 34666 T39 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@59ec699a[collection1]
main{UninvertingDirectoryReader(Uninverting(_4(5.0):C20))}
[junit4] 2> 34667 T36 C4
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 34668 T36 C4 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 34668 T36 C4 oashd.DocBuilder.execute Time taken = 0:0:0.37
[junit4] 2> 34669 T36 C4 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null
params={command=full-import&indent=true&synchronous=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-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"+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&commit=true&clean=true}
{deleteByQuery=*:*,add=[1, 2, 3, 4, 5, 6, 7, 8, 9, 10, ... (20 adds)],commit=}
0 58
[junit4] 2> 34672 T36 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=*:*&rows=20&version=2.2&qt=standard} hits=20
status=0 QTime=1
[junit4] 2> 34683 T36 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 34684 T36 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 34685 T36 oashd.SimplePropertiesWriter.readIndexerProperties
Read the.properties
[junit4] 2> 34692 T36 C4 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 34692 T36 C4 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 34693 T36 C4 oashd.DataImporter.doDeltaImport Starting Delta
Import
[junit4] 2> 34694 T36 C4
oashd.SimplePropertiesWriter.readIndexerProperties Read the.properties
[junit4] 2> 34695 T36 C4 oashd.DocBuilder.doDelta Starting delta
collection.
[junit4] 2> 34696 T36 C4 oashd.DocBuilder.collectDelta Running
ModifiedRowKey() for Entity: People
[junit4] 2> 34696 T36 C4 oashd.JdbcDataSource$1.call Creating a connection
for entity People with URL: jdbc:hsqldb:mem:.
[junit4] 2> 34697 T36 C4 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 34701 T36 C4 oashd.DocBuilder.collectDelta Completed
ModifiedRowKey for Entity: People rows obtained : 3
[junit4] 2> 34702 T36 C4 oashd.DocBuilder.collectDelta Completed
DeletedRowKey for Entity: People rows obtained : 2
[junit4] 2> 34702 T36 C4 oashd.DocBuilder.collectDelta Completed
parentDeltaQuery for Entity: People
[junit4] 2> 34703 T36 C4 oashd.DocBuilder.deleteAll Deleting stale
documents
[junit4] 2> 34703 T36 C4 oashd.SolrWriter.deleteDoc Deleting document: 9
[junit4] 2> 34704 T36 C4 oashd.SolrWriter.deleteDoc Deleting document: 14
[junit4] 2> 34709 T36 C4 oashd.DocBuilder.doDelta Delta Import completed
successfully
[junit4] 2> 34709 T36 C4 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 34710 T36 C4 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 34717 T36 C4 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@19f594a
lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index),segFN=segments_9,generation=9}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@19f594a
lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index),segFN=segments_a,generation=10}
[junit4] 2> 34718 T36 C4 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 10
[junit4] 2> 34720 T36 C4 oass.SolrIndexSearcher.<init> Opening
Searcher@36049b80[collection1] main
[junit4] 2> 34721 T36 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 34728 T39 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@36049b80[collection1]
main{UninvertingDirectoryReader(Uninverting(_4(5.0):C20/3:delGen=1)
Uninverting(_5(5.0):C3))}
[junit4] 2> 34729 T39 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=solr&rows=10&distrib=false&event=newSearcher}
hits=0 status=0 QTime=1
[junit4] 2> 34729 T39 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=rocks&rows=10&distrib=false&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 34730 T39 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=0
[junit4] 2> 34730 T39 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 34731 T39 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@36049b80[collection1]
main{UninvertingDirectoryReader(Uninverting(_4(5.0):C20/3:delGen=1)
Uninverting(_5(5.0):C3))}
[junit4] 2> 34732 T36 C4
oashd.SimplePropertiesWriter.readIndexerProperties Read the.properties
[junit4] 2> 34733 T36 C4 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 34733 T36 C4 oashd.DocBuilder.execute Time taken = 0:0:0.39
[junit4] 2> 34734 T36 C4 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null
params={command=delta-import&indent=true&synchronous=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-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&commit=true&clean=false}
{delete=[9, 14],add=[5, 1018, 1015],commit=} 0 46
[junit4] 2> 34737 T36 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=*:*&rows=20&version=2.2&qt=standard} hits=20
status=0 QTime=1
[junit4] 2> 34747 T36 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 34749 T36 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=1
[junit4] 2> 34750 T36 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:1018&rows=20&version=2.2&qt=standard} hits=1
status=0 QTime=1
[junit4] 2> 34755 T36 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:1015&rows=20&version=2.2&qt=standard} hits=1
status=0 QTime=1
[junit4] 2> 34759 T36 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:14&rows=20&version=2.2&qt=standard} hits=0
status=0 QTime=1
[junit4] 2> 34763 T36 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:9&rows=20&version=2.2&qt=standard} hits=0
status=0 QTime=1
[junit4] 2> 34766 T36 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:5&rows=20&version=2.2&qt=standard} hits=1
status=0 QTime=0
[junit4] 2> 34772 T36 oas.SolrTestCaseJ4.tearDown ###Ending
testSingleEntity
[junit4] 2> 34789 T36 oas.SolrTestCaseJ4.setUp ###Starting
testDeltaImportWithoutInitialFullImport
[junit4] 2> 34792 T36 C4 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 34793 T36 C4 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:*} 0 2
[junit4] 2> 34800 T36 C4 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 34801 T36 C4 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@19f594a
lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index),segFN=segments_a,generation=10}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@19f594a
lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index),segFN=segments_b,generation=11}
[junit4] 2> 34802 T36 C4 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 11
[junit4] 2> 34803 T36 C4 oass.SolrIndexSearcher.<init> Opening
Searcher@72086f9a[collection1] main
[junit4] 2> 34803 T36 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 34805 T39 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@72086f9a[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 34806 T39 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=solr&rows=10&distrib=false&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 34807 T39 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=rocks&rows=10&distrib=false&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 34808 T39 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> 34809 T39 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 34809 T39 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@72086f9a[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 34811 T36 C4 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {commit=} 0 11
[junit4] 2> 35366 T36 C4 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 35367 T36 C4 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 35367 T36 C4 oashd.DataImporter.doDeltaImport Starting Delta
Import
[junit4] 2> 35369 T36 C4
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 35370 T36 C4 oashd.DocBuilder.doDelta Starting delta
collection.
[junit4] 2> 35371 T36 C4 oashd.DocBuilder.collectDelta Running
ModifiedRowKey() for Entity: People
[junit4] 2> 35371 T36 C4 oashd.JdbcDataSource$1.call Creating a connection
for entity People with URL: jdbc:derby:memory:derbyDB;territory=en_US
[junit4] 2> 35373 T36 C4 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 1
[junit4] 2> 35420 T36 C4 oashd.DocBuilder.collectDelta Completed
ModifiedRowKey for Entity: People rows obtained : 20
[junit4] 2> 35421 T36 C4 oashd.DocBuilder.collectDelta Completed
DeletedRowKey for Entity: People rows obtained : 0
[junit4] 2> 35422 T36 C4 oashd.DocBuilder.collectDelta Completed
parentDeltaQuery for Entity: People
[junit4] 2> 35575 T36 C4 oashd.DocBuilder.doDelta Delta Import completed
successfully
[junit4] 2> 35576 T36 C4 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 35576 T36 C4 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 35584 T36 C4 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@19f594a
lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index),segFN=segments_b,generation=11}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@19f594a
lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index),segFN=segments_c,generation=12}
[junit4] 2> 35584 T36 C4 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 12
[junit4] 2> 35587 T36 C4 oass.SolrIndexSearcher.<init> Opening
Searcher@29e78923[collection1] main
[junit4] 2> 35587 T36 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 35594 T39 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@29e78923[collection1]
main{UninvertingDirectoryReader(Uninverting(_6(5.0):C20))}
[junit4] 2> 35595 T39 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=solr&rows=10&distrib=false&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 35596 T39 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=rocks&rows=10&distrib=false&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 35597 T39 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=0
[junit4] 2> 35598 T39 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 35598 T39 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@29e78923[collection1]
main{UninvertingDirectoryReader(Uninverting(_6(5.0):C20))}
[junit4] 2> 35599 T36 C4
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 35600 T36 C4 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 35601 T36 C4 oashd.DocBuilder.execute Time taken = 0:0:0.231
[junit4] 2> 35601 T36 C4 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null
params={command=delta-import&indent=true&synchronous=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-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}'+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&commit=true&clean=false}
{add=[11, 10, 9, 8, 15, 14, 13, 12, 3, 2, ... (20 adds)],commit=} 0 252
[junit4] 2> 35607 T36 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=*:*&rows=20&version=2.2&qt=standard} hits=20
status=0 QTime=2
[junit4] 2> 35618 T36 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 35619 T36 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 36130 T36 oas.SolrTestCaseJ4.tearDown ###Ending
testDeltaImportWithoutInitialFullImport
[junit4] 2> 36152 T36 oas.SolrTestCaseJ4.setUp ###Starting
testWithComplexTransformer
[junit4] 2> 36157 T36 C4 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 36158 T36 C4 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> 36170 T36 C4 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 36171 T36 C4 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@19f594a
lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index),segFN=segments_c,generation=12}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@19f594a
lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index),segFN=segments_d,generation=13}
[junit4] 2> 36172 T36 C4 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 13
[junit4] 2> 36173 T36 C4 oass.SolrIndexSearcher.<init> Opening
Searcher@75e85d4a[collection1] main
[junit4] 2> 36174 T36 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 36176 T39 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@75e85d4a[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 36177 T39 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=solr&rows=10&distrib=false&event=newSearcher}
hits=0 status=0 QTime=1
[junit4] 2> 36178 T39 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=rocks&rows=10&distrib=false&event=newSearcher}
hits=0 status=0 QTime=1
[junit4] 2> 36179 T39 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> 36179 T39 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 36180 T39 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@75e85d4a[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 36181 T36 C4 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {commit=} 0 11
[junit4] 2> 36272 T36 C4 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 36273 T36 C4 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 36274 T36 C4 oashd.DataImporter.doFullImport Starting Full
Import
[junit4] 2> 36275 T36 C4
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 36277 T36 C4 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 36278 T36 C4 oashd.JdbcDataSource$1.call Creating a connection
for entity People with URL: jdbc:hsqldb:mem:.
[junit4] 2> 36279 T36 C4 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 36456 T36 C4 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 36457 T36 C4 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 36516 T36 C4 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@19f594a
lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index),segFN=segments_d,generation=13}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@19f594a
lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index),segFN=segments_e,generation=14}
[junit4] 2> 36517 T36 C4 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 14
[junit4] 2> 36520 T36 C4 oass.SolrIndexSearcher.<init> Opening
Searcher@5d312788[collection1] main
[junit4] 2> 36522 T36 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 36531 T39 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@5d312788[collection1]
main{UninvertingDirectoryReader(Uninverting(_7(5.0):C60))}
[junit4] 2> 36532 T39 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=solr&rows=10&distrib=false&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 36533 T39 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=rocks&rows=10&distrib=false&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 36534 T39 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=0
[junit4] 2> 36535 T39 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 36536 T39 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@5d312788[collection1]
main{UninvertingDirectoryReader(Uninverting(_7(5.0):C60))}
[junit4] 2> 36538 T36 C4
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 36540 T36 C4 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 36541 T36 C4 oashd.DocBuilder.execute Time taken = 0:0:0.264
[junit4] 2> 36541 T36 C4 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null
params={command=full-import&indent=true&synchronous=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-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&commit=true&clean=true}
{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 295
[junit4] 2> ASYNC NEW_CORE C5 name=collection1
org.apache.solr.core.SolrCore@7cac5ecd
[junit4] 2> 37267 T36 C5 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=*:*&rows=60&sort=id+asc} hits=60 status=0 QTime=722
[junit4] 2> 37388 T36 C5 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={start=0&q=id:TripleThreat-1-*&rows=20&version=2.2&qt=standard} hits=20
status=0 QTime=71
[junit4] 2> 37400 T36 C5 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={start=0&q=id:TripleThreat-2-*&rows=20&version=2.2&qt=standard} hits=20
status=0 QTime=2
[junit4] 2> 37436 T36 C5 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={start=0&q=%2Bid:TripleThreat-1-3+%2BNAME_mult_s:Michael+%2BNAME_mult_s:leahciM++%2BCOUNTRY_CODES_mult_s:NR+%2BCOUNTRY_CODES_mult_s:RN&rows=20&version=2.2&qt=standard}
hits=1 status=0 QTime=24
[junit4] 2> 37441 T36 C5 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=AddAColumn_s:Added&rows=20&version=2.2&qt=standard}
hits=20 status=0 QTime=1
[junit4] 2> 37452 T36 C5 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=1
[junit4] 2> 37453 T36 C5 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 37455 T36 oashd.SimplePropertiesWriter.readIndexerProperties
Read the.properties
[junit4] 2> 37483 T36 C5 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 37484 T36 C5 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 37485 T36 C5 oashd.DataImporter.doDeltaImport Starting Delta
Import
[junit4] 2> 37486 T36 C5
oashd.SimplePropertiesWriter.readIndexerProperties Read the.properties
[junit4] 2> 37487 T36 C5 oashd.DocBuilder.doDelta Starting delta
collection.
[junit4] 2> 37488 T36 C5 oashd.DocBuilder.collectDelta Running
ModifiedRowKey() for Entity: People
[junit4] 2> 37489 T36 C5 oashd.JdbcDataSource$1.call Creating a connection
for entity People with URL: jdbc:hsqldb:mem:.
[junit4] 2> 37490 T36 C5 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 37495 T36 C5 oashd.DocBuilder.collectDelta Completed
ModifiedRowKey for Entity: People rows obtained : 5
[junit4] 2> 37496 T36 C5 oashd.DocBuilder.collectDelta Completed
DeletedRowKey for Entity: People rows obtained : 5
[junit4] 2> 37497 T36 C5 oashd.DocBuilder.collectDelta Completed
parentDeltaQuery for Entity: People
[junit4] 2> 37498 T36 C5 oashd.DocBuilder.deleteAll Deleting stale
documents
[junit4] 2> 37498 T36 C5 oashd.SolrWriter.deleteDoc Deleting document: 14
[junit4] 2> 37499 T36 C5 oashd.SolrWriter.deleteDoc Deleting document: 8
[junit4] 2> 37499 T36 C5 oashd.SolrWriter.deleteDoc Deleting document: 20
[junit4] 2> 37500 T36 C5 oashd.SolrWriter.deleteDoc Deleting document: 4
[junit4] 2> 37501 T36 C5 oashd.SolrWriter.deleteDoc Deleting document: 16
[junit4] 2> 37516 T36 C5 oashd.DocBuilder.doDelta Delta Import completed
successfully
[junit4] 2> 37516 T36 C5 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 37517 T36 C5 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 37527 T36 C5 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@19f594a
lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index),segFN=segments_e,generation=14}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@19f594a
lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index),segFN=segments_f,generation=15}
[junit4] 2> 37528 T36 C5 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 15
[junit4] 2> 37531 T36 C5 oass.SolrIndexSearcher.<init> Opening
Searcher@4d50f804[collection1] main
[junit4] 2> 37532 T36 C5 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 37552 T39 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@4d50f804[collection1]
main{UninvertingDirectoryReader(Uninverting(_7(5.0):C60/17:delGen=1)
Uninverting(_8(5.0):C15))}
[junit4] 2> 37554 T39 C5 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=solr&rows=10&distrib=false&event=newSearcher}
hits=0 status=0 QTime=1
[junit4] 2> 37555 T39 C5 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=rocks&rows=10&distrib=false&event=newSearcher}
hits=0 status=0 QTime=1
[junit4] 2> 37556 T39 C5 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> 37556 T39 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 37557 T39 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@4d50f804[collection1]
[...truncated too long message...]
status=0 QTime=0
[junit4] 2> 37617 T36 C5 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:1005&rows=20&version=2.2&qt=standard} hits=1
status=0 QTime=1
[junit4] 2> 37620 T36 C5 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:16&rows=20&version=2.2&qt=standard} hits=0
status=0 QTime=0
[junit4] 2> 37623 T36 C5 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:4&rows=20&version=2.2&qt=standard} hits=0
status=0 QTime=0
[junit4] 2> 37626 T36 C5 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:20&rows=20&version=2.2&qt=standard} hits=0
status=0 QTime=0
[junit4] 2> 37629 T36 C5 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:8&rows=20&version=2.2&qt=standard} hits=0
status=0 QTime=1
[junit4] 2> 37632 T36 C5 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:14&rows=20&version=2.2&qt=standard} hits=0
status=0 QTime=1
[junit4] 2> 37635 T36 C5 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:19&rows=20&version=2.2&qt=standard} hits=1
status=0 QTime=1
[junit4] 2> 37641 T36 C5 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:2&rows=20&version=2.2&qt=standard} hits=1
status=0 QTime=1
[junit4] 2> 37646 T36 C5 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:6&rows=20&version=2.2&qt=standard} hits=1
status=0 QTime=0
[junit4] 2> 37650 T36 C5 oasc.SolrCore.execute [collection1] webapp=null
path=null params={start=0&q=id:5&rows=20&version=2.2&qt=standard} hits=1
status=0 QTime=0
[junit4] 2> 37657 T36 oas.SolrTestCaseJ4.tearDown ###Ending
testWithComplexTransformer
[junit4] 2> 37835 T36 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 37835 T36 oasc.CoreContainer.shutdown Shutting down
CoreContainer instance=2114944958
[junit4] 2> 37836 T36 oasc.SolrCore.close [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@7cac5ecd
[junit4] 2> 37836 T36 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=168,cumulative_deletesById=15,cumulative_deletesByQuery=9,cumulative_errors=0}
[junit4] 2> 37837 T36 oasu.SolrCoreState.decrefSolrCoreState Closing
SolrCoreState
[junit4] 2> 37837 T36 oasu.DefaultSolrCoreState.closeIndexWriter
SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 37837 T36 oasu.DefaultSolrCoreState.closeIndexWriter closing
IndexWriter with IndexWriterCloser
[junit4] 2> 37839 T36 oasc.SolrCore.closeSearcher [collection1] Closing
main searcher on request.
[junit4] 2> 37840 T36 oasc.CachingDirectoryFactory.close Closing
MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 37841 T36 oasc.CachingDirectoryFactory.closeCacheValue looking
to close
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001
[CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001;done=false>>]
[junit4] 2> 37841 T36 oasc.CachingDirectoryFactory.close Closing
directory:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001
[junit4] 2> 37842 T36 oasc.CachingDirectoryFactory.closeCacheValue looking
to close
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index
[CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index;done=false>>]
[junit4] 2> 37842 T36 oasc.CachingDirectoryFactory.close Closing
directory:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-BC001C04DD767F58-001/init-core-data-001/index
[junit4] 2> 17604 T35 ccr.ThreadLeakControl.checkThreadLeaks WARNING Will
linger awaiting termination of 1 leaked thread(s).
[junit4] 2> 37686 T35 ccr.ThreadLeakControl.checkThreadLeaks SEVERE 1
thread leaked from SUITE scope at
org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta:
[junit4] 2> 1) Thread[id=37, 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:503)
[junit4] 2> at
java.util.TimerThread.mainLoop(Timer.java:526)
[junit4] 2> at java.util.TimerThread.run(Timer.java:505)
[junit4] 2> 37687 T35 ccr.ThreadLeakControl.tryToInterruptAll Starting to
interrupt leaked threads:
[junit4] 2> 1) Thread[id=37, name=Timer-0, state=WAITING,
group=TGRP-TestSqlEntityProcessorDelta]
[junit4] 2> 40694 T35 ccr.ThreadLeakControl.tryToInterruptAll SEVERE There
are still zombie threads that couldn't be terminated:
[junit4] 2> 1) Thread[id=37, 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:503)
[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=Lucene42,
sim=RandomSimilarityProvider(queryNorm=false,coord=crazy): {}, locale=es_PE,
timezone=America/Swift_Current
[junit4] 2> NOTE: FreeBSD 9.1-RELEASE-p3 amd64/Oracle Corporation 1.7.0_60
(64-bit)/cpus=16,threads=2,free=65763344,total=122683392
[junit4] 2> NOTE: All tests run in this JVM: [TestZKPropertiesWriter,
TestSqlEntityProcessorDelta]
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=TestSqlEntityProcessorDelta -Dtests.seed=BC001C04DD767F58
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=es_PE
-Dtests.timezone=America/Swift_Current -Dtests.file.encoding=US-ASCII
[junit4] ERROR 0.00s J0 | 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=37, name=Timer-0, state=WAITING,
group=TGRP-TestSqlEntityProcessorDelta]
[junit4] > at java.lang.Object.wait(Native Method)
[junit4] > at java.lang.Object.wait(Object.java:503)
[junit4] > at java.util.TimerThread.mainLoop(Timer.java:526)
[junit4] > at java.util.TimerThread.run(Timer.java:505)
[junit4] > at
__randomizedtesting.SeedInfo.seed([BC001C04DD767F58]:0)Throwable #2:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
[junit4] > 1) Thread[id=37, name=Timer-0, state=WAITING,
group=TGRP-TestSqlEntityProcessorDelta]
[junit4] > at java.lang.Object.wait(Native Method)
[junit4] > at java.lang.Object.wait(Object.java:503)
[junit4] > at java.util.TimerThread.mainLoop(Timer.java:526)
[junit4] > at java.util.TimerThread.run(Timer.java:505)
[junit4] > at
__randomizedtesting.SeedInfo.seed([BC001C04DD767F58]:0)
[junit4] Completed on J0 in 40.86s, 5 tests, 2 errors <<< FAILURES!
[...truncated 79 lines...]
BUILD FAILED
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/build.xml:474:
The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/build.xml:454:
The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/build.xml:45:
The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/extra-targets.xml:37:
The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/build.xml:209:
The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/common-build.xml:440:
The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/solr/common-build.xml:496:
The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/lucene/common-build.xml:1298:
The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-Java7/lucene/common-build.xml:922:
There were test failures: 37 suites, 148 tests, 2 suite-level errors, 54
ignored (3 assumptions)
Total time: 114 minutes 46 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Sending artifact delta relative to Lucene-Solr-Tests-trunk-Java7 #4793
Archived 3 artifacts
Archive block size is 32768
Received 0 blocks and 1405874 bytes
Compression is 0.0%
Took 0.54 sec
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
