Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/10997/
Java: 64bit/jdk1.8.0_20-ea-b23 -XX:+UseCompressedOops -XX:+UseParallelGC
4 tests failed.
FAILED:
junit.framework.TestSuite.org.apache.solr.handler.dataimport.TestVariableResolverEndToEnd
Error Message:
1 thread leaked from SUITE scope at
org.apache.solr.handler.dataimport.TestVariableResolverEndToEnd: 1)
Thread[id=148, name=Timer-0, state=WAITING,
group=TGRP-TestVariableResolverEndToEnd] at
java.lang.Object.wait(Native Method) at
java.lang.Object.wait(Object.java:502) at
java.util.TimerThread.mainLoop(Timer.java:526) at
java.util.TimerThread.run(Timer.java:505)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE
scope at org.apache.solr.handler.dataimport.TestVariableResolverEndToEnd:
1) Thread[id=148, name=Timer-0, state=WAITING,
group=TGRP-TestVariableResolverEndToEnd]
at java.lang.Object.wait(Native Method)
at java.lang.Object.wait(Object.java:502)
at java.util.TimerThread.mainLoop(Timer.java:526)
at java.util.TimerThread.run(Timer.java:505)
at __randomizedtesting.SeedInfo.seed([762960FC1BF2F89B]:0)
FAILED:
junit.framework.TestSuite.org.apache.solr.handler.dataimport.TestVariableResolverEndToEnd
Error Message:
There are still zombie threads that couldn't be terminated: 1)
Thread[id=148, name=Timer-0, state=WAITING,
group=TGRP-TestVariableResolverEndToEnd] at
java.lang.Object.wait(Native Method) at
java.lang.Object.wait(Object.java:502) at
java.util.TimerThread.mainLoop(Timer.java:526) at
java.util.TimerThread.run(Timer.java:505)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
1) Thread[id=148, name=Timer-0, state=WAITING,
group=TGRP-TestVariableResolverEndToEnd]
at java.lang.Object.wait(Native Method)
at java.lang.Object.wait(Object.java:502)
at java.util.TimerThread.mainLoop(Timer.java:526)
at java.util.TimerThread.run(Timer.java:505)
at __randomizedtesting.SeedInfo.seed([762960FC1BF2F89B]:0)
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=51, name=Timer-0, state=WAITING,
group=TGRP-TestSqlEntityProcessorDelta] at java.lang.Object.wait(Native
Method) at java.lang.Object.wait(Object.java:502) at
java.util.TimerThread.mainLoop(Timer.java:526) at
java.util.TimerThread.run(Timer.java:505)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE
scope at org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta:
1) Thread[id=51, name=Timer-0, state=WAITING,
group=TGRP-TestSqlEntityProcessorDelta]
at java.lang.Object.wait(Native Method)
at java.lang.Object.wait(Object.java:502)
at java.util.TimerThread.mainLoop(Timer.java:526)
at java.util.TimerThread.run(Timer.java:505)
at __randomizedtesting.SeedInfo.seed([762960FC1BF2F89B]: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=51,
name=Timer-0, state=WAITING, group=TGRP-TestSqlEntityProcessorDelta] at
java.lang.Object.wait(Native Method) at
java.lang.Object.wait(Object.java:502) at
java.util.TimerThread.mainLoop(Timer.java:526) at
java.util.TimerThread.run(Timer.java:505)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
1) Thread[id=51, name=Timer-0, state=WAITING,
group=TGRP-TestSqlEntityProcessorDelta]
at java.lang.Object.wait(Native Method)
at java.lang.Object.wait(Object.java:502)
at java.util.TimerThread.mainLoop(Timer.java:526)
at java.util.TimerThread.run(Timer.java:505)
at __randomizedtesting.SeedInfo.seed([762960FC1BF2F89B]:0)
Build Log:
[...truncated 15094 lines...]
[junit4] Suite:
org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta
[junit4] 2> Creating dataDir:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001
[junit4] 2> 16671 T50 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl
(false) and clientAuth (false)
[junit4] 2> 17390 T50 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> 17392 T50 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/core-home-001/collection1/'
[junit4] 2> 17436 T50 oasc.SolrConfig.<init> Using Lucene MatchVersion:
LUCENE_5_0
[junit4] 2> 17451 T50 oasc.SolrConfig.<init> Loaded SolrConfig:
dataimport-solrconfig.xml
[junit4] 2> 17452 T50 oass.IndexSchema.readSchema Reading Solr Schema from
dataimport-schema.xml
[junit4] 2> 17462 T50 oass.IndexSchema.readSchema [null] Schema
name=dih_test
[junit4] 2> 17478 T50 oass.IndexSchema.readSchema default search field in
schema is desc
[junit4] 2> 17479 T50 oass.IndexSchema.readSchema query parser default
operator is OR
[junit4] 2> 17479 T50 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 17480 T50 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 17480 T50 oasc.SolrResourceLoader.locateSolrHome using system
property solr.solr.home:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/core-home-001
[junit4] 2> 17481 T50 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/core-home-001/'
[junit4] 2> 17508 T50 oasc.CoreContainer.<init> New CoreContainer
1493362283
[junit4] 2> 17509 T50 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/core-home-001/]
[junit4] 2> 17510 T50 oashc.HttpShardHandlerFactory.getParameter Setting
socketTimeout to: 0
[junit4] 2> 17510 T50 oashc.HttpShardHandlerFactory.getParameter Setting
urlScheme to: null
[junit4] 2> 17510 T50 oashc.HttpShardHandlerFactory.getParameter Setting
connTimeout to: 0
[junit4] 2> 17511 T50 oashc.HttpShardHandlerFactory.getParameter Setting
maxConnectionsPerHost to: 20
[junit4] 2> 17511 T50 oashc.HttpShardHandlerFactory.getParameter Setting
corePoolSize to: 0
[junit4] 2> 17511 T50 oashc.HttpShardHandlerFactory.getParameter Setting
maximumPoolSize to: 2147483647
[junit4] 2> 17512 T50 oashc.HttpShardHandlerFactory.getParameter Setting
maxThreadIdleTime to: 5
[junit4] 2> 17512 T50 oashc.HttpShardHandlerFactory.getParameter Setting
sizeOfQueue to: -1
[junit4] 2> 17512 T50 oashc.HttpShardHandlerFactory.getParameter Setting
fairnessPolicy to: false
[junit4] 2> 17513 T50 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=30000&connTimeout=30000&retry=false
[junit4] 2> 17513 T50 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 17514 T50 oasl.LogWatcher.newRegisteredLogWatcher Registering
Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 17514 T50 oasc.CoreContainer.load Host Name:
[junit4] 2> 17518 T52 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/core-home-001/collection1/'
[junit4] 2> 17550 T52 oasc.SolrConfig.<init> Using Lucene MatchVersion:
LUCENE_5_0
[junit4] 2> 17565 T52 oasc.SolrConfig.<init> Loaded SolrConfig:
dataimport-solrconfig.xml
[junit4] 2> 17566 T52 oass.IndexSchema.readSchema Reading Solr Schema from
dataimport-schema.xml
[junit4] 2> 17576 T52 oass.IndexSchema.readSchema [collection1] Schema
name=dih_test
[junit4] 2> 17590 T52 oass.IndexSchema.readSchema default search field in
schema is desc
[junit4] 2> 17591 T52 oass.IndexSchema.readSchema query parser default
operator is OR
[junit4] 2> 17591 T52 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 17592 T52 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from instancedir
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/core-home-001/collection1/
[junit4] 2> 17592 T52 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 17592 T52 oasc.SolrCore.<init> [collection1] Opening new
SolrCore at
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/core-home-001/collection1/,
dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/
[junit4] 2> 17592 T52 oasc.SolrCore.<init> JMX monitoring not detected for
core: collection1
[junit4] 2> 17593 T52 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> 17593 T52 oasc.SolrCore.initListeners [collection1] Added
SolrEventListener for firstSearcher:
org.apache.solr.core.QuerySenderListener{queries=[]}
[junit4] 2> 17594 T52 oasc.CachingDirectoryFactory.get return new
directory for
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001
[junit4] 2> 17594 T52 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/index/
[junit4] 2> 17594 T52 oasc.SolrCore.initIndex WARN [collection1] Solr
index directory
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/index'
doesn't exist. Creating new index...
[junit4] 2> 17595 T52 oasc.CachingDirectoryFactory.get return new
directory for
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/index
[junit4] 2> 17596 T52 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@218fe827
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/index),segFN=segments_1,generation=1}
[junit4] 2> 17596 T52 oasc.SolrDeletionPolicy.updateCommits newest commit
generation = 1
[junit4] 2> 17597 T52 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "" (default)
[junit4] 2> 17598 T52 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "" (default)
[junit4] 2> 17598 T52 oasc.RequestHandlers.initHandlersFromConfig created
/update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 17599 T52 oasc.RequestHandlers.initHandlersFromConfig created
/update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 17599 T52 oasc.RequestHandlers.initHandlersFromConfig created
/update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 17599 T52 oasc.RequestHandlers.initHandlersFromConfig created
/update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 17599 T52 oasc.RequestHandlers.initHandlersFromConfig created
standard: solr.StandardRequestHandler
[junit4] 2> 17600 T52 oasc.RequestHandlers.initHandlersFromConfig created
/dataimport: org.apache.solr.handler.dataimport.DataImportHandler
[junit4] 2> 17600 T52 oasc.RequestHandlers.initHandlersFromConfig created
/search: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 17600 T52 oasc.RequestHandlers.initHandlersFromConfig WARN
Multiple requestHandler registered to the same name: /update ignoring:
org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 17601 T52 oasc.RequestHandlers.initHandlersFromConfig created
/update: solr.UpdateRequestHandler
[junit4] 2> 17603 T52 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 17604 T52 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 17605 T52 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 17606 T52 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 17608 T52 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 17609 T52 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 17609 T52 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 17610 T52 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@218fe827
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/index),segFN=segments_1,generation=1}
[junit4] 2> 17610 T52 oasc.SolrDeletionPolicy.updateCommits newest commit
generation = 1
[junit4] 2> 17611 T52 oass.SolrIndexSearcher.<init> Opening
Searcher@5db6efdd[collection1] main
[junit4] 2> 17611 T52 oasr.ManagedResourceStorage$FileStorageIO.configure
File-based storage initialized to use dir:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/core-home-001/collection1/conf
[junit4] 2> 17611 T52 oasr.RestManager.init Initializing RestManager with
initArgs:
{storageDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/core-home-001/collection1/conf}
[junit4] 2> 17612 T52 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using
file:dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/core-home-001/collection1/conf
[junit4] 2> 17612 T52 oasr.ManagedResource.reloadFromStorage WARN No
stored data found for /rest/managed
[junit4] 2> 17612 T52 oasr.ManagedResourceStorage$JsonStorage.store Saved
JSON object to path _rest_managed.json using
file:dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/core-home-001/collection1/conf
[junit4] 2> 17613 T52 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 17613 T52 oasc.CoreContainer.registerCore registering core:
collection1
[junit4] 2> 17613 T53 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@5db6efdd[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 17614 T53 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 17614 T53 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@5db6efdd[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 17615 T50 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 17621 T50 oas.SolrTestCaseJ4.setUp ###Starting testSingleEntity
[junit4] 2> ASYNC NEW_CORE C2 name=collection1
org.apache.solr.core.SolrCore@5e8d16e5
[junit4] 2> 17640 T50 C2 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 17642 T50 C2 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:*} 0 17
[junit4] 2> 17654 T50 C2 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 17655 T50 C2 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@218fe827
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/index),segFN=segments_1,generation=1}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@218fe827
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/index),segFN=segments_2,generation=2}
[junit4] 2> 17656 T50 C2 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 2
[junit4] 2> 17656 T50 C2 oass.SolrIndexSearcher.<init> Opening
Searcher@34c86d34[collection1] main
[junit4] 2> 17657 T50 C2 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 17658 T53 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@34c86d34[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 17658 T53 C2 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 17659 T53 C2 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 17660 T53 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=1
[junit4] 2> 17660 T53 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 17660 T53 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@34c86d34[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 17661 T50 C2 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {commit=} 0 7
[junit4] 2> ASYNC NEW_CORE C3 name=collection1
org.apache.solr.core.SolrCore@5e8d16e5
[junit4] 2> 17873 T50 C3 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 17874 T50 C3 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 17875 T50 C3 oashd.DataImporter.doFullImport Starting Full
Import
[junit4] 2> 17875 T50 C3
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 17890 T50 C3 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 17894 T50 C3 oashd.JdbcDataSource$1.call Creating a connection
for entity People with URL: jdbc:hsqldb:mem:.
[junit4] 2> 17894 T50 C3 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 17916 T50 C3 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 17916 T50 C3 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 17927 T50 C3 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@218fe827
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/index),segFN=segments_2,generation=2}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@218fe827
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/index),segFN=segments_3,generation=3}
[junit4] 2> 17928 T50 C3 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 3
[junit4] 2> 17935 T50 C3 oass.SolrIndexSearcher.<init> Opening
Searcher@53b0fce9[collection1] main
[junit4] 2> 17935 T50 C3 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 17936 T53 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@53b0fce9[collection1]
main{UninvertingDirectoryReader(Uninverting(_0(5.0):C20))}
[junit4] 2> 17936 T53 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 17937 T53 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 17938 T53 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> 17938 T53 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 17938 T53 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@53b0fce9[collection1]
main{UninvertingDirectoryReader(Uninverting(_0(5.0):C20))}
[junit4] 2> 17939 T50 C3
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 17940 T50 C3 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 17940 T50 C3 oashd.DocBuilder.execute Time taken = 0:0:0.63
[junit4] 2> 17940 T50 C3 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null
params={indent=true&synchronous=true&commit=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/tempDir-001"+filename%3D"the.properties"+/>%0a<dataSource+name%3D"hsqldb"+driver%3D"org.hsqldb.jdbcDriver"+url%3D"jdbc:hsqldb:mem:."+/>+%0a<dataSource+name%3D"derby"+driver%3D"org.apache.derby.jdbc.EmbeddedDriver"+url%3D"jdbc:derby:memory:derbyDB;territory%3Den_US"+/>+%0a<document+name%3D"TestSqlEntityProcessor">+%0a<entity+name%3D"People"+pk%3D"ID"+processor%3D"SqlEntityProcessor"+dataSource%3D"hsqldb"+query%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+WHERE+DELETED+!%3D+'Y'+"+deletedPkQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED%3D'Y'+AND+last_modified+%26gt;%3D'${dih.People.last_index_time}'+"+deltaImportQuery%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+where+ID%3D${dih.delta.ID}+"+deltaQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+last_modified+%26gt;%3D'${dih.People.last_index_time}'+UNION+DISTINCT+SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+COUNTRY_CODE+IN+(SELECT+CODE+FROM+COUNTRIES+WHERE+last_modified+%26gt;%3D'${dih.People.last_index_time}')+"+>+%0a<field+column%3D"NAME"+name%3D"NAME_mult_s"+/>+%0a<field+column%3D"COUNTRY_CODE"+name%3D"COUNTRY_CODES_mult_s"+/>+%0a</entity>+%0a</document>+%0a</dataConfig>+%0a&clean=true&command=full-import}
{deleteByQuery=*:*,add=[1, 2, 3, 4, 5, 6, 7, 8, 9, 10, ... (20 adds)],commit=}
0 69
[junit4] 2> 17945 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=*:*&qt=standard&start=0&rows=20&version=2.2} hits=20
status=0 QTime=1
[junit4] 2> 17960 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=1
[junit4] 2> 17960 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 17961 T50 oashd.SimplePropertiesWriter.readIndexerProperties
Read the.properties
[junit4] 2> 17967 T50 C3 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 17968 T50 C3 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 17968 T50 C3 oashd.DataImporter.doDeltaImport Starting Delta
Import
[junit4] 2> 17968 T50 C3
oashd.SimplePropertiesWriter.readIndexerProperties Read the.properties
[junit4] 2> 17969 T50 C3 oashd.DocBuilder.doDelta Starting delta
collection.
[junit4] 2> 17970 T50 C3 oashd.DocBuilder.collectDelta Running
ModifiedRowKey() for Entity: People
[junit4] 2> 17970 T50 C3 oashd.JdbcDataSource$1.call Creating a connection
for entity People with URL: jdbc:hsqldb:mem:.
[junit4] 2> 17970 T50 C3 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 17974 T50 C3 oashd.DocBuilder.findMatchingPkColumn Resolving
deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 17975 T50 C3 oashd.DocBuilder.collectDelta Completed
ModifiedRowKey for Entity: People rows obtained : 5
[junit4] 2> 17976 T50 C3 oashd.DocBuilder.collectDelta Completed
DeletedRowKey for Entity: People rows obtained : 3
[junit4] 2> 17976 T50 C3 oashd.DocBuilder.collectDelta Completed
parentDeltaQuery for Entity: People
[junit4] 2> 17976 T50 C3 oashd.DocBuilder.deleteAll Deleting stale
documents
[junit4] 2> 17976 T50 C3 oashd.DocBuilder.findMatchingPkColumn Resolving
deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 17977 T50 C3 oashd.SolrWriter.deleteDoc Deleting document: 10
[junit4] 2> 17977 T50 C3 oashd.DocBuilder.findMatchingPkColumn Resolving
deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 17977 T50 C3 oashd.SolrWriter.deleteDoc Deleting document: 15
[junit4] 2> 17978 T50 C3 oashd.DocBuilder.findMatchingPkColumn Resolving
deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 17978 T50 C3 oashd.SolrWriter.deleteDoc Deleting document: 12
[junit4] 2> 17982 T50 C3 oashd.DocBuilder.doDelta Delta Import completed
successfully
[junit4] 2> 17982 T50 C3 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 17982 T50 C3 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 18012 T50 C3 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@218fe827
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/index),segFN=segments_3,generation=3}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@218fe827
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/index),segFN=segments_4,generation=4}
[junit4] 2> 18012 T50 C3 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 4
[junit4] 2> 18021 T50 C3 oass.SolrIndexSearcher.<init> Opening
Searcher@304e02ef[collection1] main
[junit4] 2> 18022 T50 C3 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 18023 T53 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@304e02ef[collection1]
main{UninvertingDirectoryReader(Uninverting(_0(5.0):C20/7:delGen=1)
Uninverting(_1(5.0):C5))}
[junit4] 2> 18023 T53 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 18024 T53 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 18025 T53 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> 18026 T53 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 18026 T53 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@304e02ef[collection1]
main{UninvertingDirectoryReader(Uninverting(_0(5.0):C20/7:delGen=1)
Uninverting(_1(5.0):C5))}
[junit4] 2> 18027 T50 C3
oashd.SimplePropertiesWriter.readIndexerProperties Read the.properties
[junit4] 2> 18027 T50 C3 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 18028 T50 C3 oashd.DocBuilder.execute Time taken = 0:0:0.59
[junit4] 2> 18028 T50 C3 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null
params={indent=true&synchronous=true&commit=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-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&clean=false&command=delta-import}
{delete=[10, 15, 12],add=[1007, 13, 2, 6, 20],commit=} 0 63
[junit4] 2> 18031 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=*:*&qt=standard&start=0&rows=20&version=2.2} hits=18
status=0 QTime=1
[junit4] 2> 18039 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=1
[junit4] 2> 18039 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 18042 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:1007&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=2
[junit4] 2> 18045 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:10&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=1
[junit4] 2> 18047 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:12&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=1
[junit4] 2> 18049 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:15&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=1
[junit4] 2> 18051 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:2&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=1
[junit4] 2> 18054 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:20&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=0
[junit4] 2> 18056 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:6&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=0
[junit4] 2> 18058 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:13&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=0
[junit4] 2> 18064 T50 oas.SolrTestCaseJ4.tearDown ###Ending
testSingleEntity
[junit4] 2> 18070 T50 oas.SolrTestCaseJ4.setUp ###Starting
testDeltaImportWithoutInitialFullImport
[junit4] 2> 18071 T50 C3 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 18072 T50 C3 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> 18073 T50 C3 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 18074 T50 C3 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@218fe827
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/index),segFN=segments_4,generation=4}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@218fe827
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/index),segFN=segments_5,generation=5}
[junit4] 2> 18074 T50 C3 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 5
[junit4] 2> 18075 T50 C3 oass.SolrIndexSearcher.<init> Opening
Searcher@a8d2dca[collection1] main
[junit4] 2> 18075 T50 C3 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 18076 T53 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@a8d2dca[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 18076 T53 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 18077 T53 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 18077 T53 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> 18077 T53 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 18078 T53 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@a8d2dca[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 18079 T50 C3 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {commit=} 0 6
[junit4] 2> 18096 T50 C3 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 18097 T50 C3 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 18097 T50 C3 oashd.DataImporter.doDeltaImport Starting Delta
Import
[junit4] 2> 18098 T50 C3
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 18099 T50 C3 oashd.DocBuilder.doDelta Starting delta
collection.
[junit4] 2> 18100 T50 C3 oashd.DocBuilder.collectDelta Running
ModifiedRowKey() for Entity: People
[junit4] 2> 18100 T50 C3 oashd.JdbcDataSource$1.call Creating a connection
for entity People with URL: jdbc:hsqldb:mem:.
[junit4] 2> 18100 T50 C3 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 18103 T50 C3 oashd.DocBuilder.findMatchingPkColumn Resolving
deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 18104 T50 C3 oashd.DocBuilder.collectDelta Completed
ModifiedRowKey for Entity: People rows obtained : 20
[junit4] 2> 18104 T50 C3 oashd.DocBuilder.collectDelta Completed
DeletedRowKey for Entity: People rows obtained : 0
[junit4] 2> 18104 T50 C3 oashd.DocBuilder.collectDelta Completed
parentDeltaQuery for Entity: People
[junit4] 2> 18117 T50 C3 oashd.DocBuilder.doDelta Delta Import completed
successfully
[junit4] 2> 18117 T50 C3 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 18118 T50 C3 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 18135 T50 C3 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@218fe827
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/index),segFN=segments_5,generation=5}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@218fe827
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/index),segFN=segments_6,generation=6}
[junit4] 2> 18136 T50 C3 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 6
[junit4] 2> 18144 T50 C3 oass.SolrIndexSearcher.<init> Opening
Searcher@2a914df7[collection1] main
[junit4] 2> 18145 T50 C3 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 18150 T53 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@2a914df7[collection1]
main{UninvertingDirectoryReader(Uninverting(_2(5.0):C20))}
[junit4] 2> 18150 T53 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 18151 T53 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 18152 T53 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> 18152 T53 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 18153 T53 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@2a914df7[collection1]
main{UninvertingDirectoryReader(Uninverting(_2(5.0):C20))}
[junit4] 2> 18153 T50 C3
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 18154 T50 C3 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 18154 T50 C3 oashd.DocBuilder.execute Time taken = 0:0:0.56
[junit4] 2> 18155 T50 C3 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null
params={indent=true&synchronous=true&commit=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-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&clean=false&command=delta-import}
{add=[19, 18, 17, 16, 20, 11, 10, 9, 8, 15, ... (20 adds)],commit=} 0 62
[junit4] 2> 18158 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=*:*&qt=standard&start=0&rows=20&version=2.2} hits=20
status=0 QTime=2
[junit4] 2> 18166 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 18167 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 18168 T50 oas.SolrTestCaseJ4.tearDown ###Ending
testDeltaImportWithoutInitialFullImport
[junit4] 2> 18174 T50 oas.SolrTestCaseJ4.setUp ###Starting
testWithComplexTransformer
[junit4] 2> 18175 T50 C3 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 18176 T50 C3 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> 18177 T50 C3 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 18178 T50 C3 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@218fe827
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/index),segFN=segments_6,generation=6}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@218fe827
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/index),segFN=segments_7,generation=7}
[junit4] 2> 18178 T50 C3 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 7
[junit4] 2> 18178 T50 C3 oass.SolrIndexSearcher.<init> Opening
Searcher@4eb8404[collection1] main
[junit4] 2> 18179 T50 C3 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 18179 T53 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@4eb8404[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 18180 T53 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 18180 T53 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 18181 T53 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> 18182 T53 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 18182 T53 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@4eb8404[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 18183 T50 C3 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {commit=} 0 6
[junit4] 2> 18197 T50 C3 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 18197 T50 C3 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 18197 T50 C3 oashd.DataImporter.doFullImport Starting Full
Import
[junit4] 2> 18198 T50 C3
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 18198 T50 C3 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 18199 T50 C3 oashd.JdbcDataSource$1.call Creating a connection
for entity People with URL: jdbc:hsqldb:mem:.
[junit4] 2> 18200 T50 C3 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 18237 T50 C3 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 18237 T50 C3 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 18256 T50 C3 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@218fe827
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/index),segFN=segments_7,generation=7}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@218fe827
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/index),segFN=segments_8,generation=8}
[junit4] 2> 18256 T50 C3 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 8
[junit4] 2> 18268 T50 C3 oass.SolrIndexSearcher.<init> Opening
Searcher@13def06[collection1] main
[junit4] 2> 18268 T50 C3 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 18278 T53 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@13def06[collection1]
main{UninvertingDirectoryReader(Uninverting(_3(5.0):C60))}
[junit4] 2> 18279 T53 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 18280 T53 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 18281 T53 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> 18281 T53 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 18282 T53 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@13def06[collection1]
main{UninvertingDirectoryReader(Uninverting(_3(5.0):C60))}
[junit4] 2> 18282 T50 C3
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 18283 T50 C3 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 18284 T50 C3 oashd.DocBuilder.execute Time taken = 0:0:0.85
[junit4] 2> 18284 T50 C3 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null
params={indent=true&synchronous=true&commit=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/tempDir-001"+filename%3D"the.properties"+/>%0a<dataSource+name%3D"hsqldb"+driver%3D"org.hsqldb.jdbcDriver"+url%3D"jdbc:hsqldb:mem:."+/>+%0a<dataSource+name%3D"derby"+driver%3D"org.apache.derby.jdbc.EmbeddedDriver"+url%3D"jdbc:derby:memory:derbyDB;territory%3Den_US"+/>+%0a<document+name%3D"TestSqlEntityProcessor">+%0a<entity+name%3D"People"+pk%3D"People.ID"+processor%3D"SqlEntityProcessor"+dataSource%3D"hsqldb"+transformer%3D"TripleThreatTransformer"+query%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+WHERE+DELETED+!%3D+'Y'+"+deletedPkQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED%3D'Y'+AND+last_modified+%26gt;%3D'${dih.People.last_index_time}'+"+deltaImportQuery%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+where+ID%3D${dih.delta.ID}+"+deltaQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+last_modified+%26gt;%3D'${dih.People.last_index_time}'+UNION+DISTINCT+SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+COUNTRY_CODE+IN+(SELECT+CODE+FROM+COUNTRIES+WHERE+last_modified+%26gt;%3D'${dih.People.last_index_time}')+"+>+%0a<field+column%3D"NAME"+name%3D"NAME_mult_s"+/>+%0a<field+column%3D"COUNTRY_CODE"+name%3D"COUNTRY_CODES_mult_s"+/>+%0a</entity>+%0a</document>+%0a</dataConfig>+%0a&clean=true&command=full-import}
{deleteByQuery=*:*,add=[1, TripleThreat-1-1, TripleThreat-2-1, 2,
TripleThreat-1-2, TripleThreat-2-2, 3, TripleThreat-1-3, TripleThreat-2-3, 4,
... (60 adds)],commit=} 0 90
[junit4] 2> 18358 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=*:*&sort=id+asc&rows=60} hits=60 status=0 QTime=72
[junit4] 2> 18382 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=id:TripleThreat-1-*&qt=standard&start=0&rows=20&version=2.2} hits=20
status=0 QTime=9
[junit4] 2> 18388 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=id:TripleThreat-2-*&qt=standard&start=0&rows=20&version=2.2} hits=20
status=0 QTime=1
[junit4] 2> 18402 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=%2Bid:TripleThreat-1-3+%2BNAME_mult_s:Michael+%2BNAME_mult_s:leahciM++%2BCOUNTRY_CODES_mult_s:NR+%2BCOUNTRY_CODES_mult_s:RN&qt=standard&start=0&rows=20&version=2.2}
hits=1 status=0 QTime=9
[junit4] 2> 18407 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=AddAColumn_s:Added&qt=standard&start=0&rows=20&version=2.2}
hits=20 status=0 QTime=3
[junit4] 2> 18410 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 18411 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 18412 T50 oashd.SimplePropertiesWriter.readIndexerProperties
Read the.properties
[junit4] 2> 18418 T50 C3 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 18419 T50 C3 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 18419 T50 C3 oashd.DataImporter.doDeltaImport Starting Delta
Import
[junit4] 2> 18420 T50 C3
oashd.SimplePropertiesWriter.readIndexerProperties Read the.properties
[junit4] 2> 18421 T50 C3 oashd.DocBuilder.doDelta Starting delta
collection.
[junit4] 2> 18421 T50 C3 oashd.DocBuilder.collectDelta Running
ModifiedRowKey() for Entity: People
[junit4] 2> 18422 T50 C3 oashd.JdbcDataSource$1.call Creating a connection
for entity People with URL: jdbc:hsqldb:mem:.
[junit4] 2> 18422 T50 C3 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 18424 T50 C3 oashd.DocBuilder.findMatchingPkColumn Resolving
deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 18426 T50 C3 oashd.DocBuilder.collectDelta Completed
ModifiedRowKey for Entity: People rows obtained : 8
[junit4] 2> 18426 T50 C3 oashd.DocBuilder.collectDelta Completed
DeletedRowKey for Entity: People rows obtained : 8
[junit4] 2> 18426 T50 C3 oashd.DocBuilder.collectDelta Completed
parentDeltaQuery for Entity: People
[junit4] 2> 18427 T50 C3 oashd.DocBuilder.deleteAll Deleting stale
documents
[junit4] 2> 18427 T50 C3 oashd.DocBuilder.findMatchingPkColumn Resolving
deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 18428 T50 C3 oashd.SolrWriter.deleteDoc Deleting document: 8
[junit4] 2> 18428 T50 C3 oashd.DocBuilder.findMatchingPkColumn Resolving
deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 18429 T50 C3 oashd.SolrWriter.deleteDoc Deleting document: 15
[junit4] 2> 18429 T50 C3 oashd.DocBuilder.findMatchingPkColumn Resolving
deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 18429 T50 C3 oashd.SolrWriter.deleteDoc Deleting document: 13
[junit4] 2> 18430 T50 C3 oashd.DocBuilder.findMatchingPkColumn Resolving
deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 18430 T50 C3 oashd.SolrWriter.deleteDoc Deleting document: 2
[junit4] 2> 18431 T50 C3 oashd.DocBuilder.findMatchingPkColumn Resolving
deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 18431 T50 C3 oashd.SolrWriter.deleteDoc Deleting document: 1
[junit4] 2> 18431 T50 C3 oashd.DocBuilder.findMatchingPkColumn Resolving
deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 18432 T50 C3 oashd.SolrWriter.deleteDoc Deleting document: 16
[junit4] 2> 18432 T50 C3 oashd.DocBuilder.findMatchingPkColumn Resolving
deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 18432 T50 C3 oashd.SolrWriter.deleteDoc Deleting document: 7
[junit4] 2> 18433 T50 C3 oashd.DocBuilder.findMatchingPkColumn Resolving
deltaQuery column 'ID' to match entity's declared pk 'People.ID'
[junit4] 2> 18433 T50 C3 oashd.SolrWriter.deleteDoc Deleting document: 5
[junit4] 2> 18446 T50 C3 oashd.DocBuilder.doDelta Delta Import completed
successfully
[junit4] 2> 18447 T50 C3 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 18447 T50 C3 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 18454 T50 C3 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@218fe827
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/index),segFN=segments_8,generation=8}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@218fe827
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/index),segFN=segments_9,generation=9}
[junit4] 2> 18455 T50 C3 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 9
[junit4] 2> 18456 T50 C3 oass.SolrIndexSearcher.<init> Opening
Searcher@bc577c1[collection1] main
[junit4] 2> 18457 T50 C3 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 18468 T53 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@bc577c1[collection1]
main{UninvertingDirectoryReader(Uninverting(_3(5.0):C60/26:delGen=1)
Uninverting(_4(5.0):C24))}
[junit4] 2> 18469 T53 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=1
[junit4] 2> 18469 T53 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 18471 T53 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> 18471 T53 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 18471 T53 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@bc577c1[collection1]
main{UninvertingDirectoryReader(Uninverting(_3(5.0):C60/26:delGen=1)
Uninverting(_4(5.0):C24))}
[junit4] 2> 18472 T50 C3
oashd.SimplePropertiesWriter.readIndexerProperties Read the.properties
[junit4] 2> 18472 T50 C3 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 18473 T50 C3 oashd.DocBuilder.execute Time taken = 0:0:0.52
[junit4] 2> 18473 T50 C3 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null
params={indent=true&synchronous=true&commit=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/tempDir-001"+filename%3D"the.properties"+/>%0a<dataSource+name%3D"hsqldb"+driver%3D"org.hsqldb.jdbcDriver"+url%3D"jdbc:hsqldb:mem:."+/>+%0a<dataSource+name%3D"derby"+driver%3D"org.apache.derby.jdbc.EmbeddedDriver"+url%3D"jdbc:derby:memory:derbyDB;territory%3Den_US"+/>+%0a<document+name%3D"TestSqlEntityProcessor">+%0a<entity+name%3D"People"+pk%3D"People.ID"+processor%3D"SqlEntityProcessor"+dataSource%3D"hsqldb"+transformer%3D"TripleThreatTransformer"+query%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+WHERE+DELETED+!%3D+'Y'+"+deletedPkQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED%3D'Y'+AND+last_modified+%26gt;%3D'${dih.People.last_index_time}'+"+deltaImportQuery%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+where+ID%3D${dih.delta.ID}+"+deltaQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+last_modified+%26gt;%3D'${dih.People.last_index_time}'+UNION+DISTINCT+SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+COUNTRY_CODE+IN+(SELECT+CODE+FROM+COUNTRIES+WHERE+last_modified+%26gt;%3D'${dih.People.last_index_time}')+"+>+%0a<field+column%3D"NAME"+name%3D"NAME_mult_s"+/>+%0a<field+column%3D"COUNTRY_CODE"+name%3D"COUNTRY_CODES_mult_s"+/>+%0a</entity>+%0a</document>+%0a</dataConfig>+%0a&clean=false&command=delta-import}
{delete=[8, 15, 13, 2, 1, 16, 7, 5],add=[14, TripleThreat-1-14,
TripleThreat-2-14, 1005, TripleThreat-1-1005, TripleThreat-2-1005, 19,
TripleThreat-1-19, TripleThreat-2-19, 18, ... (24 adds)],commit=} 0 58
[junit4] 2> 18476 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=*:*&sort=id+asc&rows=42} hits=58 status=0 QTime=0
[junit4] 2> 18484 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=id:TripleThreat-1-*&qt=standard&start=0&rows=20&version=2.2} hits=22
status=0 QTime=0
[junit4] 2> 18488 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=id:TripleThreat-2-*&qt=standard&start=0&rows=20&version=2.2} hits=22
status=0 QTime=0
[junit4] 2> 18495 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=%2Bid:TripleThreat-1-3+%2BNAME_mult_s:Michael+%2BNAME_mult_s:leahciM++%2BCOUNTRY_CODES_mult_s:NR+%2BCOUNTRY_CODES_mult_s:RN&qt=standard&start=0&rows=20&version=2.2}
hits=1 status=0 QTime=1
[junit4] 2> 18496 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=AddAColumn_s:Added&qt=standard&start=0&rows=20&version=2.2}
hits=22 status=0 QTime=0
[junit4] 2> 18500 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 18501 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 18503 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:1015&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=2
[junit4] 2> 18505 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:1005&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=0
[junit4] 2> 18507 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:16&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=0
[junit4] 2> 18509 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:1&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=1
[junit4] 2> 18510 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:2&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=0
[junit4] 2> 18512 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:5&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=1
[junit4] 2> 18513 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:7&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=0
[junit4] 2> 18514 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:8&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=0
[junit4] 2> 18515 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:13&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=0
[junit4] 2> 18517 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:15&qt=standard&start=0&rows=20&version=2.2} hits=0
status=0 QTime=1
[junit4] 2> 18519 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:17&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=1
[junit4] 2> 18521 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:18&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=1
[junit4] 2> 18523 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:19&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=1
[junit4] 2> 18525 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:20&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=1
[junit4] 2> 18527 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:6&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=1
[junit4] 2> 18529 T50 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=id:14&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=1
[junit4] 2> 18530 T50 oas.SolrTestCaseJ4.tearDown ###Ending
testWithComplexTransformer
[junit4] 2> 18535 T50 oas.SolrTestCaseJ4.setUp ###Starting
testChildEntities
[junit4] 2> 18536 T50 C3 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 18537 T50 C3 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> 18538 T50 C3 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 18538 T50 C3 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@218fe827
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/index),segFN=segments_9,generation=9}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@218fe827
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/index),segFN=segments_a,generation=10}
[junit4] 2> 18539 T50 C3 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 10
[junit4] 2> 18539 T50 C3 oass.SolrIndexSearcher.<init> Opening
Searcher@677acc14[collection1] main
[junit4] 2> 18540 T50 C3 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 18541 T53 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@677acc14[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 18541 T53 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 18541 T53 C3 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 18542 T53 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> 18542 T53 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 18542 T53 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@677acc14[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 18544 T50 C3 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {commit=} 0 6
[junit4] 2> ASYNC NEW_CORE C4 name=collection1
org.apache.solr.core.SolrCore@5e8d16e5
[junit4] 2> 20180 T50 C4 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 20181 T50 C4 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 20181 T50 C4 oashd.DataImporter.doFullImport Starting Full
Import
[junit4] 2> 20182 T50 C4
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 20183 T50 C4 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 20184 T50 C4 oashd.JdbcDataSource$1.call Creating a connection
for entity People with URL: jdbc:derby:memory:derbyDB;territory=en_US
[junit4] 2> 20185 T50 C4 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 1
[junit4] 2> 20191 T50 C4 oashd.JdbcDataSource$1.call Creating a connection
for entity Countries with URL: jdbc:derby:memory:derbyDB;territory=en_US
[junit4] 2> 20193 T50 C4 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 20286 T50 C4 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 20287 T50 C4 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 20294 T50 C4 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@218fe827
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/index),segFN=segments_a,generation=10}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@218fe827
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/index),segFN=segments_b,generation=11}
[junit4] 2> 20294 T50 C4 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 11
[junit4] 2> 20296 T50 C4 oass.SolrIndexSearcher.<init> Opening
Searcher@6391b35b[collection1] main
[junit4] 2> 20296 T50 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 20301 T53 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@6391b35b[collection1]
main{UninvertingDirectoryReader(Uninverting(_5(5.0):C20))}
[junit4] 2> 20302 T53 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=1
[junit4] 2> 20302 T53 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 20303 T53 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> 20303 T53 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 20303 T53 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@6391b35b[collection1]
main{UninvertingDirectoryReader(Uninverting(_5(5.0):C20))}
[junit4] 2> 20304 T50 C4
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 20304 T50 C4 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 20304 T50 C4 oashd.DocBuilder.execute Time taken = 0:0:0.122
[junit4] 2> 20305 T50 C4 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null
params={indent=true&synchronous=true&commit=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-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+name%3D"Countries"+pk%3D"CODE"+dataSource%3D"derby"+processor%3D"SqlEntityProcessor"+query%3D"SELECT+CODE,+COUNTRY_NAME+FROM+COUNTRIES+WHERE+DELETED+!%3D+'Y'+AND+CODE%3D'${People.COUNTRY_CODE}'+"+>+%0a<field+column%3D"CODE"+name%3D"COUNTRY_CODE_s"+/>+%0a<field+column%3D"COUNTRY_NAME"+name%3D"COUNTRY_NAME_s"+/>+%0a</entity>+%0a</entity>+%0a</document>+%0a</dataConfig>+%0a&clean=true&command=full-import}
{deleteByQuery=*:*,add=[1, 2, 3, 4, 5, 6, 7, 8, 9, 10, ... (20 adds)],commit=}
0 127
[junit4] 2> 20309 T50 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=*:*&qt=standard&start=0&rows=20&version=2.2} hits=20
status=0 QTime=2
[junit4] 2> 20331 T50 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=NAME_mult_s:Jayden&qt=standard&start=0&rows=20&version=2.2}
hits=1 status=0 QTime=0
[junit4] 2> 20357 T50 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=COUNTRY_CODES_mult_s:NR&qt=standard&start=0&rows=20&version=2.2}
hits=2 status=0 QTime=1
[junit4] 2> 20359 T50 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 20359 T50 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 20360 T50 oashd.SimplePropertiesWriter.readIndexerProperties
Read the.properties
[junit4] 2> 20386 T50 C4 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 20386 T50 C4 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 20387 T50 C4 oashd.DataImporter.doDeltaImport Starting Delta
Import
[junit4] 2> 20387 T50 C4
oashd.SimplePropertiesWriter.readIndexerProperties Read the.properties
[junit4] 2> 20388 T50 C4 oashd.DocBuilder.doDelta Starting delta
collection.
[junit4] 2> 20388 T50 C4 oashd.DocBuilder.collectDelta Running
ModifiedRowKey() for Entity: Countries
[junit4] 2> 20389 T50 C4 oashd.DocBuilder.collectDelta Completed
ModifiedRowKey for Entity: Countries rows obtained : 0
[junit4] 2> 20389 T50 C4 oashd.DocBuilder.collectDelta Completed
DeletedRowKey for Entity: Countries rows obtained : 0
[junit4] 2> 20389 T50 C4 oashd.DocBuilder.collectDelta Completed
parentDeltaQuery for Entity: Countries
[junit4] 2> 20389 T50 C4 oashd.DocBuilder.collectDelta Running
ModifiedRowKey() for Entity: People
[junit4] 2> 20390 T50 C4 oashd.JdbcDataSource$1.call Creating a connection
for entity People with URL: jdbc:derby:memory:derbyDB;territory=en_US
[junit4] 2> 20391 T50 C4 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 20445 T50 C4 oashd.DocBuilder.collectDelta Completed
ModifiedRowKey for Entity: People rows obtained : 13
[junit4] 2> 20445 T50 C4 oashd.DocBuilder.collectDelta Completed
DeletedRowKey for Entity: People rows obtained : 0
[junit4] 2> 20445 T50 C4 oashd.DocBuilder.collectDelta Completed
parentDeltaQuery for Entity: People
[junit4] 2> 20452 T50 C4 oashd.JdbcDataSource$1.call Creating a connection
for entity Countries with URL: jdbc:derby:memory:derbyDB;territory=en_US
[junit4] 2> 20453 T50 C4 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 20521 T50 C4 oashd.DocBuilder.doDelta Delta Import completed
successfully
[junit4] 2> 20522 T50 C4 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 20522 T50 C4 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 20580 T50 C4 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@218fe827
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/index),segFN=segments_b,generation=11}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@218fe827
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/index),segFN=segments_c,generation=12}
[junit4] 2> 20581 T50 C4 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 12
[junit4] 2> 20583 T50 C4 oass.SolrIndexSearcher.<init> Opening
Searcher@6f5e4fd4[collection1] main
[junit4] 2> 20584 T50 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 20596 T53 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@6f5e4fd4[collection1]
main{UninvertingDirectoryReader(Uninverting(_5(5.0):C20/13:delGen=1)
Uninverting(_6(5.0):C13))}
[junit4] 2> 20597 T53 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 20598 T53 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=1
[junit4] 2> 20598 T53 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> 20598 T53 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 20599 T53 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@6f5e4fd4[collection1]
main{UninvertingDirectoryReader(Uninverting(_5(5.0):C20/13:delGen=1)
Uninverting(_6(5.0):C13))}
[junit4] 2> 20600 T50 C4
oashd.SimplePropertiesWriter.readIndexerProperties Read the.properties
[junit4] 2> 20600 T50 C4 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 20601 T50 C4 oashd.DocBuilder.execute Time taken = 0:0:0.213
[junit4] 2> 20601 T50 C4 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null
params={indent=true&synchronous=true&commit=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-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+name%3D"Countries"+pk%3D"Countries.CODE"+dataSource%3D"derby"+processor%3D"SqlEntityProcessor"+query%3D"SELECT+CODE,+COUNTRY_NAME+FROM+COUNTRIES+WHERE+DELETED+!%3D+'Y'+AND+CODE%3D'${People.COUNTRY_CODE}'+"+>+%0a<field+column%3D"CODE"+name%3D"COUNTRY_CODE_s"+/>+%0a<field+column%3D"COUNTRY_NAME"+name%3D"COUNTRY_NAME_s"+/>+%0a</entity>+%0a</entity>+%0a</document>+%0a</dataConfig>+%0a&clean=false&command=delta-import}
{add=[19, 16, 20, 10, 9, 8, 15, 14, 13, 3, ... (13 adds)],commit=} 0 217
[junit4] 2> 20607 T50 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=*:*&qt=standard&start=0&rows=20&version=2.2} hits=20
status=0 QTime=3
[junit4] 2> 20616 T50 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=NAME_mult_s:Jayden&qt=standard&start=0&rows=20&version=2.2}
hits=1 status=0 QTime=1
[junit4] 2> 20622 T50 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=COUNTRY_CODES_mult_s:NR&qt=standard&start=0&rows=20&version=2.2}
hits=2 status=0 QTime=0
[junit4] 2> 20636 T50 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=COUNTRY_CODE_s:NO&qt=standard&start=0&rows=20&version=2.2}
hits=1 status=0 QTime=12
[junit4] 2> 20650 T50 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=COUNTRY_CODE_s:NP&qt=standard&start=0&rows=20&version=2.2}
hits=1 status=0 QTime=12
[junit4] 2> 20655 T50 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=COUNTRY_CODE_s:NR&qt=standard&start=0&rows=20&version=2.2}
hits=2 status=0 QTime=3
[junit4] 2> 20668 T50 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=COUNTRY_CODE_s:NC&qt=standard&start=0&rows=20&version=2.2}
hits=1 status=0 QTime=11
[junit4] 2> 20682 T50 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=COUNTRY_CODE_s:NE&qt=standard&start=0&rows=20&version=2.2}
hits=2 status=0 QTime=13
[junit4] 2> 20728 T50 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=COUNTRY_CODE_s:NU&qt=standard&start=0&rows=20&version=2.2}
hits=2 status=0 QTime=44
[junit4] 2> 20741 T50 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=COUNTRY_CODE_s:NF&qt=standard&start=0&rows=20&version=2.2}
hits=2 status=0 QTime=10
[junit4] 2> 20755 T50 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=COUNTRY_CODE_s:NG&qt=standard&start=0&rows=20&version=2.2}
hits=2 status=0 QTime=12
[junit4] 2> 21287 T50 oas.SolrTestCaseJ4.tearDown ###Ending
testChildEntities
[junit4] 2> 21296 T50 oas.SolrTestCaseJ4.setUp ###Starting
testWithSimpleTransformer
[junit4] 2> 21298 T50 C4 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 21299 T50 C4 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:*} 0 2
[junit4] 2> 21300 T50 C4 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 21302 T50 C4 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@218fe827
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/index),segFN=segments_c,generation=12}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@218fe827
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/index),segFN=segments_d,generation=13}
[junit4] 2> 21302 T50 C4 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 13
[junit4] 2> 21304 T50 C4 oass.SolrIndexSearcher.<init> Opening
Searcher@2f5df41e[collection1] main
[junit4] 2> 21304 T50 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 21306 T53 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@2f5df41e[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 21306 T53 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 21307 T53 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=1
[junit4] 2> 21307 T53 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> 21307 T53 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 21307 T53 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@2f5df41e[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 21309 T50 C4 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {commit=} 0 9
[junit4] 2> 21325 T50 C4 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 21325 T50 C4 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 21326 T50 C4 oashd.DataImporter.doFullImport Starting Full
Import
[junit4] 2> 21326 T50 C4
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 21327 T50 C4 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 21328 T50 C4 oashd.JdbcDataSource$1.call Creating a connection
for entity People with URL: jdbc:hsqldb:mem:.
[junit4] 2> 21328 T50 C4 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 21351 T50 C4 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 21352 T50 C4 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 21357 T50 C4 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@218fe827
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/index),segFN=segments_d,generation=13}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@218fe827
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-001/init-core-data-001/index),segFN=segments_e,generation=14}
[junit4] 2> 21357 T50 C4 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 14
[junit4] 2> 21359 T50 C4 oass.SolrIndexSearcher.<init> Opening
Searcher@41c778e5[collection1] main
[junit4] 2> 21359 T50 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 21364 T53 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@41c778e5[collection1]
main{UninvertingDirectoryReader(Uninverting(_7(5.0):C20))}
[junit4] 2> 21365 T53 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 21365 T53 C4 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=0
[junit4] 2> 21366 T53 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> 21366 T53 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 21366 T53 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@41c778e5[collection1]
main{UninvertingDirectoryReader(Uninverting(_7(5.0):C20))}
[junit4] 2> 21367 T50 C4
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 21368 T50 C4 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 21368 T50 C4 oashd.DocBuilder.execute Time taken = 0:0:0.41
[junit4] 2> 21368 T50 C4 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null
params={indent=true&synchronous=true&commit=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-762960FC1BF2F89B-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
[...truncated too long message...]
webapp=null path=null
params={indent=true&synchronous=true&commit=true&dataConfig=<dataConfig>+%0a<dataSource+name%3D"hsqldb"+driver%3D"${dataimporter.request.dots.in.hsqldb.driver}"+url%3D"jdbc:hsqldb:mem:."+/>+%0a<document+name%3D"TestEvaluators">+%0a<entity+name%3D"FIRST"+processor%3D"SqlEntityProcessor"+dataSource%3D"hsqldb"++query%3D"select++1+as+id,++'SELECT'+as+SELECT_KEYWORD,++CURRENT_TIMESTAMP+as+FIRST_TS+from+DUAL+"+>%0a++<field+column%3D"SELECT_KEYWORD"+name%3D"select_keyword_s"+/>+%0a++<entity+name%3D"SECOND"+processor%3D"SqlEntityProcessor"+dataSource%3D"hsqldb"+transformer%3D"TemplateTransformer"++++query%3D"${dataimporter.functions.encodeUrl(FIRST.SELECT_KEYWORD)}++1+as+SORT,++CURRENT_TIMESTAMP+as+SECOND_TS,++'${dataimporter.functions.formatDate(FIRST.FIRST_TS,+'yyyy',+'da_DK')}'+as+SECOND1_S,+++'PORK'+AS+MEAT,++'GRILL'+AS+METHOD,++'ROUND'+AS+CUTS,++'BEEF_CUTS'+AS+WHATKIND+from+DUAL+WHERE+1%3D${FIRST.ID}+UNION+${dataimporter.functions.encodeUrl(FIRST.SELECT_KEYWORD)}++2+as+SORT,++CURRENT_TIMESTAMP+as+SECOND_TS,++'${dataimporter.functions.formatDate(FIRST.FIRST_TS,+'yyyy',+'da_DK')}'+as+SECOND1_S,+++'FISH'+AS+MEAT,++'FRY'+AS+METHOD,++'SIRLOIN'+AS+CUTS,++'BEEF_CUTS'+AS+WHATKIND+from+DUAL+WHERE+1%3D${FIRST.ID}+ORDER+BY+SORT+">%0a+++<field+column%3D"SECOND_S"+name%3D"second_s"+/>+%0a+++<field+column%3D"SECOND1_S"+name%3D"second1_s"+/>+%0a+++<field+column%3D"second2_s"+template%3D"${dataimporter.functions.formatDate(SECOND.SECOND_TS,+'yyyy',+'da_DK')}"+/>+%0a+++<field+column%3D"second3_s"+template%3D"${dih.functions.formatDate(SECOND.SECOND_TS,+'yyyy',+'da_DK')}"+/>+%0a+++<field+column%3D"METHOD"+name%3D"${SECOND.MEAT}_s"/>%0a+++<field+column%3D"CUTS"+name%3D"${SECOND.WHATKIND}_mult_s"/>%0a++</entity>%0a</entity>%0a</document>+%0a</dataConfig>+%0a&clean=true&command=full-import}
{deleteByQuery=*:*,add=[1],commit=} 0 72
[junit4] 2> 46352 T147 C17 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=*:*&indent=true&wt=json} hits=1 status=0 QTime=0
[junit4] 2> 46362 T147 oas.SolrTestCaseJ4.tearDown ###Ending test
[junit4] 2> 46418 T147 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 46418 T147 oasc.CoreContainer.shutdown Shutting down
CoreContainer instance=1670435815
[junit4] 2> 46418 T147 oasc.SolrCore.close [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@2948d8
[junit4] 2> 46418 T147 oasu.DirectUpdateHandler2.close closing
DirectUpdateHandler2{commits=2,autocommits=0,soft
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=1,cumulative_deletesById=0,cumulative_deletesByQuery=2,cumulative_errors=0}
[junit4] 2> 46419 T147 oasu.SolrCoreState.decrefSolrCoreState Closing
SolrCoreState
[junit4] 2> 46419 T147 oasu.DefaultSolrCoreState.closeIndexWriter
SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 46419 T147 oasu.DefaultSolrCoreState.closeIndexWriter closing
IndexWriter with IndexWriterCloser
[junit4] 2> 46420 T147 oasc.SolrCore.closeSearcher [collection1] Closing
main searcher on request.
[junit4] 2> 46421 T147 oasc.CachingDirectoryFactory.close Closing
MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 46421 T147 oasc.CachingDirectoryFactory.closeCacheValue
looking to close
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestVariableResolverEndToEnd-762960FC1BF2F89B-001/init-core-data-001/index
[CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestVariableResolverEndToEnd-762960FC1BF2F89B-001/init-core-data-001/index;done=false>>]
[junit4] 2> 46421 T147 oasc.CachingDirectoryFactory.close Closing
directory:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestVariableResolverEndToEnd-762960FC1BF2F89B-001/init-core-data-001/index
[junit4] 2> 46421 T147 oasc.CachingDirectoryFactory.closeCacheValue
looking to close
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestVariableResolverEndToEnd-762960FC1BF2F89B-001/init-core-data-001
[CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestVariableResolverEndToEnd-762960FC1BF2F89B-001/init-core-data-001;done=false>>]
[junit4] 2> 46422 T147 oasc.CachingDirectoryFactory.close Closing
directory:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestVariableResolverEndToEnd-762960FC1BF2F89B-001/init-core-data-001
[junit4] 2> 1448 T146 ccr.ThreadLeakControl.checkThreadLeaks WARNING Will
linger awaiting termination of 1 leaked thread(s).
[junit4] 2> 21686 T146 ccr.ThreadLeakControl.checkThreadLeaks SEVERE 1
thread leaked from SUITE scope at
org.apache.solr.handler.dataimport.TestVariableResolverEndToEnd:
[junit4] 2> 1) Thread[id=148, name=Timer-0, state=WAITING,
group=TGRP-TestVariableResolverEndToEnd]
[junit4] 2> at java.lang.Object.wait(Native Method)
[junit4] 2> at java.lang.Object.wait(Object.java:502)
[junit4] 2> at
java.util.TimerThread.mainLoop(Timer.java:526)
[junit4] 2> at java.util.TimerThread.run(Timer.java:505)
[junit4] 2> 21686 T146 ccr.ThreadLeakControl.tryToInterruptAll Starting to
interrupt leaked threads:
[junit4] 2> 1) Thread[id=148, name=Timer-0, state=WAITING,
group=TGRP-TestVariableResolverEndToEnd]
[junit4] 2> 24688 T146 ccr.ThreadLeakControl.tryToInterruptAll SEVERE
There are still zombie threads that couldn't be terminated:
[junit4] 2> 1) Thread[id=148, name=Timer-0, state=WAITING,
group=TGRP-TestVariableResolverEndToEnd]
[junit4] 2> at java.lang.Object.wait(Native Method)
[junit4] 2> at java.lang.Object.wait(Object.java:502)
[junit4] 2> at
java.util.TimerThread.mainLoop(Timer.java:526)
[junit4] 2> at java.util.TimerThread.run(Timer.java:505)
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene49),
sim=DefaultSimilarity, locale=da_DK, timezone=Asia/Tashkent
[junit4] 2> NOTE: Linux 3.13.0-32-generic amd64/Oracle Corporation
1.8.0_20-ea (64-bit)/cpus=8,threads=2,free=225696608,total=258998272
[junit4] 2> NOTE: All tests run in this JVM: [TestZKPropertiesWriter,
TestSolrEntityProcessorEndToEnd, TestDocBuilder2,
TestFileListWithLineEntityProcessor, TestDataConfig,
TestVariableResolverEndToEnd]
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=TestVariableResolverEndToEnd -Dtests.seed=762960FC1BF2F89B
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=da_DK
-Dtests.timezone=Asia/Tashkent -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 0.00s J0 | TestVariableResolverEndToEnd (suite) <<<
[junit4] > Throwable #1:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE
scope at org.apache.solr.handler.dataimport.TestVariableResolverEndToEnd:
[junit4] > 1) Thread[id=148, name=Timer-0, state=WAITING,
group=TGRP-TestVariableResolverEndToEnd]
[junit4] > at java.lang.Object.wait(Native Method)
[junit4] > at java.lang.Object.wait(Object.java:502)
[junit4] > at java.util.TimerThread.mainLoop(Timer.java:526)
[junit4] > at java.util.TimerThread.run(Timer.java:505)
[junit4] > at
__randomizedtesting.SeedInfo.seed([762960FC1BF2F89B]:0)Throwable #2:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
[junit4] > 1) Thread[id=148, name=Timer-0, state=WAITING,
group=TGRP-TestVariableResolverEndToEnd]
[junit4] > at java.lang.Object.wait(Native Method)
[junit4] > at java.lang.Object.wait(Object.java:502)
[junit4] > at java.util.TimerThread.mainLoop(Timer.java:526)
[junit4] > at java.util.TimerThread.run(Timer.java:505)
[junit4] > at
__randomizedtesting.SeedInfo.seed([762960FC1BF2F89B]:0)
[junit4] Completed on J0 in 24.76s, 1 test, 2 errors <<< FAILURES!
[...truncated 11 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:474: The following
error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:454: The following
error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:45: The following
error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/extra-targets.xml:37: The
following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build.xml:209: The
following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/common-build.xml:440:
The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/common-build.xml:496:
The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:1307:
The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:922:
There were test failures: 37 suites, 148 tests, 4 suite-level errors, 73 ignored
Total time: 94 minutes 38 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 64bit/jdk1.8.0_20-ea-b23
-XX:+UseCompressedOops -XX:+UseParallelGC
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
