Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/10992/
Java: 64bit/jdk1.8.0_11 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC
2 tests failed.
FAILED:
junit.framework.TestSuite.org.apache.solr.handler.dataimport.TestSqlEntityProcessor
Error Message:
1 thread leaked from SUITE scope at
org.apache.solr.handler.dataimport.TestSqlEntityProcessor: 1) Thread[id=19,
name=Timer-0, state=WAITING, group=TGRP-TestSqlEntityProcessor] 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.TestSqlEntityProcessor:
1) Thread[id=19, name=Timer-0, state=WAITING,
group=TGRP-TestSqlEntityProcessor]
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([62C2F87AABFB94CD]:0)
FAILED:
junit.framework.TestSuite.org.apache.solr.handler.dataimport.TestSqlEntityProcessor
Error Message:
There are still zombie threads that couldn't be terminated: 1) Thread[id=19,
name=Timer-0, state=WAITING, group=TGRP-TestSqlEntityProcessor] 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=19, name=Timer-0, state=WAITING,
group=TGRP-TestSqlEntityProcessor]
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([62C2F87AABFB94CD]:0)
Build Log:
[...truncated 15111 lines...]
[junit4] Suite: org.apache.solr.handler.dataimport.TestSqlEntityProcessor
[junit4] 2> Creating dataDir:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001
[junit4] 2> 1981 T18 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl
(true) and clientAuth (false)
[junit4] 2> 2828 T18 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> 2837 T18 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.TestSqlEntityProcessor-62C2F87AABFB94CD-001/core-home-001/collection1/'
[junit4] 2> 3245 T18 oasc.SolrConfig.<init> Using Lucene MatchVersion:
LUCENE_5_0
[junit4] 2> 3677 T18 oasc.SolrConfig.<init> Loaded SolrConfig:
dataimport-solrconfig.xml
[junit4] 2> 3699 T18 oass.IndexSchema.readSchema Reading Solr Schema from
dataimport-schema.xml
[junit4] 2> 3733 T18 oass.IndexSchema.readSchema [null] Schema
name=dih_test
[junit4] 2> 3974 T18 oass.IndexSchema.readSchema default search field in
schema is desc
[junit4] 2> 3975 T18 oass.IndexSchema.readSchema query parser default
operator is OR
[junit4] 2> 3981 T18 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 3994 T18 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 3995 T18 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.TestSqlEntityProcessor-62C2F87AABFB94CD-001/core-home-001
[junit4] 2> 3996 T18 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.TestSqlEntityProcessor-62C2F87AABFB94CD-001/core-home-001/'
[junit4] 2> 4195 T18 oasc.CoreContainer.<init> New CoreContainer 313101436
[junit4] 2> 4218 T18 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.TestSqlEntityProcessor-62C2F87AABFB94CD-001/core-home-001/]
[junit4] 2> 4245 T18 oashc.HttpShardHandlerFactory.getParameter Setting
socketTimeout to: 0
[junit4] 2> 4246 T18 oashc.HttpShardHandlerFactory.getParameter Setting
urlScheme to: null
[junit4] 2> 4246 T18 oashc.HttpShardHandlerFactory.getParameter Setting
connTimeout to: 0
[junit4] 2> 4247 T18 oashc.HttpShardHandlerFactory.getParameter Setting
maxConnectionsPerHost to: 20
[junit4] 2> 4247 T18 oashc.HttpShardHandlerFactory.getParameter Setting
corePoolSize to: 0
[junit4] 2> 4247 T18 oashc.HttpShardHandlerFactory.getParameter Setting
maximumPoolSize to: 2147483647
[junit4] 2> 4248 T18 oashc.HttpShardHandlerFactory.getParameter Setting
maxThreadIdleTime to: 5
[junit4] 2> 4248 T18 oashc.HttpShardHandlerFactory.getParameter Setting
sizeOfQueue to: -1
[junit4] 2> 4250 T18 oashc.HttpShardHandlerFactory.getParameter Setting
fairnessPolicy to: false
[junit4] 2> 4618 T18 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=30000&connTimeout=30000&retry=false
[junit4] 2> 4626 T18 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 4627 T18 oasl.LogWatcher.newRegisteredLogWatcher Registering
Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 4629 T18 oasc.CoreContainer.load Host Name:
[junit4] 2> 4793 T20 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.TestSqlEntityProcessor-62C2F87AABFB94CD-001/core-home-001/collection1/'
[junit4] 2> 4967 T20 oasc.SolrConfig.<init> Using Lucene MatchVersion:
LUCENE_5_0
[junit4] 2> 5131 T20 oasc.SolrConfig.<init> Loaded SolrConfig:
dataimport-solrconfig.xml
[junit4] 2> 5132 T20 oass.IndexSchema.readSchema Reading Solr Schema from
dataimport-schema.xml
[junit4] 2> 5149 T20 oass.IndexSchema.readSchema [collection1] Schema
name=dih_test
[junit4] 2> 5311 T20 oass.IndexSchema.readSchema default search field in
schema is desc
[junit4] 2> 5312 T20 oass.IndexSchema.readSchema query parser default
operator is OR
[junit4] 2> 5315 T20 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 5317 T20 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.TestSqlEntityProcessor-62C2F87AABFB94CD-001/core-home-001/collection1/
[junit4] 2> 5368 T20 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 5387 T20 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.TestSqlEntityProcessor-62C2F87AABFB94CD-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.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001/
[junit4] 2> 5388 T20 oasc.SolrCore.<init> JMX monitoring not detected for
core: collection1
[junit4] 2> 5400 T20 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> 5401 T20 oasc.SolrCore.initListeners [collection1] Added
SolrEventListener for firstSearcher:
org.apache.solr.core.QuerySenderListener{queries=[]}
[junit4] 2> 5442 T20 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.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001
[junit4] 2> 5443 T20 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.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001/index/
[junit4] 2> 5443 T20 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.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001/index'
doesn't exist. Creating new index...
[junit4] 2> 5445 T20 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.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001/index
[junit4] 2> 5533 T20 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@387eec1d
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001/index),segFN=segments_1,generation=1}
[junit4] 2> 5534 T20 oasc.SolrDeletionPolicy.updateCommits newest commit
generation = 1
[junit4] 2> 5858 T20 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "" (default)
[junit4] 2> 5897 T20 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "" (default)
[junit4] 2> 5903 T20 oasc.RequestHandlers.initHandlersFromConfig created
/update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5903 T20 oasc.RequestHandlers.initHandlersFromConfig created
/update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5908 T20 oasc.RequestHandlers.initHandlersFromConfig created
/update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5909 T20 oasc.RequestHandlers.initHandlersFromConfig created
/update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5916 T20 oasc.RequestHandlers.initHandlersFromConfig created
standard: solr.StandardRequestHandler
[junit4] 2> 5919 T20 oasc.RequestHandlers.initHandlersFromConfig created
/dataimport: org.apache.solr.handler.dataimport.DataImportHandler
[junit4] 2> 5919 T20 oasc.RequestHandlers.initHandlersFromConfig created
/search: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 5925 T20 oasc.RequestHandlers.initHandlersFromConfig WARN
Multiple requestHandler registered to the same name: /update ignoring:
org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5926 T20 oasc.RequestHandlers.initHandlersFromConfig created
/update: solr.UpdateRequestHandler
[junit4] 2> 5970 T20 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5976 T20 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5980 T20 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5981 T20 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5982 T20 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 6014 T20 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 6014 T20 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 6018 T20 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@387eec1d
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001/index),segFN=segments_1,generation=1}
[junit4] 2> 6018 T20 oasc.SolrDeletionPolicy.updateCommits newest commit
generation = 1
[junit4] 2> 6048 T20 oass.SolrIndexSearcher.<init> Opening
Searcher@24dbe77f[collection1] main
[junit4] 2> 6074 T20 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.TestSqlEntityProcessor-62C2F87AABFB94CD-001/core-home-001/collection1/conf
[junit4] 2> 6074 T20 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.TestSqlEntityProcessor-62C2F87AABFB94CD-001/core-home-001/collection1/conf}
[junit4] 2> 6107 T20 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.TestSqlEntityProcessor-62C2F87AABFB94CD-001/core-home-001/collection1/conf
[junit4] 2> 6107 T20 oasr.ManagedResource.reloadFromStorage WARN No stored
data found for /rest/managed
[junit4] 2> 6112 T20 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.TestSqlEntityProcessor-62C2F87AABFB94CD-001/core-home-001/collection1/conf
[junit4] 2> 6112 T20 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 6137 T20 oasc.CoreContainer.registerCore registering core:
collection1
[junit4] 2> 6138 T21 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@24dbe77f[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 6139 T21 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 6140 T21 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@24dbe77f[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 6146 T18 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 6164 T18 oas.SolrTestCaseJ4.setUp ###Starting testChildEntities
[junit4] 2> ASYNC NEW_CORE C0 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 6333 T18 C0 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 6337 T18 C0 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:*} 0 170
[junit4] 2> ASYNC NEW_CORE C1 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 6357 T18 C1 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> ASYNC NEW_CORE C2 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 6361 T18 C2 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@387eec1d
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001/index),segFN=segments_1,generation=1}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@387eec1d
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001/index),segFN=segments_2,generation=2}
[junit4] 2> 6361 T18 C2 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 2
[junit4] 2> 6362 T18 C2 oass.SolrIndexSearcher.<init> Opening
Searcher@52ef9998[collection1] main
[junit4] 2> 6365 T18 C2 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 6365 T21 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@52ef9998[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> ASYNC NEW_CORE C3 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 6397 T21 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=30
[junit4] 2> 6398 T21 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> ASYNC NEW_CORE C4 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 6412 T21 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=13
[junit4] 2> 6412 T21 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 6412 T21 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@52ef9998[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 6413 T18 C4 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {commit=} 0 56
[junit4] 2> ASYNC NEW_CORE C5 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 8353 T18 C5 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 8354 T18 C5 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 8357 T18 C5 oashd.DataImporter.doFullImport Starting Full
Import
[junit4] 2> ASYNC NEW_CORE C6 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 8373 T18 C6 oashd.SimplePropertiesWriter.readIndexerProperties
WARN Unable to read: the.properties
[junit4] 2> ASYNC NEW_CORE C7 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 8400 T18 C7 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 8405 T18 C7 oashd.JdbcDataSource$1.call Creating a connection
for entity People with URL: jdbc:derby:memory:derbyDB;territory=en_US
[junit4] 2> 8407 T18 C7 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 1
[junit4] 2> ASYNC NEW_CORE C8 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 8482 T18 C8 oashd.JdbcDataSource$1.call Creating a connection
for entity Sports with URL: jdbc:derby:memory:derbyDB;territory=en_US
[junit4] 2> 8484 T18 C8 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 1
[junit4] 2> ASYNC NEW_CORE C9 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 8967 T18 C9 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 8967 T18 C9 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> ASYNC NEW_CORE C10 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 9184 T18 C10 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@387eec1d
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001/index),segFN=segments_2,generation=2}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@387eec1d
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001/index),segFN=segments_3,generation=3}
[junit4] 2> 9185 T18 C10 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 3
[junit4] 2> ASYNC NEW_CORE C11 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 9224 T18 C11 oass.SolrIndexSearcher.<init> Opening
Searcher@5b47b261[collection1] main
[junit4] 2> 9225 T18 C11 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 9243 T21 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@5b47b261[collection1]
main{UninvertingDirectoryReader(Uninverting(_0(5.0):c20))}
[junit4] 2> ASYNC NEW_CORE C12 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 9243 T21 C12 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> 9244 T21 C12 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> 9245 T21 C12 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> 9245 T21 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 9246 T21 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@5b47b261[collection1]
main{UninvertingDirectoryReader(Uninverting(_0(5.0):c20))}
[junit4] 2> 9247 T18 C12
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 9247 T18 C12 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 9248 T18 C12 oashd.DocBuilder.execute Time taken = 0:0:0.874
[junit4] 2> 9248 T18 C12 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.TestSqlEntityProcessor-62C2F87AABFB94CD-001/tempDir-001"+filename%3D"the.properties"+/>%0a<dataSource+name%3D"hsqldb"+driver%3D"org.hsqldb.jdbcDriver"+url%3D"jdbc:hsqldb:mem:."+/>+%0a<dataSource+name%3D"derby"+driver%3D"org.apache.derby.jdbc.EmbeddedDriver"+url%3D"jdbc:derby:memory:derbyDB;territory%3Den_US"+/>+%0a<document+name%3D"TestSqlEntityProcessor">+%0a<entity+name%3D"People"+pk%3D"ID"+processor%3D"SqlEntityProcessor"+dataSource%3D"derby"+transformer%3D"AddAColumnTransformer"+query%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+WHERE+DELETED+!%3D+'Y'+"+>+%0a<field+column%3D"NAME"+name%3D"NAME_mult_s"+/>+%0a<field+column%3D"COUNTRY_CODE"+name%3D"COUNTRY_CODES_mult_s"+/>+%0a<entity+name%3D"Sports"+dataSource%3D"derby"+transformer%3D"AddAColumnTransformer"+newColumnName%3D"sportsAdded_s"+newColumnValue%3D"sport_added"+processor%3D"SqlEntityProcessor"+query%3D"SELECT+ID,+SPORT_NAME+FROM+PEOPLE_SPORTS+WHERE+DELETED+!%3D+'Y'+AND+PERSON_ID%3D${People.ID}+ORDER+BY+ID"+>+%0a<field+column%3D"SPORT_NAME"+name%3D"SPORT_NAME_mult_s"+/>+%0a<field+column%3D"id"+name%3D"SPORT_ID_mult_s"+/>+%0a</entity>+%0a</entity>+%0a</document>+%0a</dataConfig>+%0a&clean=true&command=full-import}
{deleteByQuery=*:*,add=[1, 2, 3, 4, 5, 6, 7, 8, 9, 10, ... (20 adds)],commit=}
0 904
[junit4] 2> 9255 T18 C12 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=*:*&qt=standard&start=0&rows=20&version=2.2} hits=20
status=0 QTime=4
[junit4] 2> ASYNC NEW_CORE C13 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 9293 T18 C13 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=9
[junit4] 2> ASYNC NEW_CORE C14 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 9303 T18 C14 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=SPORT_NAME_mult_s:Sailing&qt=standard&start=0&rows=20&version=2.2}
hits=2 status=0 QTime=1
[junit4] 2> ASYNC NEW_CORE C15 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 9344 T18 C15 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=NAME_mult_s:Michael&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=1
[junit4] 2> ASYNC NEW_CORE C16 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 9354 T18 C16 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=sportsAdded_s:sport_added&qt=standard&start=0&rows=20&version=2.2}
hits=20 status=0 QTime=3
[junit4] 2> ASYNC NEW_CORE C17 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 9363 T18 C17 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 9365 T18 C17 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 9928 T18 oas.SolrTestCaseJ4.tearDown ###Ending
testChildEntities
[junit4] 2> 9943 T18 oas.SolrTestCaseJ4.setUp ###Starting
testWithComplexTransformer
[junit4] 2> ASYNC NEW_CORE C18 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 9944 T18 C18 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 9945 T18 C18 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> 9947 T18 C18 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 9947 T18 C18 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@387eec1d
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001/index),segFN=segments_3,generation=3}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@387eec1d
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001/index),segFN=segments_4,generation=4}
[junit4] 2> 9948 T18 C18 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 4
[junit4] 2> 9949 T18 C18 oass.SolrIndexSearcher.<init> Opening
Searcher@5c296f91[collection1] main
[junit4] 2> 9949 T18 C18 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 9950 T21 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@5c296f91[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 9951 T21 C18 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=1
[junit4] 2> ASYNC NEW_CORE C19 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 9954 T21 C19 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher}
hits=0 status=0 QTime=3
[junit4] 2> 9956 T21 C19 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> 9956 T21 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 9956 T21 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@5c296f91[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 9958 T18 C19 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {commit=} 0 11
[junit4] 2> ASYNC NEW_CORE C20 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 10224 T18 C20 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 10225 T18 C20 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 10225 T18 C20 oashd.DataImporter.doFullImport Starting Full
Import
[junit4] 2> 10226 T18 C20
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> ASYNC NEW_CORE C21 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 10230 T18 C21 oasu.DirectUpdateHandler2.deleteAll
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 10232 T18 C21 oashd.JdbcDataSource$1.call Creating a
connection for entity People with URL: jdbc:hsqldb:mem:.
[junit4] 2> 10233 T18 C21 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> ASYNC NEW_CORE C22 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 10303 T18 C22 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 10304 T18 C22 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 10317 T18 C22 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@387eec1d
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001/index),segFN=segments_4,generation=4}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@387eec1d
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001/index),segFN=segments_5,generation=5}
[junit4] 2> ASYNC NEW_CORE C23 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 10319 T18 C23 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 5
[junit4] 2> 10321 T18 C23 oass.SolrIndexSearcher.<init> Opening
Searcher@5ce28fec[collection1] main
[junit4] 2> 10322 T18 C23 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 10324 T21 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@5ce28fec[collection1]
main{UninvertingDirectoryReader(Uninverting(_1(5.0):c60))}
[junit4] 2> 10325 T21 C23 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> 10325 T21 C23 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> 10326 T21 C23 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> 10327 T21 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 10327 T21 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@5ce28fec[collection1]
main{UninvertingDirectoryReader(Uninverting(_1(5.0):c60))}
[junit4] 2> 10328 T18 C23
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 10329 T18 C23 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 10329 T18 C23 oashd.DocBuilder.execute Time taken = 0:0:0.102
[junit4] 2> 10329 T18 C23 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.TestSqlEntityProcessor-62C2F87AABFB94CD-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"TripleThreatTransformer"+query%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+WHERE+DELETED+!%3D+'Y'+"+>+%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 108
[junit4] 2> ASYNC NEW_CORE C24 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 10441 T18 C24 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=*:*&sort=id+asc&rows=60} hits=60 status=0 QTime=104
[junit4] 2> ASYNC NEW_CORE C25 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 10476 T18 C25 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=13
[junit4] 2> ASYNC NEW_CORE C26 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 10483 T18 C26 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> ASYNC NEW_CORE C27 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 10495 T18 C27 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=%2Bid:TripleThreat-1-3+%2BNAME_mult_s:Michael+%2BNAME_mult_s:leahciM++%2BCOUNTRY_CODES_mult_s:NR+%2BCOUNTRY_CODES_mult_s:RN&qt=standard&start=0&rows=20&version=2.2}
hits=1 status=0 QTime=4
[junit4] 2> 10498 T18 C27 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=AddAColumn_s:Added&qt=standard&start=0&rows=20&version=2.2}
hits=20 status=0 QTime=1
[junit4] 2> ASYNC NEW_CORE C28 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 10504 T18 C28 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=1
[junit4] 2> 10504 T18 C28 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 10508 T18 oas.SolrTestCaseJ4.tearDown ###Ending
testWithComplexTransformer
[junit4] 2> 10516 T18 oas.SolrTestCaseJ4.setUp ###Starting testSingleEntity
[junit4] 2> ASYNC NEW_CORE C29 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 10518 T18 C29 oasu.DirectUpdateHandler2.deleteAll
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 10518 T18 C29 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> ASYNC NEW_CORE C30 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 10522 T18 C30 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 10523 T18 C30 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@387eec1d
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001/index),segFN=segments_5,generation=5}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@387eec1d
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001/index),segFN=segments_6,generation=6}
[junit4] 2> 10523 T18 C30 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 6
[junit4] 2> 10524 T18 C30 oass.SolrIndexSearcher.<init> Opening
Searcher@10c2d37c[collection1] main
[junit4] 2> 10525 T18 C30 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 10526 T21 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@10c2d37c[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 10526 T21 C30 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> 10527 T21 C30 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> 10528 T21 C30 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> 10528 T21 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 10528 T21 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@10c2d37c[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 10531 T18 C30 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {commit=} 0 9
[junit4] 2> ASYNC NEW_CORE C31 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 10816 T18 C31 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 10817 T18 C31 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 10817 T18 C31 oashd.DataImporter.doFullImport Starting Full
Import
[junit4] 2> 10818 T18 C31
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 10819 T18 C31 oasu.DirectUpdateHandler2.deleteAll
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 10820 T18 C31 oashd.JdbcDataSource$1.call Creating a
connection for entity People with URL: jdbc:derby:memory:derbyDB;territory=en_US
[junit4] 2> 10822 T18 C31 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> ASYNC NEW_CORE C32 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 10846 T18 C32 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 10846 T18 C32 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> ASYNC NEW_CORE C33 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 10870 T18 C33 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@387eec1d
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001/index),segFN=segments_6,generation=6}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@387eec1d
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001/index),segFN=segments_7,generation=7}
[junit4] 2> 10871 T18 C33 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 7
[junit4] 2> 10873 T18 C33 oass.SolrIndexSearcher.<init> Opening
Searcher@759ccc8a[collection1] main
[junit4] 2> 10877 T21 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@759ccc8a[collection1]
main{UninvertingDirectoryReader(Uninverting(_2(5.0):c20))}
[junit4] 2> 10878 T21 C33 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> 10878 T21 C33 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> 10879 T21 C33 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> 10879 T21 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 10880 T21 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@759ccc8a[collection1]
main{UninvertingDirectoryReader(Uninverting(_2(5.0):c20))}
[junit4] 2> 10880 T18 C33 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 10881 T18 C33
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 10882 T18 C33 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 10882 T18 C33 oashd.DocBuilder.execute Time taken = 0:0:0.63
[junit4] 2> 10883 T18 C33 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.TestSqlEntityProcessor-62C2F87AABFB94CD-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'+"+>+%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 71
[junit4] 2> ASYNC NEW_CORE C34 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 10896 T18 C34 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> ASYNC NEW_CORE C35 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 10913 T18 C35 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 10914 T18 C35 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 11421 T18 oas.SolrTestCaseJ4.tearDown ###Ending
testSingleEntity
[junit4] 2> 11431 T18 oas.SolrTestCaseJ4.setUp ###Starting
testCachedChildEntities
[junit4] 2> ASYNC NEW_CORE C36 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 11433 T18 C36 oasu.DirectUpdateHandler2.deleteAll
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 11434 T18 C36 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> 11435 T18 C36 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> ASYNC NEW_CORE C37 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 11443 T18 C37 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@387eec1d
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001/index),segFN=segments_7,generation=7}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@387eec1d
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001/index),segFN=segments_8,generation=8}
[junit4] 2> 11444 T18 C37 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 8
[junit4] 2> 11445 T18 C37 oass.SolrIndexSearcher.<init> Opening
Searcher@59644c56[collection1] main
[junit4] 2> 11446 T18 C37 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 11446 T21 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@59644c56[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 11447 T21 C37 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> 11448 T21 C37 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> 11448 T21 C37 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> 11448 T21 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 11448 T21 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@59644c56[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 11454 T18 C37 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {commit=} 0 19
[junit4] 2> ASYNC NEW_CORE C38 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 11480 T18 C38 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 11480 T18 C38 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 11481 T18 C38 oashd.DataImporter.doFullImport Starting Full
Import
[junit4] 2> 11482 T18 C38
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> ASYNC NEW_CORE C39 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 11506 T18 C39 oasc.SolrResourceLoader.findClass WARN Solr
loaded a deprecated plugin/analysis class [CachedSqlEntityProcessor]. Please
consult documentation how to replace it accordingly.
[junit4] 2> 11507 T18 C39 oasu.DirectUpdateHandler2.deleteAll
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 11508 T18 C39 oashd.JdbcDataSource$1.call Creating a
connection for entity People with URL: jdbc:hsqldb:mem:.
[junit4] 2> 11509 T18 C39 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> ASYNC NEW_CORE C40 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 11518 T18 C40 oashd.JdbcDataSource$1.call Creating a
connection for entity Sports with URL: jdbc:hsqldb:mem:.
[junit4] 2> 11519 T18 C40 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> ASYNC NEW_CORE C41 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 11562 T18 C41 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 11563 T18 C41 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 11568 T18 C41 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@387eec1d
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001/index),segFN=segments_8,generation=8}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@387eec1d
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001/index),segFN=segments_9,generation=9}
[junit4] 2> ASYNC NEW_CORE C42 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 11571 T18 C42 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 9
[junit4] 2> 11574 T18 C42 oass.SolrIndexSearcher.<init> Opening
Searcher@4eee583b[collection1] main
[junit4] 2> 11574 T18 C42 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 11579 T21 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@4eee583b[collection1]
main{UninvertingDirectoryReader(Uninverting(_3(5.0):c20))}
[junit4] 2> 11580 T21 C42 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> 11581 T21 C42 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> 11581 T21 C42 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> 11582 T21 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 11582 T21 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@4eee583b[collection1]
main{UninvertingDirectoryReader(Uninverting(_3(5.0):c20))}
[junit4] 2> 11583 T18 C42
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 11584 T18 C42 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 11584 T18 C42 oashd.DocBuilder.execute Time taken = 0:0:0.102
[junit4] 2> 11585 T18 C42 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.TestSqlEntityProcessor-62C2F87AABFB94CD-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'+"+>+%0a<field+column%3D"NAME"+name%3D"NAME_mult_s"+/>+%0a<field+column%3D"COUNTRY_CODE"+name%3D"COUNTRY_CODES_mult_s"+/>+%0a<entity+name%3D"Sports"+dataSource%3D"hsqldb"+processor%3D"CachedSqlEntityProcessor"+where%3D"PERSON_ID%3DPeople.ID"+query%3D"SELECT+ID,+PERSON_ID,+SPORT_NAME+FROM+PEOPLE_SPORTS+ORDER+BY+ID"+>+%0a<field+column%3D"SPORT_NAME"+name%3D"SPORT_NAME_mult_s"+/>+%0a<field+column%3D"id"+name%3D"SPORT_ID_mult_s"+/>+%0a</entity>+%0a</entity>+%0a</document>+%0a</dataConfig>+%0a&clean=true&command=full-import}
{deleteByQuery=*:*,add=[1, 2, 3, 4, 5, 6, 7, 8, 9, 10, ... (20 adds)],commit=}
0 108
[junit4] 2> ASYNC NEW_CORE C43 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 11590 T18 C43 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> 11597 T18 C43 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=SPORT_NAME_mult_s:Sailing&qt=standard&start=0&rows=20&version=2.2}
hits=2 status=0 QTime=0
[junit4] 2> ASYNC NEW_CORE C44 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 11605 T18 C44 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=NAME_mult_s:Michael&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=1
[junit4] 2> ASYNC NEW_CORE C45 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 11626 T18 C45 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 11627 T18 C45 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 11628 T18 oas.SolrTestCaseJ4.tearDown ###Ending
testCachedChildEntities
[junit4] 2> 11644 T18 oas.SolrTestCaseJ4.setUp ###Starting
testWithSimpleTransformer
[junit4] 2> ASYNC NEW_CORE C46 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 11646 T18 C46 oasu.DirectUpdateHandler2.deleteAll
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 11647 T18 C46 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> ASYNC NEW_CORE C47 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 11655 T18 C47 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 11657 T18 C47 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@387eec1d
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001/index),segFN=segments_9,generation=9}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@387eec1d
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001/index),segFN=segments_a,generation=10}
[junit4] 2> 11657 T18 C47 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 10
[junit4] 2> 11658 T18 C47 oass.SolrIndexSearcher.<init> Opening
Searcher@4a88618f[collection1] main
[junit4] 2> 11659 T18 C47 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 11659 T21 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@4a88618f[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 11660 T21 C47 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> 11661 T21 C47 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> 11661 T21 C47 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> 11661 T21 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 11661 T21 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@4a88618f[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 11662 T18 C47 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {commit=} 0 7
[junit4] 2> ASYNC NEW_CORE C48 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 11681 T18 C48 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> ASYNC NEW_CORE C49 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 11685 T18 C49 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 11686 T18 C49 oashd.DataImporter.doFullImport Starting Full
Import
[junit4] 2> 11687 T18 C49
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 11689 T18 C49 oasu.DirectUpdateHandler2.deleteAll
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 11690 T18 C49 oashd.JdbcDataSource$1.call Creating a
connection for entity People with URL: jdbc:hsqldb:mem:.
[junit4] 2> 11691 T18 C49 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 11704 T18 C49 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 11704 T18 C49 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> ASYNC NEW_CORE C50 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 11716 T18 C50 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@387eec1d
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001/index),segFN=segments_a,generation=10}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@387eec1d
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001/index),segFN=segments_b,generation=11}
[junit4] 2> 11716 T18 C50 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 11
[junit4] 2> 11718 T18 C50 oass.SolrIndexSearcher.<init> Opening
Searcher@45999822[collection1] main
[junit4] 2> 11722 T18 C50 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 11726 T21 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@45999822[collection1]
main{UninvertingDirectoryReader(Uninverting(_4(5.0):c20))}
[junit4] 2> 11726 T21 C50 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> 11727 T21 C50 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> 11728 T21 C50 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> 11728 T21 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 11728 T21 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@45999822[collection1]
main{UninvertingDirectoryReader(Uninverting(_4(5.0):c20))}
[junit4] 2> 11733 T18 C50
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> ASYNC NEW_CORE C51 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 11739 T18 C51 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 11739 T18 C51 oashd.DocBuilder.execute Time taken = 0:0:0.51
[junit4] 2> 11740 T18 C51 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.TestSqlEntityProcessor-62C2F87AABFB94CD-001/tempDir-001"+filename%3D"the.properties"+/>%0a<dataSource+name%3D"hsqldb"+driver%3D"org.hsqldb.jdbcDriver"+url%3D"jdbc:hsqldb:mem:."+/>+%0a<dataSource+name%3D"derby"+driver%3D"org.apache.derby.jdbc.EmbeddedDriver"+url%3D"jdbc:derby:memory:derbyDB;territory%3Den_US"+/>+%0a<document+name%3D"TestSqlEntityProcessor">+%0a<entity+name%3D"People"+pk%3D"People.ID"+processor%3D"SqlEntityProcessor"+dataSource%3D"hsqldb"+transformer%3D"AddAColumnTransformer"+query%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+WHERE+DELETED+!%3D+'Y'+"+>+%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 62
[junit4] 2> 11742 T18 C51 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=AddAColumn_s:Added&qt=standard&start=0&rows=20&version=2.2}
hits=20 status=0 QTime=1
[junit4] 2> ASYNC NEW_CORE C52 name=collection1
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 11765 T18 C52 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 11766 T18 C52 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 11767 T18 oas.SolrTestCaseJ4.tearDown ###Ending
testWithSimpleTransformer
[junit4] 2> 11794 T18 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 11794 T18 oasc.CoreContainer.shutdown Shutting down
CoreContainer instance=313101436
[junit4] 2> 11794 T18 oasc.SolrCore.close [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@1f9a716b
[junit4] 2> 11795 T18 oasu.DirectUpdateHandler2.close closing
DirectUpdateHandler2{commits=10,autocommits=0,soft
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=140,cumulative_deletesById=0,cumulative_deletesByQuery=10,cumulative_errors=0}
[junit4] 2> 11798 T18 oasu.SolrCoreState.decrefSolrCoreState Closing
SolrCoreState
[junit4] 2> 11798 T18 oasu.DefaultSolrCoreState.closeIndexWriter
SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 11798 T18 oasu.DefaultSolrCoreState.closeIndexWriter closing
IndexWriter with IndexWriterCloser
[junit4] 2> 11800 T18 oasc.SolrCore.closeSearcher [collection1] Closing
main searcher on request.
[junit4] 2> 11801 T18 oasc.CachingDirectoryFactory.close Closing
MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 11802 T18 oasc.CachingDirectoryFactory.closeCacheValue looking
to close
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001/index
[CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001/index;done=false>>]
[junit4] 2> 11803 T18 oasc.CachingDirectoryFactory.close Closing
directory:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001/index
[junit4] 2> 11803 T18 oasc.CachingDirectoryFactory.closeCacheValue looking
to close
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001
[CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001;done=false>>]
[junit4] 2> 11804 T18 oasc.CachingDirectoryFactory.close Closing
directory:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSqlEntityProcessor-62C2F87AABFB94CD-001/init-core-data-001
[junit4] 2> 9846 T17 ccr.ThreadLeakControl.checkThreadLeaks WARNING Will
linger awaiting termination of 1 leaked thread(s).
[junit4] 2> 29908 T17 ccr.ThreadLeakControl.checkThreadLeaks SEVERE 1
thread leaked from SUITE scope at
org.apache.solr.handler.dataimport.TestSqlEntityProcessor:
[junit4] 2> 1) Thread[id=19, name=Timer-0, state=WAITING,
group=TGRP-TestSqlEntityProcessor]
[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> 29908 T17 ccr.ThreadLeakControl.tryToInterruptAll Starting to
interrupt leaked threads:
[junit4] 2> 1) Thread[id=19, name=Timer-0, state=WAITING,
group=TGRP-TestSqlEntityProcessor]
[junit4] 2> 32910 T17 ccr.ThreadLeakControl.tryToInterruptAll SEVERE There
are still zombie threads that couldn't be terminated:
[junit4] 2> 1) Thread[id=19, name=Timer-0, state=WAITING,
group=TGRP-TestSqlEntityProcessor]
[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=Lucene45,
sim=RandomSimilarityProvider(queryNorm=false,coord=no): {}, locale=ja,
timezone=Etc/GMT-2
[junit4] 2> NOTE: Linux 3.13.0-32-generic amd64/Oracle Corporation
1.8.0_11 (64-bit)/cpus=8,threads=2,free=79260384,total=131989504
[junit4] 2> NOTE: All tests run in this JVM: [TestContextImpl,
TestDocBuilder, TestSqlEntityProcessor]
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=TestSqlEntityProcessor -Dtests.seed=62C2F87AABFB94CD
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ja
-Dtests.timezone=Etc/GMT-2 -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J1 | TestSqlEntityProcessor (suite) <<<
[junit4] > Throwable #1:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE
scope at org.apache.solr.handler.dataimport.TestSqlEntityProcessor:
[junit4] > 1) Thread[id=19, name=Timer-0, state=WAITING,
group=TGRP-TestSqlEntityProcessor]
[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([62C2F87AABFB94CD]:0)Throwable #2:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
[junit4] > 1) Thread[id=19, name=Timer-0, state=WAITING,
group=TGRP-TestSqlEntityProcessor]
[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([62C2F87AABFB94CD]:0)
[junit4] Completed on J1 in 33.06s, 6 tests, 2 errors, 1 skipped <<<
FAILURES!
[...truncated 76 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:1298:
The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:922:
There were test failures: 37 suites, 148 tests, 2 suite-level errors, 46 ignored
Total time: 99 minutes 28 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 64bit/jdk1.8.0_11
-XX:-UseCompressedOops -XX:+UseConcMarkSweepGC
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]
