Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/1418/
Java: 64bit/jdk1.8.0_162 -XX:-UseCompressedOops -XX:+UseG1GC

2 tests failed.
FAILED:  
junit.framework.TestSuite.org.apache.solr.ltr.model.TestMultipleAdditiveTreesModel

Error Message:
1 thread leaked from SUITE scope at 
org.apache.solr.ltr.model.TestMultipleAdditiveTreesModel:     1) Thread[id=248, 
name=qtp1744622884-248, state=TIMED_WAITING, 
group=TGRP-TestMultipleAdditiveTreesModel]         at 
sun.misc.Unsafe.park(Native Method)         at 
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)         
at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163)
         at 
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
         at 
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
         at 
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)
         at 
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626) 
        at java.lang.Thread.run(Thread.java:748)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE 
scope at org.apache.solr.ltr.model.TestMultipleAdditiveTreesModel: 
   1) Thread[id=248, name=qtp1744622884-248, state=TIMED_WAITING, 
group=TGRP-TestMultipleAdditiveTreesModel]
        at sun.misc.Unsafe.park(Native Method)
        at 
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
        at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163)
        at 
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
        at 
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
        at 
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)
        at 
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
        at java.lang.Thread.run(Thread.java:748)
        at __randomizedtesting.SeedInfo.seed([FB60D0DA57A0B0C5]:0)


FAILED:  
junit.framework.TestSuite.org.apache.solr.ltr.model.TestMultipleAdditiveTreesModel

Error Message:
There are still zombie threads that couldn't be terminated:    1) 
Thread[id=248, name=qtp1744622884-248, state=TIMED_WAITING, 
group=TGRP-TestMultipleAdditiveTreesModel]         at 
sun.misc.Unsafe.park(Native Method)         at 
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)         
at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163)
         at 
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
         at 
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
         at 
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)
         at 
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626) 
        at java.lang.Thread.run(Thread.java:748)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie 
threads that couldn't be terminated:
   1) Thread[id=248, name=qtp1744622884-248, state=TIMED_WAITING, 
group=TGRP-TestMultipleAdditiveTreesModel]
        at sun.misc.Unsafe.park(Native Method)
        at 
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
        at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163)
        at 
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
        at 
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
        at 
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)
        at 
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
        at java.lang.Thread.run(Thread.java:748)
        at __randomizedtesting.SeedInfo.seed([FB60D0DA57A0B0C5]:0)




Build Log:
[...truncated 22257 lines...]
   [junit4] Suite: org.apache.solr.ltr.model.TestMultipleAdditiveTreesModel
   [junit4]   2> 19406 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.model.TestMultipleAdditiveTreesModel_FB60D0DA57A0B0C5-001/init-core-data-001
   [junit4]   2> 19407 WARN  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=3 numCloses=3
   [junit4]   2> 19407 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 19408 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 19408 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 19413 WARN  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/contrib/ltr/src/test-files/solr/models
 filtered by null to classpath: 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/contrib/ltr/src/test-files/solr/models
   [junit4]   2> 19415 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.0
   [junit4]   2> 19423 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.s.IndexSchema [null] Schema name=example
   [junit4]   2> 19431 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.s.IndexSchema Loaded schema example/1.5 with uniqueid field id
   [junit4]   2> 19456 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@46d9d34e
   [junit4]   2> 19461 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@46d9d34e
   [junit4]   2> 19461 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@46d9d34e
   [junit4]   2> 19463 INFO  (coreLoadExecutor-144-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 19469 WARN  (coreLoadExecutor-144-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/contrib/ltr/src/test-files/solr/models
 filtered by null to classpath: 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/contrib/ltr/src/test-files/solr/models
   [junit4]   2> 19470 INFO  (coreLoadExecutor-144-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.0
   [junit4]   2> 19477 INFO  (coreLoadExecutor-144-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=example
   [junit4]   2> 19484 INFO  (coreLoadExecutor-144-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema example/1.5 with uniqueid 
field id
   [junit4]   2> 19486 INFO  (coreLoadExecutor-144-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/contrib/ltr/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 19486 INFO  (coreLoadExecutor-144-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@46d9d34e
   [junit4]   2> 19486 INFO  (coreLoadExecutor-144-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 19486 INFO  (coreLoadExecutor-144-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/contrib/ltr/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.model.TestMultipleAdditiveTreesModel_FB60D0DA57A0B0C5-001/init-core-data-001/]
   [junit4]   2> 19521 WARN  (coreLoadExecutor-144-thread-1) [    
x:collection1] o.a.s.c.RequestHandlers no default request handler is registered 
(either '/select' or 'standard')
   [junit4]   2> 19521 INFO  (coreLoadExecutor-144-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 19521 INFO  (coreLoadExecutor-144-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 19523 INFO  (coreLoadExecutor-144-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 
15000ms; 
   [junit4]   2> 19523 INFO  (coreLoadExecutor-144-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: if uncommited for 1000ms; 
   [junit4]   2> 19524 INFO  (coreLoadExecutor-144-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@33f24cdd[collection1] main]
   [junit4]   2> 19525 WARN  (coreLoadExecutor-144-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/contrib/ltr/src/test-files/solr/collection1/conf;
 switching to use InMemory storage instead.
   [junit4]   2> 19525 INFO  (coreLoadExecutor-144-thread-1) [    
x:collection1] o.a.s.r.RestManager Registered ManagedResource impl 
org.apache.solr.ltr.store.rest.ManagedFeatureStore for path 
/schema/feature-store
   [junit4]   2> 19525 WARN  (coreLoadExecutor-144-thread-1) [    
x:collection1] o.a.s.r.ManagedResource No stored data found for 
/schema/feature-store
   [junit4]   2> 19525 INFO  (coreLoadExecutor-144-thread-1) [    
x:collection1] o.a.s.l.s.r.ManagedFeatureStore ------ managed feature ~ loading 
------
   [junit4]   2> 19525 INFO  (coreLoadExecutor-144-thread-1) [    
x:collection1] o.a.s.r.ManagedResource Notified 1 observers of 
/schema/feature-store
   [junit4]   2> 19525 INFO  (coreLoadExecutor-144-thread-1) [    
x:collection1] o.a.s.r.RestManager Registered new managed resource 
/schema/feature-store
   [junit4]   2> 19525 INFO  (coreLoadExecutor-144-thread-1) [    
x:collection1] o.a.s.r.RestManager Registered ManagedResource impl 
org.apache.solr.ltr.store.rest.ManagedModelStore for path /schema/model-store
   [junit4]   2> 19525 WARN  (coreLoadExecutor-144-thread-1) [    
x:collection1] o.a.s.r.ManagedResource No stored data found for 
/schema/model-store
   [junit4]   2> 19525 INFO  (coreLoadExecutor-144-thread-1) [    
x:collection1] o.a.s.l.s.r.ManagedModelStore INIT model store
   [junit4]   2> 19525 INFO  (coreLoadExecutor-144-thread-1) [    
x:collection1] o.a.s.l.s.r.ManagedModelStore ------ managed models ~ loading 
------
   [junit4]   2> 19525 INFO  (coreLoadExecutor-144-thread-1) [    
x:collection1] o.a.s.r.ManagedResource Notified 1 observers of 
/schema/model-store
   [junit4]   2> 19525 INFO  (coreLoadExecutor-144-thread-1) [    
x:collection1] o.a.s.r.RestManager Registered new managed resource 
/schema/model-store
   [junit4]   2> 19525 INFO  (coreLoadExecutor-144-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 19527 INFO  
(searcherExecutor-145-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@33f24cdd[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 19527 INFO  (coreLoadExecutor-144-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1593274813242146816
   [junit4]   2> 19529 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 19532 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 19532 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 19533 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.model.TestMultipleAdditiveTreesModel_FB60D0DA57A0B0C5-001/tempDir-003/cores/core
   [junit4]   2> 19534 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-21T23:27:37+02:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 19535 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 19535 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 19535 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.e.j.s.session Scavenging every 660000ms
   [junit4]   2> 19535 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@4a54f95d{/solr,null,AVAILABLE}
   [junit4]   2> 19536 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@3990afe3{HTTP/1.1,[http/1.1]}{127.0.0.1:41675}
   [junit4]   2> 19536 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.e.j.s.Server Started @20555ms
   [junit4]   2> 19536 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=41675, 
configSetBaseDir=/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.model.TestMultipleAdditiveTreesModel_FB60D0DA57A0B0C5-001/tempDir-001,
 
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.model.TestMultipleAdditiveTreesModel_FB60D0DA57A0B0C5-001/tempDir-003/cores}
   [junit4]   2> 19536 ERROR 
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 19537 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.3.0
   [junit4]   2> 19537 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 19537 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 19537 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-02-24T09:41:08.376Z
   [junit4]   2> 19537 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.model.TestMultipleAdditiveTreesModel_FB60D0DA57A0B0C5-001/tempDir-001/solr.xml
   [junit4]   2> 19542 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@46d9d34e, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 19572 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@46d9d34e
   [junit4]   2> 19578 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@46d9d34e
   [junit4]   2> 19579 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@46d9d34e
   [junit4]   2> 19580 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.model.TestMultipleAdditiveTreesModel_FB60D0DA57A0B0C5-001/tempDir-003/cores
   [junit4]   2> 19580 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 19582 INFO  (coreLoadExecutor-155-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 19589 WARN  (coreLoadExecutor-155-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.model.TestMultipleAdditiveTreesModel_FB60D0DA57A0B0C5-001/tempDir-001/models
 filtered by null to classpath: 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.model.TestMultipleAdditiveTreesModel_FB60D0DA57A0B0C5-001/tempDir-001/models
   [junit4]   2> 19591 INFO  (coreLoadExecutor-155-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.0
   [junit4]   2> 19654 INFO  (coreLoadExecutor-155-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=example
   [junit4]   2> 19662 INFO  (coreLoadExecutor-155-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema example/1.5 with uniqueid 
field id
   [junit4]   2> 19664 INFO  (coreLoadExecutor-155-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.model.TestMultipleAdditiveTreesModel_FB60D0DA57A0B0C5-001/tempDir-001/collection1,
 trusted=true
   [junit4]   2> 19664 INFO  (coreLoadExecutor-155-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@46d9d34e
   [junit4]   2> 19664 INFO  (coreLoadExecutor-155-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 19664 INFO  (coreLoadExecutor-155-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.model.TestMultipleAdditiveTreesModel_FB60D0DA57A0B0C5-001/tempDir-001/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.model.TestMultipleAdditiveTreesModel_FB60D0DA57A0B0C5-001/tempDir-003/cores/core/data/]
   [junit4]   2> 19710 WARN  (coreLoadExecutor-155-thread-1) [    
x:collection1] o.a.s.c.RequestHandlers no default request handler is registered 
(either '/select' or 'standard')
   [junit4]   2> 19710 INFO  (coreLoadExecutor-155-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 19710 INFO  (coreLoadExecutor-155-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 19712 INFO  (coreLoadExecutor-155-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 
15000ms; 
   [junit4]   2> 19712 INFO  (coreLoadExecutor-155-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: if uncommited for 1000ms; 
   [junit4]   2> 19713 INFO  (coreLoadExecutor-155-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@21369f88[collection1] main]
   [junit4]   2> 19713 INFO  (coreLoadExecutor-155-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.model.TestMultipleAdditiveTreesModel_FB60D0DA57A0B0C5-001/tempDir-001/collection1/conf
   [junit4]   2> 19713 INFO  (coreLoadExecutor-155-thread-1) [    
x:collection1] o.a.s.r.RestManager Registered ManagedResource impl 
org.apache.solr.ltr.store.rest.ManagedFeatureStore for path 
/schema/feature-store
   [junit4]   2> 19714 WARN  (coreLoadExecutor-155-thread-1) [    
x:collection1] o.a.s.r.ManagedResource No stored data found for 
/schema/feature-store
   [junit4]   2> 19714 INFO  (coreLoadExecutor-155-thread-1) [    
x:collection1] o.a.s.l.s.r.ManagedFeatureStore ------ managed feature ~ loading 
------
   [junit4]   2> 19714 INFO  (coreLoadExecutor-155-thread-1) [    
x:collection1] o.a.s.r.ManagedResource Notified 1 observers of 
/schema/feature-store
   [junit4]   2> 19714 INFO  (coreLoadExecutor-155-thread-1) [    
x:collection1] o.a.s.r.RestManager Registered new managed resource 
/schema/feature-store
   [junit4]   2> 19714 INFO  (coreLoadExecutor-155-thread-1) [    
x:collection1] o.a.s.r.RestManager Registered ManagedResource impl 
org.apache.solr.ltr.store.rest.ManagedModelStore for path /schema/model-store
   [junit4]   2> 19714 WARN  (coreLoadExecutor-155-thread-1) [    
x:collection1] o.a.s.r.ManagedResource No stored data found for 
/schema/model-store
   [junit4]   2> 19714 INFO  (coreLoadExecutor-155-thread-1) [    
x:collection1] o.a.s.l.s.r.ManagedModelStore INIT model store
   [junit4]   2> 19714 INFO  (coreLoadExecutor-155-thread-1) [    
x:collection1] o.a.s.l.s.r.ManagedModelStore ------ managed models ~ loading 
------
   [junit4]   2> 19714 INFO  (coreLoadExecutor-155-thread-1) [    
x:collection1] o.a.s.r.ManagedResource Notified 1 observers of 
/schema/model-store
   [junit4]   2> 19714 INFO  (coreLoadExecutor-155-thread-1) [    
x:collection1] o.a.s.r.RestManager Registered new managed resource 
/schema/model-store
   [junit4]   2> 19714 INFO  (coreLoadExecutor-155-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 19714 INFO  (coreLoadExecutor-155-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1593274813438230528
   [junit4]   2> 19716 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.SolrJettyTestBase Jetty Assigned Port#41675
   [junit4]   2> 19716 INFO  
(searcherExecutor-156-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@21369f88[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 19727 INFO  (qtp1744622884-244) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={stream.body=<add><doc><field+name%3D"id">1</field><field+name%3D"title">w1</field><field+name%3D"description">w1</field><field+name%3D"popularity">1</field></doc></add>}{add=[1
 (1593274813447667712)]} 0 4
   [junit4]   2> 19732 INFO  (qtp1744622884-248) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={stream.body=<add><doc><field+name%3D"id">2</field><field+name%3D"title">w2</field><field+name%3D"description">w2</field><field+name%3D"popularity">2</field></doc></add>}{add=[2
 (1593274813456056320)]} 0 1
   [junit4]   2> 19736 INFO  (qtp1744622884-250) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={stream.body=<add><doc><field+name%3D"id">3</field><field+name%3D"title">w3</field><field+name%3D"description">w3</field><field+name%3D"popularity">3</field></doc></add>}{add=[3
 (1593274813460250624)]} 0 2
   [junit4]   2> 19738 INFO  (qtp1744622884-248) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={stream.body=<add><doc><field+name%3D"id">4</field><field+name%3D"title">w4</field><field+name%3D"description">w4</field><field+name%3D"popularity">4</field></doc></add>}{add=[4
 (1593274813463396352)]} 0 0
   [junit4]   2> 19741 INFO  (qtp1744622884-250) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={stream.body=<add><doc><field+name%3D"id">5</field><field+name%3D"title">w5</field><field+name%3D"description">w5</field><field+name%3D"popularity">5</field></doc></add>}{add=[5
 (1593274813465493504)]} 0 0
   [junit4]   2> 19742 INFO  (qtp1744622884-248) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1593274813467590656,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 19743 INFO  (qtp1744622884-248) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@27d0bd4e 
commitCommandVersion:1593274813467590656
   [junit4]   2> 19749 INFO  (qtp1744622884-248) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@79a839fa[collection1] main]
   [junit4]   2> 19750 INFO  (qtp1744622884-248) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 19752 INFO  
(searcherExecutor-156-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@79a839fa[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.3.0):C5)))}
   [junit4]   2> 19752 INFO  (qtp1744622884-248) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={stream.body=<commit/>}{commit=} 0 9
   [junit4]   2> 19755 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestEmptyParams-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting multipleAdditiveTreesTestEmptyParams
   [junit4]   2> 19756 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestEmptyParams-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.r.ManagedResourceStorage Saved JSON object to path 
_schema_feature-store.json using InMemoryStorage
   [junit4]   2> 19756 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestEmptyParams-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.l.s.r.ManagedFeatureStore register feature based on 
{name=matchedTitle, class=org.apache.solr.ltr.feature.SolrFeature, 
params={q={!terms f=title}${user_query}}}
   [junit4]   2> 19761 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestEmptyParams-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.l.s.r.ManagedFeatureStore register feature based on 
{name=constantScoreToForceMultipleAdditiveTreesScoreAllDocs, 
class=org.apache.solr.ltr.feature.ValueFeature, params={value=1}}
   [junit4]   2> 19763 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestEmptyParams-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.l.s.r.ManagedModelStore INIT model store
   [junit4]   2> 19763 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestEmptyParams-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending multipleAdditiveTreesTestEmptyParams
   [junit4]   2> 19768 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoParams-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting multipleAdditiveTreesTestNoParams
   [junit4]   2> 19769 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoParams-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.r.ManagedResourceStorage Saved JSON object to path 
_schema_feature-store.json using InMemoryStorage
   [junit4]   2> 19769 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoParams-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.l.s.r.ManagedFeatureStore register feature based on 
{name=matchedTitle, class=org.apache.solr.ltr.feature.SolrFeature, 
params={q={!terms f=title}${user_query}}}
   [junit4]   2> 19769 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoParams-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.l.s.r.ManagedFeatureStore register feature based on 
{name=constantScoreToForceMultipleAdditiveTreesScoreAllDocs, 
class=org.apache.solr.ltr.feature.ValueFeature, params={value=1}}
   [junit4]   2> 19769 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoParams-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.l.s.r.ManagedModelStore INIT model store
   [junit4]   2> 19769 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoParams-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending multipleAdditiveTreesTestNoParams
   [junit4]   2> 19773 INFO  
(TEST-TestMultipleAdditiveTreesModel.testMultipleAdditiveTrees-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testMultipleAdditiveTrees
   [junit4]   2> 19773 INFO  
(TEST-TestMultipleAdditiveTreesModel.testMultipleAdditiveTrees-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.l.TestRerankBase send 
   [junit4]   2> [
   [junit4]   2>     {
   [junit4]   2>         "name": "matchedTitle",
   [junit4]   2>         "class": "org.apache.solr.ltr.feature.SolrFeature",
   [junit4]   2>         "params": {
   [junit4]   2>             "q": "{!terms f=title}${user_query}"
   [junit4]   2>         }
   [junit4]   2>     },
   [junit4]   2>     {
   [junit4]   2>         "name": 
"constantScoreToForceMultipleAdditiveTreesScoreAllDocs",
   [junit4]   2>         "class": "org.apache.solr.ltr.feature.ValueFeature",
   [junit4]   2>         "params": {
   [junit4]   2>             "value": 1
   [junit4]   2>         }
   [junit4]   2>     }
   [junit4]   2> ]
   [junit4]   2> 
   [junit4]   2> 19774 INFO  (qtp1744622884-250) [    x:collection1] 
o.e.j.s.h.C.solr SolrSchemaRestApi: [Restlet] ServerServlet: component class is 
null
   [junit4]   2> 19775 INFO  (qtp1744622884-250) [    x:collection1] 
o.e.j.s.h.C.solr SolrSchemaRestApi: [Restlet] Attaching application: 
org.apache.solr.rest.SolrSchemaRestApi@7724fde6 to URI: /solr/schema
   [junit4]   2> feb 24, 2018 5:41:08 AM org.restlet.Application start
   [junit4]   2> INFORMACIÓN: Starting org.apache.solr.rest.SolrSchemaRestApi 
application
   [junit4]   2> 19777 INFO  (qtp1744622884-250) [    x:collection1] 
o.a.s.r.SolrSchemaRestApi createInboundRoot started for /schema
   [junit4]   2> 19777 INFO  (qtp1744622884-250) [    x:collection1] 
o.a.s.r.RestManager Attached managed resource at path: /feature-store
   [junit4]   2> 19777 INFO  (qtp1744622884-250) [    x:collection1] 
o.a.s.r.RestManager Attached managed resource at path: /managed
   [junit4]   2> 19777 INFO  (qtp1744622884-250) [    x:collection1] 
o.a.s.r.RestManager Attached managed resource at path: /model-store
   [junit4]   2> 19777 INFO  (qtp1744622884-250) [    x:collection1] 
o.a.s.r.RestManager Attached 3 ManagedResource endpoints to Restlet router: 
/schema
   [junit4]   2> 19777 INFO  (qtp1744622884-250) [    x:collection1] 
o.a.s.r.SolrSchemaRestApi createInboundRoot complete for /schema
   [junit4]   2> 19778 INFO  (qtp1744622884-250) [    x:collection1] 
o.a.s.r.RestManager Found ManagedResource 
[org.apache.solr.ltr.store.rest.ManagedFeatureStore@20787572] for 
/schema/feature-store
   [junit4]   2> 19778 INFO  (qtp1744622884-250) [    x:collection1] 
o.a.s.r.ManagedResource Processing update to /schema/feature-store: 
[{name=matchedTitle, class=org.apache.solr.ltr.feature.SolrFeature, 
params={q={!terms f=title}${user_query}}}, 
{name=constantScoreToForceMultipleAdditiveTreesScoreAllDocs, 
class=org.apache.solr.ltr.feature.ValueFeature, params={value=1}}] is a 
java.util.ArrayList
   [junit4]   2> 19778 INFO  (qtp1744622884-250) [    x:collection1] 
o.a.s.l.s.r.ManagedFeatureStore register feature based on {name=matchedTitle, 
class=org.apache.solr.ltr.feature.SolrFeature, params={q={!terms 
f=title}${user_query}}}
   [junit4]   2> 19778 INFO  (qtp1744622884-250) [    x:collection1] 
o.a.s.l.s.r.ManagedFeatureStore register feature based on 
{name=constantScoreToForceMultipleAdditiveTreesScoreAllDocs, 
class=org.apache.solr.ltr.feature.ValueFeature, params={value=1}}
   [junit4]   2> 19779 INFO  (qtp1744622884-250) [    x:collection1] 
o.a.s.r.ManagedResourceStorage Saved JSON object to path 
_schema_feature-store.json using 
file:dir=/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.model.TestMultipleAdditiveTreesModel_FB60D0DA57A0B0C5-001/tempDir-001/collection1/conf
   [junit4]   2> 19779 INFO  (qtp1744622884-250) [    x:collection1] 
o.a.s.r.RestManager [collection1]  webapp=/solr path=/schema/feature-store 
params={indent=on&wt=json} status=0 QTime=4
   [junit4]   2> feb 24, 2018 5:41:08 AM org.restlet.engine.log.LogFilter 
afterHandle
   [junit4]   2> INFORMACIÓN: 2018-02-24        05:41:08        127.0.0.1       
-       127.0.0.1       41675   PUT     /solr/schema/feature-store      
wt=json&indent=on       200     -       387     3       http://127.0.0.1:41675  
Apache-HttpClient/4.5.3 (Java/1.8.0_162)        -
   [junit4]   2> 19781 INFO  (qtp1744622884-248) [    x:collection1] 
o.a.s.r.RestManager Found ManagedResource [ManagedModelStore [store=ModelStore 
[availableModels=[]], 
featureStores=org.apache.solr.ltr.store.rest.ManagedFeatureStore@20787572]] for 
/schema/model-store
   [junit4]   2> 19782 INFO  (qtp1744622884-248) [    x:collection1] 
o.a.s.r.ManagedResource Processing update to /schema/model-store: 
{class=org.apache.solr.ltr.model.MultipleAdditiveTreesModel, 
name=multipleadditivetreesmodel, features=[{name=matchedTitle}, 
{name=constantScoreToForceMultipleAdditiveTreesScoreAllDocs}], 
params={trees=[{weight=1f, root={feature=matchedTitle, threshold=0.5f, 
left={value=-100}, 
right={feature=constantScoreToForceMultipleAdditiveTreesScoreAllDocs, 
threshold=10.0f, left={value=50}, right={value=75}}}}, {weight=2f, 
root={value=-10}}]}} is a java.util.LinkedHashMap
   [junit4]   2> 19789 INFO  (qtp1744622884-248) [    x:collection1] 
o.a.s.l.s.r.ManagedModelStore adding model multipleadditivetreesmodel
   [junit4]   2> 19789 INFO  (qtp1744622884-248) [    x:collection1] 
o.a.s.r.ManagedResourceStorage Saved JSON object to path 
_schema_model-store.json using 
file:dir=/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.model.TestMultipleAdditiveTreesModel_FB60D0DA57A0B0C5-001/tempDir-001/collection1/conf
   [junit4]   2> 19790 INFO  (qtp1744622884-248) [    x:collection1] 
o.a.s.r.RestManager [collection1]  webapp=/solr path=/schema/model-store 
params={indent=on&wt=json} status=0 QTime=8
   [junit4]   2> feb 24, 2018 5:41:08 AM org.restlet.engine.log.LogFilter 
afterHandle
   [junit4]   2> INFORMACIÓN: 2018-02-24        05:41:08        127.0.0.1       
-       127.0.0.1       41675   PUT     /solr/schema/model-store        
wt=json&indent=on       200     -       1129    9       http://127.0.0.1:41675  
Apache-HttpClient/4.5.3 (Java/1.8.0_162)        -
   [junit4]   2> 19792 INFO  (qtp1744622884-250) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/query 
params={q=*:*&indent=on&fl=*,score&rows=3&wt=json} hits=5 status=0 QTime=0
   [junit4]   2> 19793 INFO  (qtp1744622884-248) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/query 
params={q=*:*&indent=on&fl=*,score&rows=3&wt=json} hits=5 status=0 QTime=0
   [junit4]   2> 19795 INFO  (qtp1744622884-250) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/query 
params={q=*:*&indent=on&fl=*,score&rows=3&wt=json} hits=5 status=0 QTime=0
   [junit4]   2> 19806 INFO  (qtp1744622884-248) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/query 
params={q=*:*&indent=on&fl=*,score&rows=3&wt=json&rq={!ltr+reRankDocs%3D3+model%3Dmultipleadditivetreesmodel+efi.user_query%3Ddsjkafljjk}}
 hits=5 status=0 QTime=9
   [junit4]   2> 19808 INFO  (qtp1744622884-250) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/query 
params={q=*:*&indent=on&fl=*,score&rows=3&wt=json&rq={!ltr+reRankDocs%3D3+model%3Dmultipleadditivetreesmodel+efi.user_query%3Ddsjkafljjk}}
 hits=5 status=0 QTime=0
   [junit4]   2> 19810 INFO  (qtp1744622884-248) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/query 
params={q=*:*&indent=on&fl=*,score&rows=3&wt=json&rq={!ltr+reRankDocs%3D3+model%3Dmultipleadditivetreesmodel+efi.user_query%3Ddsjkafljjk}}
 hits=5 status=0 QTime=0
   [junit4]   2> 19813 INFO  (qtp1744622884-250) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/query 
params={q=*:*&indent=on&fl=*,score&rows=3&wt=json&rq={!ltr+reRankDocs%3D3+model%3Dmultipleadditivetreesmodel+efi.user_query%3Dw3}}
 hits=5 status=0 QTime=1
   [junit4]   2> 19816 INFO  (qtp1744622884-248) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/query 
params={q=*:*&indent=on&fl=*,score&rows=3&wt=json&rq={!ltr+reRankDocs%3D3+model%3Dmultipleadditivetreesmodel+efi.user_query%3Dw3}}
 hits=5 status=0 QTime=0
   [junit4]   2> 19818 INFO  (qtp1744622884-250) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/query 
params={q=*:*&indent=on&fl=*,score&rows=3&wt=json&rq={!ltr+reRankDocs%3D3+model%3Dmultipleadditivetreesmodel+efi.user_query%3Dw3}}
 hits=5 status=0 QTime=0
   [junit4]   2> 19820 INFO  (qtp1744622884-248) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/query 
params={q=*:*&indent=on&fl=*,score&rows=3&wt=json&rq={!ltr+reRankDocs%3D3+model%3Dmultipleadditivetreesmodel+efi.user_query%3Dw3}}
 hits=5 status=0 QTime=0
   [junit4]   2> 19823 INFO  (qtp1744622884-250) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/query 
params={q=*:*&indent=on&fl=*,score,[fv]&rows=3&wt=json&debugQuery=on&rq={!ltr+reRankDocs%3D3+model%3Dmultipleadditivetreesmodel+efi.user_query%3Dw3}}
 hits=5 status=0 QTime=2
   [junit4]   2> 19828 INFO  
(TEST-TestMultipleAdditiveTreesModel.testMultipleAdditiveTrees-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testMultipleAdditiveTrees
   [junit4]   2> 19831 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestTreesParamDoesNotContatinTree-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting 
multipleAdditiveTreesTestTreesParamDoesNotContatinTree
   [junit4]   2> 19831 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestTreesParamDoesNotContatinTree-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.r.ManagedResourceStorage Saved JSON object to path 
_schema_feature-store.json using InMemoryStorage
   [junit4]   2> 19832 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestTreesParamDoesNotContatinTree-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.l.s.r.ManagedFeatureStore register feature based on 
{name=matchedTitle, class=org.apache.solr.ltr.feature.SolrFeature, 
params={q={!terms f=title}${user_query}}}
   [junit4]   2> 19832 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestTreesParamDoesNotContatinTree-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.l.s.r.ManagedFeatureStore register feature based on 
{name=constantScoreToForceMultipleAdditiveTreesScoreAllDocs, 
class=org.apache.solr.ltr.feature.ValueFeature, params={value=1}}
   [junit4]   2> 19832 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestTreesParamDoesNotContatinTree-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.l.s.r.ManagedModelStore INIT model store
   [junit4]   2> 19832 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestTreesParamDoesNotContatinTree-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending 
multipleAdditiveTreesTestTreesParamDoesNotContatinTree
   [junit4]   2> 19835 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoThreshold-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting multipleAdditiveTreesTestNoThreshold
   [junit4]   2> 19835 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoThreshold-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.r.ManagedResourceStorage Saved JSON object to path 
_schema_feature-store.json using InMemoryStorage
   [junit4]   2> 19836 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoThreshold-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.l.s.r.ManagedFeatureStore register feature based on 
{name=matchedTitle, class=org.apache.solr.ltr.feature.SolrFeature, 
params={q={!terms f=title}${user_query}}}
   [junit4]   2> 19836 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoThreshold-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.l.s.r.ManagedFeatureStore register feature based on 
{name=constantScoreToForceMultipleAdditiveTreesScoreAllDocs, 
class=org.apache.solr.ltr.feature.ValueFeature, params={value=1}}
   [junit4]   2> 19836 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoThreshold-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.l.s.r.ManagedModelStore INIT model store
   [junit4]   2> 19836 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoThreshold-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending multipleAdditiveTreesTestNoThreshold
   [junit4]   2> 19839 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoLeft-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting multipleAdditiveTreesTestNoLeft
   [junit4]   2> 19839 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoLeft-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.r.ManagedResourceStorage Saved JSON object to path 
_schema_feature-store.json using InMemoryStorage
   [junit4]   2> 19839 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoLeft-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.l.s.r.ManagedFeatureStore register feature based on 
{name=matchedTitle, class=org.apache.solr.ltr.feature.SolrFeature, 
params={q={!terms f=title}${user_query}}}
   [junit4]   2> 19840 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoLeft-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.l.s.r.ManagedFeatureStore register feature based on 
{name=constantScoreToForceMultipleAdditiveTreesScoreAllDocs, 
class=org.apache.solr.ltr.feature.ValueFeature, params={value=1}}
   [junit4]   2> 19840 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoLeft-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.l.s.r.ManagedModelStore INIT model store
   [junit4]   2> 19840 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoLeft-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending multipleAdditiveTreesTestNoLeft
   [junit4]   2> 19842 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoWeight-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting multipleAdditiveTreesTestNoWeight
   [junit4]   2> 19843 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoWeight-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.r.ManagedResourceStorage Saved JSON object to path 
_schema_feature-store.json using InMemoryStorage
   [junit4]   2> 19843 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoWeight-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.l.s.r.ManagedFeatureStore register feature based on 
{name=matchedTitle, class=org.apache.solr.ltr.feature.SolrFeature, 
params={q={!terms f=title}${user_query}}}
   [junit4]   2> 19843 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoWeight-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.l.s.r.ManagedFeatureStore register feature based on 
{name=constantScoreToForceMultipleAdditiveTreesScoreAllDocs, 
class=org.apache.solr.ltr.feature.ValueFeature, params={value=1}}
   [junit4]   2> 19843 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoWeight-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.l.s.r.ManagedModelStore INIT model store
   [junit4]   2> 19844 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoWeight-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending multipleAdditiveTreesTestNoWeight
   [junit4]   2> 19846 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestMissingTreeFeature-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting 
multipleAdditiveTreesTestMissingTreeFeature
   [junit4]   2> 19847 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestMissingTreeFeature-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.r.ManagedResourceStorage Saved JSON object to path 
_schema_feature-store.json using InMemoryStorage
   [junit4]   2> 19847 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestMissingTreeFeature-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.l.s.r.ManagedFeatureStore register feature based on 
{name=matchedTitle, class=org.apache.solr.ltr.feature.SolrFeature, 
params={q={!terms f=title}${user_query}}}
   [junit4]   2> 19847 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestMissingTreeFeature-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.l.s.r.ManagedFeatureStore register feature based on 
{name=constantScoreToForceMultipleAdditiveTreesScoreAllDocs, 
class=org.apache.solr.ltr.feature.ValueFeature, params={value=1}}
   [junit4]   2> 19847 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestMissingTreeFeature-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.l.s.r.ManagedModelStore INIT model store
   [junit4]   2> 19848 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestMissingTreeFeature-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending 
multipleAdditiveTreesTestMissingTreeFeature
   [junit4]   2> 19851 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoFeaturesSpecified-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting 
multipleAdditiveTreesTestNoFeaturesSpecified
   [junit4]   2> 19851 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoFeaturesSpecified-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.r.ManagedResourceStorage Saved JSON object to path 
_schema_feature-store.json using InMemoryStorage
   [junit4]   2> 19851 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoFeaturesSpecified-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.l.s.r.ManagedFeatureStore register feature based on 
{name=matchedTitle, class=org.apache.solr.ltr.feature.SolrFeature, 
params={q={!terms f=title}${user_query}}}
   [junit4]   2> 19852 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoFeaturesSpecified-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.l.s.r.ManagedFeatureStore register feature based on 
{name=constantScoreToForceMultipleAdditiveTreesScoreAllDocs, 
class=org.apache.solr.ltr.feature.ValueFeature, params={value=1}}
   [junit4]   2> 19852 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoFeaturesSpecified-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.l.s.r.ManagedModelStore INIT model store
   [junit4]   2> 19852 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoFeaturesSpecified-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending 
multipleAdditiveTreesTestNoFeaturesSpecified
   [junit4]   2> 19854 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoRight-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting multipleAdditiveTreesTestNoRight
   [junit4]   2> 19855 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoRight-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.r.ManagedResourceStorage Saved JSON object to path 
_schema_feature-store.json using InMemoryStorage
   [junit4]   2> 19855 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoRight-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.l.s.r.ManagedFeatureStore register feature based on 
{name=matchedTitle, class=org.apache.solr.ltr.feature.SolrFeature, 
params={q={!terms f=title}${user_query}}}
   [junit4]   2> 19855 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoRight-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.l.s.r.ManagedFeatureStore register feature based on 
{name=constantScoreToForceMultipleAdditiveTreesScoreAllDocs, 
class=org.apache.solr.ltr.feature.ValueFeature, params={value=1}}
   [junit4]   2> 19856 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoRight-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.l.s.r.ManagedModelStore INIT model store
   [junit4]   2> 19856 INFO  
(TEST-TestMultipleAdditiveTreesModel.multipleAdditiveTreesTestNoRight-seed#[FB60D0DA57A0B0C5])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending multipleAdditiveTreesTestNoRight
   [junit4]   2> 19857 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@3990afe3{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 19857 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=50703935
   [junit4]   2> 19857 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 19857 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@45816a5d: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ com.codahale.metrics.MetricRegistry@73774929
   [junit4]   2> 19861 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 19861 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@236c2ed3: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
com.codahale.metrics.MetricRegistry@52a95fa0
   [junit4]   2> 19863 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 19864 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@7fe865e7: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / com.codahale.metrics.MetricRegistry@5696c12d
   [junit4]   2> 19867 INFO  (coreCloseExecutor-161-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@2a9de5db
   [junit4]   2> 19867 INFO  (coreCloseExecutor-161-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=714991067
   [junit4]   2> 19867 INFO  (coreCloseExecutor-161-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@403d5440: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@5d1aa061
   [junit4]   2> 19876 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@4a54f95d{/solr,null,UNAVAILABLE}
   [junit4]   2> 19876 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.e.j.s.session Stopped scavenging
   [junit4]   2> 49875 WARN  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.e.j.u.t.QueuedThreadPool 
QueuedThreadPool@qtp1744622884{STOPPING,8<=8<=10000,i=0,q=1} Couldn't stop 
Thread[qtp1744622884-248,5,TGRP-TestMultipleAdditiveTreesModel]
   [junit4]   2> 49876 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 49876 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=765221964
   [junit4]   2> 49877 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 49877 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@df39d70: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ com.codahale.metrics.MetricRegistry@53c94827
   [junit4]   2> 49877 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 49878 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@2cd67012: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
com.codahale.metrics.MetricRegistry@52a95fa0
   [junit4]   2> 49878 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 49878 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1dc232ae: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / com.codahale.metrics.MetricRegistry@5696c12d
   [junit4]   2> 49879 INFO  (coreCloseExecutor-163-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@35548de6
   [junit4]   2> 49879 INFO  (coreCloseExecutor-163-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=894733798
   [junit4]   2> 49879 INFO  (coreCloseExecutor-163-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@7d43d02e: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@45562a06
   [junit4]   2> 49881 INFO  
(SUITE-TestMultipleAdditiveTreesModel-seed#[FB60D0DA57A0B0C5]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ------------------------------------------------------- 
Done waiting for tracked resources to be released
   [junit4]   2> Feb 24, 2018 9:41:38 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> Feb 24, 2018 9:41:58 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> SEVERE: 1 thread leaked from SUITE scope at 
org.apache.solr.ltr.model.TestMultipleAdditiveTreesModel: 
   [junit4]   2>    1) Thread[id=248, name=qtp1744622884-248, 
state=TIMED_WAITING, group=TGRP-TestMultipleAdditiveTreesModel]
   [junit4]   2>         at sun.misc.Unsafe.park(Native Method)
   [junit4]   2>         at 
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
   [junit4]   2>         at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163)
   [junit4]   2>         at 
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
   [junit4]   2>         at 
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
   [junit4]   2>         at 
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)
   [junit4]   2>         at 
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
   [junit4]   2>         at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> Feb 24, 2018 9:41:58 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
   [junit4]   2> INFO: Starting to interrupt leaked threads:
   [junit4]   2>    1) Thread[id=248, name=qtp1744622884-248, 
state=TIMED_WAITING, group=TGRP-TestMultipleAdditiveTreesModel]
   [junit4]   2> Feb 24, 2018 9:42:01 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
   [junit4]   2> SEVERE: There are still zombie threads that couldn't be 
terminated:
   [junit4]   2>    1) Thread[id=248, name=qtp1744622884-248, 
state=TIMED_WAITING, group=TGRP-TestMultipleAdditiveTreesModel]
   [junit4]   2>         at sun.misc.Unsafe.park(Native Method)
   [junit4]   2>         at 
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
   [junit4]   2>         at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163)
   [junit4]   2>         at 
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
   [junit4]   2>         at 
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
   [junit4]   2>         at 
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)
   [junit4]   2>         at 
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
   [junit4]   2>         at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{_version_=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
popularity=BlockTreeOrds(blocksize=128), 
description=PostingsFormat(name=MockRandom), 
id=PostingsFormat(name=LuceneVarGapFixedInterval), 
text=BlockTreeOrds(blocksize=128), 
title=PostingsFormat(name=LuceneVarGapDocFreqInterval)}, 
docValues:{_version_=DocValuesFormat(name=Lucene70), 
popularity=DocValuesFormat(name=Asserting)}, maxPointsInLeafNode=1233, 
maxMBSortInHeap=6.220140959918195, sim=RandomSimilarity(queryNorm=true): {}, 
locale=es-CR, timezone=America/Kralendijk
   [junit4]   2> NOTE: Linux 4.13.0-32-generic amd64/Oracle Corporation 
1.8.0_162 (64-bit)/cpus=8,threads=2,free=343368520,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [TestRankingFeature, 
TestUserTermScorereQDF, TestLTROnSolrCloud, TestManagedFeatureStore, 
TestLTRReRankingPipeline, TestExternalValueFeatures, TestLinearModel, 
TestMultipleAdditiveTreesModel]
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestMultipleAdditiveTreesModel -Dtests.seed=FB60D0DA57A0B0C5 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=es-CR 
-Dtests.timezone=America/Kralendijk -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   0.00s J0 | TestMultipleAdditiveTreesModel (suite) <<<
   [junit4]    > Throwable #1: 
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE 
scope at org.apache.solr.ltr.model.TestMultipleAdditiveTreesModel: 
   [junit4]    >    1) Thread[id=248, name=qtp1744622884-248, 
state=TIMED_WAITING, group=TGRP-TestMultipleAdditiveTreesModel]
   [junit4]    >         at sun.misc.Unsafe.park(Native Method)
   [junit4]    >         at 
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
   [junit4]    >         at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163)
   [junit4]    >         at 
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
   [junit4]    >         at 
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
   [junit4]    >         at 
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)
   [junit4]    >         at 
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
   [junit4]    >         at java.lang.Thread.run(Thread.java:748)
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([FB60D0DA57A0B0C5]:0)Throwable #2: 
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie 
threads that couldn't be terminated:
   [junit4]    >    1) Thread[id=248, name=qtp1744622884-248, 
state=TIMED_WAITING, group=TGRP-TestMultipleAdditiveTreesModel]
   [junit4]    >         at sun.misc.Unsafe.park(Native Method)
   [junit4]    >         at 
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
   [junit4]    >         at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163)
   [junit4]    >         at 
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
   [junit4]    >         at 
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
   [junit4]    >         at 
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)
   [junit4]    >         at 
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
   [junit4]    >         at java.lang.Thread.run(Thread.java:748)
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([FB60D0DA57A0B0C5]:0)
   [junit4] Completed [36/36 (1!)] on J0 in 53.54s, 10 tests, 2 errors <<< 
FAILURES!

[...truncated 40977 lines...]
[repro] Jenkins log URL: 
https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/1418/consoleText

[repro] Revision: d7f6cb93837e1bde1066c96606845c4ab04e50cf

[repro] Repro line:  ant test  -Dtestcase=TestMultipleAdditiveTreesModel 
-Dtests.seed=FB60D0DA57A0B0C5 -Dtests.multiplier=3 -Dtests.slow=true 
-Dtests.locale=es-CR -Dtests.timezone=America/Kralendijk -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1

[repro] Ant options: "-Dargs=-XX:-UseCompressedOops -XX:+UseG1GC"
[repro] ant clean

[...truncated 6 lines...]
[repro] Test suites by module:
[repro]    solr/contrib/ltr
[repro]       TestMultipleAdditiveTreesModel
[repro] ant compile-test

[...truncated 2579 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 
-Dtests.class="*.TestMultipleAdditiveTreesModel" -Dtests.showOutput=onerror 
"-Dargs=-XX:-UseCompressedOops -XX:+UseG1GC" -Dtests.seed=FB60D0DA57A0B0C5 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=es-CR 
-Dtests.timezone=America/Kralendijk -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1

[...truncated 116 lines...]
[repro] Failures:
[repro]   0/5 failed: org.apache.solr.ltr.model.TestMultipleAdditiveTreesModel
[repro] Exiting with code 0

[...truncated 40 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to