Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/1391/
Java: 64bit/jdk-9.0.4 -XX:-UseCompressedOops -XX:+UseG1GC

2 tests failed.
FAILED:  
junit.framework.TestSuite.org.apache.solr.ltr.feature.TestExternalValueFeatures

Error Message:
1 thread leaked from SUITE scope at 
org.apache.solr.ltr.feature.TestExternalValueFeatures:     1) Thread[id=111, 
name=qtp1766728254-111, state=TIMED_WAITING, 
group=TGRP-TestExternalValueFeatures]         at 
java.base@9.0.4/jdk.internal.misc.Unsafe.park(Native Method)         at 
java.base@9.0.4/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:234)
         at 
java.base@9.0.4/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2192)
         at 
app//org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
         at 
app//org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
         at 
app//org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)
         at 
app//org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
         at java.base@9.0.4/java.lang.Thread.run(Thread.java:844)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE 
scope at org.apache.solr.ltr.feature.TestExternalValueFeatures: 
   1) Thread[id=111, name=qtp1766728254-111, state=TIMED_WAITING, 
group=TGRP-TestExternalValueFeatures]
        at java.base@9.0.4/jdk.internal.misc.Unsafe.park(Native Method)
        at 
java.base@9.0.4/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:234)
        at 
java.base@9.0.4/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2192)
        at 
app//org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
        at 
app//org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
        at 
app//org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)
        at 
app//org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
        at java.base@9.0.4/java.lang.Thread.run(Thread.java:844)
        at __randomizedtesting.SeedInfo.seed([E7B72E4C529707D0]:0)


FAILED:  
junit.framework.TestSuite.org.apache.solr.ltr.feature.TestExternalValueFeatures

Error Message:
There are still zombie threads that couldn't be terminated:    1) 
Thread[id=111, name=qtp1766728254-111, state=TIMED_WAITING, 
group=TGRP-TestExternalValueFeatures]         at 
java.base@9.0.4/jdk.internal.misc.Unsafe.park(Native Method)         at 
java.base@9.0.4/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:234)
         at 
java.base@9.0.4/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2192)
         at 
app//org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
         at 
app//org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
         at 
app//org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)
         at 
app//org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
         at java.base@9.0.4/java.lang.Thread.run(Thread.java:844)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie 
threads that couldn't be terminated:
   1) Thread[id=111, name=qtp1766728254-111, state=TIMED_WAITING, 
group=TGRP-TestExternalValueFeatures]
        at java.base@9.0.4/jdk.internal.misc.Unsafe.park(Native Method)
        at 
java.base@9.0.4/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:234)
        at 
java.base@9.0.4/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2192)
        at 
app//org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
        at 
app//org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
        at 
app//org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)
        at 
app//org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
        at java.base@9.0.4/java.lang.Thread.run(Thread.java:844)
        at __randomizedtesting.SeedInfo.seed([E7B72E4C529707D0]:0)




Build Log:
[...truncated 22274 lines...]
   [junit4] Suite: org.apache.solr.ltr.feature.TestExternalValueFeatures
   [junit4]   2> 7300 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-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.feature.TestExternalValueFeatures_E7B72E4C529707D0-001/init-core-data-001
   [junit4]   2> 7301 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 7302 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 7304 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 7309 WARN  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-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> 7311 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.0
   [junit4]   2> 7320 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.s.IndexSchema [null] Schema name=example
   [junit4]   2> 7331 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.s.IndexSchema Loaded schema example/1.5 with uniqueid field id
   [junit4]   2> 7402 WARN  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via 
JMX.
   [junit4]   2> 7402 WARN  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via 
JMX.
   [junit4]   2> 7402 WARN  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via 
JMX.
   [junit4]   2> 7415 INFO  (coreLoadExecutor-71-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 7432 WARN  (coreLoadExecutor-71-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> 7434 INFO  (coreLoadExecutor-71-thread-1) [    x:collection1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.0
   [junit4]   2> 7443 INFO  (coreLoadExecutor-71-thread-1) [    x:collection1] 
o.a.s.s.IndexSchema [collection1] Schema name=example
   [junit4]   2> 7454 INFO  (coreLoadExecutor-71-thread-1) [    x:collection1] 
o.a.s.s.IndexSchema Loaded schema example/1.5 with uniqueid field id
   [junit4]   2> 7457 INFO  (coreLoadExecutor-71-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> 7458 WARN  (coreLoadExecutor-71-thread-1) [    x:collection1] 
o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via 
JMX.
   [junit4]   2> 7458 INFO  (coreLoadExecutor-71-thread-1) [    x:collection1] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 7458 INFO  (coreLoadExecutor-71-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.feature.TestExternalValueFeatures_E7B72E4C529707D0-001/init-core-data-001/]
   [junit4]   2> 7490 WARN  (coreLoadExecutor-71-thread-1) [    x:collection1] 
o.a.s.c.RequestHandlers no default request handler is registered (either 
'/select' or 'standard')
   [junit4]   2> 7491 INFO  (coreLoadExecutor-71-thread-1) [    x:collection1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 7491 INFO  (coreLoadExecutor-71-thread-1) [    x:collection1] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 7493 INFO  (coreLoadExecutor-71-thread-1) [    x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 15000ms; 
   [junit4]   2> 7493 INFO  (coreLoadExecutor-71-thread-1) [    x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: if uncommited for 1000ms; 
   [junit4]   2> 7494 INFO  (coreLoadExecutor-71-thread-1) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@76072914[collection1] main]
   [junit4]   2> 7494 WARN  (coreLoadExecutor-71-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> 7495 INFO  (coreLoadExecutor-71-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> 7495 WARN  (coreLoadExecutor-71-thread-1) [    x:collection1] 
o.a.s.r.ManagedResource No stored data found for /schema/feature-store
   [junit4]   2> 7495 INFO  (coreLoadExecutor-71-thread-1) [    x:collection1] 
o.a.s.l.s.r.ManagedFeatureStore ------ managed feature ~ loading ------
   [junit4]   2> 7495 INFO  (coreLoadExecutor-71-thread-1) [    x:collection1] 
o.a.s.r.ManagedResource Notified 1 observers of /schema/feature-store
   [junit4]   2> 7495 INFO  (coreLoadExecutor-71-thread-1) [    x:collection1] 
o.a.s.r.RestManager Registered new managed resource /schema/feature-store
   [junit4]   2> 7495 INFO  (coreLoadExecutor-71-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> 7495 WARN  (coreLoadExecutor-71-thread-1) [    x:collection1] 
o.a.s.r.ManagedResource No stored data found for /schema/model-store
   [junit4]   2> 7495 INFO  (coreLoadExecutor-71-thread-1) [    x:collection1] 
o.a.s.l.s.r.ManagedModelStore INIT model store
   [junit4]   2> 7495 INFO  (coreLoadExecutor-71-thread-1) [    x:collection1] 
o.a.s.l.s.r.ManagedModelStore ------ managed models ~ loading ------
   [junit4]   2> 7495 INFO  (coreLoadExecutor-71-thread-1) [    x:collection1] 
o.a.s.r.ManagedResource Notified 1 observers of /schema/model-store
   [junit4]   2> 7495 INFO  (coreLoadExecutor-71-thread-1) [    x:collection1] 
o.a.s.r.RestManager Registered new managed resource /schema/model-store
   [junit4]   2> 7495 INFO  (coreLoadExecutor-71-thread-1) [    x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 7496 INFO  (coreLoadExecutor-71-thread-1) [    x:collection1] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1592881193159753728
   [junit4]   2> 7496 INFO  
(searcherExecutor-72-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@76072914[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 7500 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 7506 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 7506 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 7506 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-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.feature.TestExternalValueFeatures_E7B72E4C529707D0-001/tempDir-003/cores/core
   [junit4]   2> 7508 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-21T17:27:37-04:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 7513 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 7513 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 7514 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.e.j.s.session Scavenging every 660000ms
   [junit4]   2> 7514 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@14746eae{/solr,null,AVAILABLE}
   [junit4]   2> 7515 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@5cd5af6e{SSL,[ssl, 
http/1.1]}{127.0.0.1:32881}
   [junit4]   2> 7515 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.e.j.s.Server Started @8764ms
   [junit4]   2> 7515 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
configSetBaseDir=/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.feature.TestExternalValueFeatures_E7B72E4C529707D0-001/tempDir-001,
 hostPort=32881, 
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.feature.TestExternalValueFeatures_E7B72E4C529707D0-001/tempDir-003/cores}
   [junit4]   2> 7516 ERROR 
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 7516 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.3.0
   [junit4]   2> 7516 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 7516 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 7516 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-02-20T01:24:43.023351Z
   [junit4]   2> 7516 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-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.feature.TestExternalValueFeatures_E7B72E4C529707D0-001/tempDir-001/solr.xml
   [junit4]   2> 7547 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-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.feature.TestExternalValueFeatures_E7B72E4C529707D0-001/tempDir-003/cores
   [junit4]   2> 7547 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 7552 INFO  (coreLoadExecutor-82-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 7562 WARN  (coreLoadExecutor-82-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.feature.TestExternalValueFeatures_E7B72E4C529707D0-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.feature.TestExternalValueFeatures_E7B72E4C529707D0-001/tempDir-001/models
   [junit4]   2> 7564 INFO  (coreLoadExecutor-82-thread-1) [    x:collection1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.0
   [junit4]   2> 7573 INFO  (coreLoadExecutor-82-thread-1) [    x:collection1] 
o.a.s.s.IndexSchema [collection1] Schema name=example
   [junit4]   2> 7581 INFO  (coreLoadExecutor-82-thread-1) [    x:collection1] 
o.a.s.s.IndexSchema Loaded schema example/1.5 with uniqueid field id
   [junit4]   2> 7584 INFO  (coreLoadExecutor-82-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.feature.TestExternalValueFeatures_E7B72E4C529707D0-001/tempDir-001/collection1,
 trusted=true
   [junit4]   2> 7584 INFO  (coreLoadExecutor-82-thread-1) [    x:collection1] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 7584 INFO  (coreLoadExecutor-82-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.feature.TestExternalValueFeatures_E7B72E4C529707D0-001/tempDir-001/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.feature.TestExternalValueFeatures_E7B72E4C529707D0-001/tempDir-003/cores/core/data/]
   [junit4]   2> 7622 WARN  (coreLoadExecutor-82-thread-1) [    x:collection1] 
o.a.s.c.RequestHandlers no default request handler is registered (either 
'/select' or 'standard')
   [junit4]   2> 7629 INFO  (coreLoadExecutor-82-thread-1) [    x:collection1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 7629 INFO  (coreLoadExecutor-82-thread-1) [    x:collection1] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 7631 INFO  (coreLoadExecutor-82-thread-1) [    x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 15000ms; 
   [junit4]   2> 7631 INFO  (coreLoadExecutor-82-thread-1) [    x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: if uncommited for 1000ms; 
   [junit4]   2> 7633 INFO  (coreLoadExecutor-82-thread-1) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@954cd7f[collection1] main]
   [junit4]   2> 7633 INFO  (coreLoadExecutor-82-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.feature.TestExternalValueFeatures_E7B72E4C529707D0-001/tempDir-001/collection1/conf
   [junit4]   2> 7634 INFO  (coreLoadExecutor-82-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> 7634 WARN  (coreLoadExecutor-82-thread-1) [    x:collection1] 
o.a.s.r.ManagedResource No stored data found for /schema/feature-store
   [junit4]   2> 7634 INFO  (coreLoadExecutor-82-thread-1) [    x:collection1] 
o.a.s.l.s.r.ManagedFeatureStore ------ managed feature ~ loading ------
   [junit4]   2> 7634 INFO  (coreLoadExecutor-82-thread-1) [    x:collection1] 
o.a.s.r.ManagedResource Notified 1 observers of /schema/feature-store
   [junit4]   2> 7634 INFO  (coreLoadExecutor-82-thread-1) [    x:collection1] 
o.a.s.r.RestManager Registered new managed resource /schema/feature-store
   [junit4]   2> 7634 INFO  (coreLoadExecutor-82-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> 7634 WARN  (coreLoadExecutor-82-thread-1) [    x:collection1] 
o.a.s.r.ManagedResource No stored data found for /schema/model-store
   [junit4]   2> 7634 INFO  (coreLoadExecutor-82-thread-1) [    x:collection1] 
o.a.s.l.s.r.ManagedModelStore INIT model store
   [junit4]   2> 7634 INFO  (coreLoadExecutor-82-thread-1) [    x:collection1] 
o.a.s.l.s.r.ManagedModelStore ------ managed models ~ loading ------
   [junit4]   2> 7634 INFO  (coreLoadExecutor-82-thread-1) [    x:collection1] 
o.a.s.r.ManagedResource Notified 1 observers of /schema/model-store
   [junit4]   2> 7634 INFO  (coreLoadExecutor-82-thread-1) [    x:collection1] 
o.a.s.r.RestManager Registered new managed resource /schema/model-store
   [junit4]   2> 7634 INFO  (coreLoadExecutor-82-thread-1) [    x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 7635 INFO  (coreLoadExecutor-82-thread-1) [    x:collection1] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1592881193305505792
   [junit4]   2> 7635 INFO  
(searcherExecutor-83-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@954cd7f[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 7636 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.SolrJettyTestBase Jetty Assigned Port#32881
   [junit4]   2> 7763 INFO  (qtp1766728254-109) [    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
 (1592881193433432064)]} 0 10
   [junit4]   2> 7770 INFO  (qtp1766728254-111) [    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
 (1592881193446014976)]} 0 1
   [junit4]   2> 7777 INFO  (qtp1766728254-109) [    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
 (1592881193454403584)]} 0 1
   [junit4]   2> 7781 INFO  (qtp1766728254-111) [    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
 (1592881193457549312)]} 0 0
   [junit4]   2> 7784 INFO  (qtp1766728254-109) [    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
 (1592881193460695040)]} 0 0
   [junit4]   2> 7786 INFO  (qtp1766728254-111) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1592881193463840768,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 7786 INFO  (qtp1766728254-111) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@25a4470f 
commitCommandVersion:1592881193463840768
   [junit4]   2> 7796 INFO  (qtp1766728254-111) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@c1474fe[collection1] main]
   [junit4]   2> 7797 INFO  (qtp1766728254-111) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 7797 INFO  
(searcherExecutor-83-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@c1474fe[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.3.0):C5)))}
   [junit4]   2> 7797 INFO  (qtp1766728254-111) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={stream.body=<commit/>}{commit=} 0 11
   [junit4]   2> 7799 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.l.TestRerankBase send 
   [junit4]   2> [{
   [junit4]   2>   "name" : "user_device_smartphone",
   [junit4]   2>   "class":"org.apache.solr.ltr.feature.ValueFeature",
   [junit4]   2>   "params" : {
   [junit4]   2>     "value": "${user_device_smartphone}"
   [junit4]   2>   }
   [junit4]   2> },
   [junit4]   2>   {
   [junit4]   2>     "name" : "user_device_tablet",
   [junit4]   2>     "class":"org.apache.solr.ltr.feature.ValueFeature",
   [junit4]   2>     "params" : {
   [junit4]   2>       "value": "${user_device_tablet}"
   [junit4]   2>     }
   [junit4]   2>   }
   [junit4]   2> 
   [junit4]   2> 
   [junit4]   2> 
   [junit4]   2> ]
   [junit4]   2> 
   [junit4]   2> 7801 INFO  (qtp1766728254-109) [    x:collection1] 
o.e.j.s.h.C.solr SolrSchemaRestApi: [Restlet] ServerServlet: component class is 
null
   [junit4]   2> 7803 INFO  (qtp1766728254-109) [    x:collection1] 
o.e.j.s.h.C.solr SolrSchemaRestApi: [Restlet] Attaching application: 
org.apache.solr.rest.SolrSchemaRestApi@1b7d8cbe to URI: /solr/schema
   [junit4]   2> Feb 19, 2018 6:24:43 ICHAMTHI org.restlet.Application start
   [junit4]   2> INFO: Starting org.apache.solr.rest.SolrSchemaRestApi 
application
   [junit4]   2> 7807 INFO  (qtp1766728254-109) [    x:collection1] 
o.a.s.r.SolrSchemaRestApi createInboundRoot started for /schema
   [junit4]   2> 7808 INFO  (qtp1766728254-109) [    x:collection1] 
o.a.s.r.RestManager Attached managed resource at path: /feature-store
   [junit4]   2> 7808 INFO  (qtp1766728254-109) [    x:collection1] 
o.a.s.r.RestManager Attached managed resource at path: /managed
   [junit4]   2> 7808 INFO  (qtp1766728254-109) [    x:collection1] 
o.a.s.r.RestManager Attached managed resource at path: /model-store
   [junit4]   2> 7808 INFO  (qtp1766728254-109) [    x:collection1] 
o.a.s.r.RestManager Attached 3 ManagedResource endpoints to Restlet router: 
/schema
   [junit4]   2> 7808 INFO  (qtp1766728254-109) [    x:collection1] 
o.a.s.r.SolrSchemaRestApi createInboundRoot complete for /schema
   [junit4]   2> 7809 INFO  (qtp1766728254-109) [    x:collection1] 
o.a.s.r.RestManager Found ManagedResource 
[org.apache.solr.ltr.store.rest.ManagedFeatureStore@13aa5112] for 
/schema/feature-store
   [junit4]   2> 7809 INFO  (qtp1766728254-109) [    x:collection1] 
o.a.s.r.ManagedResource Processing update to /schema/feature-store: 
[{name=user_device_smartphone, class=org.apache.solr.ltr.feature.ValueFeature, 
params={value=${user_device_smartphone}}}, {name=user_device_tablet, 
class=org.apache.solr.ltr.feature.ValueFeature, 
params={value=${user_device_tablet}}}] is a java.util.ArrayList
   [junit4]   2> 7809 INFO  (qtp1766728254-109) [    x:collection1] 
o.a.s.l.s.r.ManagedFeatureStore register feature based on 
{name=user_device_smartphone, class=org.apache.solr.ltr.feature.ValueFeature, 
params={value=${user_device_smartphone}}}
   [junit4]   2> 7812 INFO  (qtp1766728254-109) [    x:collection1] 
o.a.s.l.s.r.ManagedFeatureStore register feature based on 
{name=user_device_tablet, class=org.apache.solr.ltr.feature.ValueFeature, 
params={value=${user_device_tablet}}}
   [junit4]   2> 7813 INFO  (qtp1766728254-109) [    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.feature.TestExternalValueFeatures_E7B72E4C529707D0-001/tempDir-001/collection1/conf
   [junit4]   2> 7813 INFO  (qtp1766728254-109) [    x:collection1] 
o.a.s.r.RestManager [collection1]  webapp=/solr path=/schema/feature-store 
params={indent=on&wt=json} status=0 QTime=12
   [junit4]   2> Feb 19, 2018 6:24:43 ICHAMTHI org.restlet.engine.log.LogFilter 
afterHandle
   [junit4]   2> INFO: 2018-02-19       18:24:43        127.0.0.1       -       
127.0.0.1       32881   PUT     /solr/schema/feature-store      
wt=json&indent=on       200     -       323     10      https://127.0.0.1:32881 
Apache-HttpClient/4.5.3 (Java/9.0.4)    -
   [junit4]   2> 7822 INFO  (qtp1766728254-109) [    x:collection1] 
o.a.s.r.RestManager Found ManagedResource [ManagedModelStore [store=ModelStore 
[availableModels=[]], 
featureStores=org.apache.solr.ltr.store.rest.ManagedFeatureStore@13aa5112]] for 
/schema/model-store
   [junit4]   2> 7823 INFO  (qtp1766728254-109) [    x:collection1] 
o.a.s.r.ManagedResource Processing update to /schema/model-store: 
{class=org.apache.solr.ltr.model.MultipleAdditiveTreesModel, 
name=external_model_binary_feature, features=[{name=user_device_smartphone}, 
{name=user_device_tablet}], params={trees=[{weight=1f, 
root={feature=user_device_smartphone, threshold=0.5f, left={value=0}, 
right={value=50}}}, {weight=1f, root={feature=user_device_tablet, 
threshold=0.5f, left={value=0}, right={value=65}}}]}} is a 
java.util.LinkedHashMap
   [junit4]   2> 7831 INFO  (qtp1766728254-109) [    x:collection1] 
o.a.s.l.s.r.ManagedModelStore adding model external_model_binary_feature
   [junit4]   2> 7832 INFO  (qtp1766728254-109) [    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.feature.TestExternalValueFeatures_E7B72E4C529707D0-001/tempDir-001/collection1/conf
   [junit4]   2> 7832 INFO  (qtp1766728254-109) [    x:collection1] 
o.a.s.r.RestManager [collection1]  webapp=/solr path=/schema/model-store 
params={indent=on&wt=json} status=0 QTime=11
   [junit4]   2> Feb 19, 2018 6:24:43 ICHAMTHI org.restlet.engine.log.LogFilter 
afterHandle
   [junit4]   2> INFO: 2018-02-19       18:24:43        127.0.0.1       -       
127.0.0.1       32881   PUT     /solr/schema/model-store        
wt=json&indent=on       200     -       768     11      https://127.0.0.1:32881 
Apache-HttpClient/4.5.3 (Java/9.0.4)    -
   [junit4]   2> 7836 INFO  
(TEST-TestExternalValueFeatures.efiFeatureProcessing_oneEfiMissing_shouldNotCalculateMissingFeature-seed#[E7B72E4C529707D0])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting 
efiFeatureProcessing_oneEfiMissing_shouldNotCalculateMissingFeature
   [junit4]   2> 7839 INFO  (qtp1766728254-111) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/query 
params={q=*:*&indent=on&fl=*,score,features:[fv]&rows=3&wt=json&rq={!ltr+reRankDocs%3D3+model%3Dexternal_model_binary_feature+efi.user_device_tablet%3D1}}
 hits=5 status=0 QTime=1
   [junit4]   2> 7843 INFO  (qtp1766728254-109) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/query 
params={q=*:*&indent=on&fl=*,score,features:[fv]&rows=3&wt=json&rq={!ltr+reRankDocs%3D3+model%3Dexternal_model_binary_feature+efi.user_device_tablet%3D1}}
 hits=5 status=0 QTime=0
   [junit4]   2> 7858 INFO  (qtp1766728254-109) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/query 
params={q=*:*&indent=on&fl=*,score,features:[fv]&rows=3&wt=json&rq={!ltr+reRankDocs%3D3+model%3Dexternal_model_binary_feature+efi.user_device_tablet%3D1}}
 hits=5 status=0 QTime=10
   [junit4]   2> 7860 INFO  
(TEST-TestExternalValueFeatures.efiFeatureProcessing_oneEfiMissing_shouldNotCalculateMissingFeature-seed#[E7B72E4C529707D0])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending 
efiFeatureProcessing_oneEfiMissing_shouldNotCalculateMissingFeature
   [junit4]   2> 7867 INFO  
(TEST-TestExternalValueFeatures.efiFeatureProcessing_allEfisMissing_shouldReturnZeroScore-seed#[E7B72E4C529707D0])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting 
efiFeatureProcessing_allEfisMissing_shouldReturnZeroScore
   [junit4]   2> 7869 INFO  (qtp1766728254-111) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/query 
params={q=*:*&indent=on&fl=*,score,features:[fv]&fl=[fv]&rows=3&wt=json&rq={!ltr+reRankDocs%3D3+model%3Dexternal_model_binary_feature}}
 hits=5 status=0 QTime=0
   [junit4]   2> 7878 INFO  (qtp1766728254-109) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/query 
params={q=*:*&indent=on&fl=*,score,features:[fv]&fl=[fv]&rows=3&wt=json&rq={!ltr+reRankDocs%3D3+model%3Dexternal_model_binary_feature}}
 hits=5 status=0 QTime=0
   [junit4]   2> 7881 INFO  (qtp1766728254-111) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/query 
params={q=*:*&indent=on&fl=*,score,features:[fv]&fl=[fv]&rows=3&wt=json&rq={!ltr+reRankDocs%3D3+model%3Dexternal_model_binary_feature}}
 hits=5 status=0 QTime=0
   [junit4]   2> 7882 INFO  
(TEST-TestExternalValueFeatures.efiFeatureProcessing_allEfisMissing_shouldReturnZeroScore-seed#[E7B72E4C529707D0])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending 
efiFeatureProcessing_allEfisMissing_shouldReturnZeroScore
   [junit4]   2> 7897 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@5cd5af6e{SSL,[ssl, 
http/1.1]}{127.0.0.1:0}
   [junit4]   2> 7898 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1746395728
   [junit4]   2> 7898 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 7898 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 7898 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 7903 INFO  (coreCloseExecutor-88-thread-1) [    x:collection1] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@705ee360
   [junit4]   2> 7903 INFO  (coreCloseExecutor-88-thread-1) [    x:collection1] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=1885266784
   [junit4]   2> 7921 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@14746eae{/solr,null,UNAVAILABLE}
   [junit4]   2> 7921 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.e.j.s.session Stopped scavenging
   [junit4]   2> 37919 WARN  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.e.j.u.t.QueuedThreadPool 
QueuedThreadPool@qtp1766728254{STOPPING,8<=9<=10000,i=0,q=1} Couldn't stop 
Thread[qtp1766728254-111,5,TGRP-TestExternalValueFeatures]
   [junit4]   2> 37921 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 37921 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=2095592502
   [junit4]   2> 37921 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 37921 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@172030b1: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ null
   [junit4]   2> 37921 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 37921 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@6564c24f: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
null
   [junit4]   2> 37921 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 37921 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@392ff3d3: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / null
   [junit4]   2> 37921 INFO  (coreCloseExecutor-90-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@6b592ef
   [junit4]   2> 37921 INFO  (coreCloseExecutor-90-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=112562927
   [junit4]   2> 37921 INFO  (coreCloseExecutor-90-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@284b677b: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / null
   [junit4]   2> 37923 INFO  
(SUITE-TestExternalValueFeatures-seed#[E7B72E4C529707D0]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ------------------------------------------------------- 
Done waiting for tracked resources to be released
   [junit4]   2> Feb 20, 2018 1:25:13 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> Feb 20, 2018 1:25:33 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> SEVERE: 1 thread leaked from SUITE scope at 
org.apache.solr.ltr.feature.TestExternalValueFeatures: 
   [junit4]   2>    1) Thread[id=111, name=qtp1766728254-111, 
state=TIMED_WAITING, group=TGRP-TestExternalValueFeatures]
   [junit4]   2>         at 
java.base@9.0.4/jdk.internal.misc.Unsafe.park(Native Method)
   [junit4]   2>         at 
java.base@9.0.4/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:234)
   [junit4]   2>         at 
java.base@9.0.4/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2192)
   [junit4]   2>         at 
app//org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
   [junit4]   2>         at 
app//org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
   [junit4]   2>         at 
app//org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)
   [junit4]   2>         at 
app//org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
   [junit4]   2>         at 
java.base@9.0.4/java.lang.Thread.run(Thread.java:844)
   [junit4]   2> Feb 20, 2018 1:25:33 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
   [junit4]   2> INFO: Starting to interrupt leaked threads:
   [junit4]   2>    1) Thread[id=111, name=qtp1766728254-111, 
state=TIMED_WAITING, group=TGRP-TestExternalValueFeatures]
   [junit4]   2> Feb 20, 2018 1:25:36 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
   [junit4]   2> SEVERE: There are still zombie threads that couldn't be 
terminated:
   [junit4]   2>    1) Thread[id=111, name=qtp1766728254-111, 
state=TIMED_WAITING, group=TGRP-TestExternalValueFeatures]
   [junit4]   2>         at 
java.base@9.0.4/jdk.internal.misc.Unsafe.park(Native Method)
   [junit4]   2>         at 
java.base@9.0.4/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:234)
   [junit4]   2>         at 
java.base@9.0.4/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2192)
   [junit4]   2>         at 
app//org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
   [junit4]   2>         at 
app//org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
   [junit4]   2>         at 
app//org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)
   [junit4]   2>         at 
app//org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
   [junit4]   2>         at 
java.base@9.0.4/java.lang.Thread.run(Thread.java:844)
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70), 
sim=RandomSimilarity(queryNorm=true): {}, locale=asa, 
timezone=America/Yellowknife
   [junit4]   2> NOTE: Linux 4.13.0-32-generic amd64/Oracle Corporation 9.0.4 
(64-bit)/cpus=8,threads=2,free=200079832,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [TestFieldLengthFeature, 
TestManagedFeatureStore, TestSelectiveWeightCreation, TestWrapperModel, 
TestExternalValueFeatures]
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestExternalValueFeatures -Dtests.seed=E7B72E4C529707D0 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=asa 
-Dtests.timezone=America/Yellowknife -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.00s J0 | TestExternalValueFeatures (suite) <<<
   [junit4]    > Throwable #1: 
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE 
scope at org.apache.solr.ltr.feature.TestExternalValueFeatures: 
   [junit4]    >    1) Thread[id=111, name=qtp1766728254-111, 
state=TIMED_WAITING, group=TGRP-TestExternalValueFeatures]
   [junit4]    >         at 
java.base@9.0.4/jdk.internal.misc.Unsafe.park(Native Method)
   [junit4]    >         at 
java.base@9.0.4/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:234)
   [junit4]    >         at 
java.base@9.0.4/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2192)
   [junit4]    >         at 
app//org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
   [junit4]    >         at 
app//org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
   [junit4]    >         at 
app//org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)
   [junit4]    >         at 
app//org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
   [junit4]    >         at 
java.base@9.0.4/java.lang.Thread.run(Thread.java:844)
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([E7B72E4C529707D0]:0)Throwable #2: 
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie 
threads that couldn't be terminated:
   [junit4]    >    1) Thread[id=111, name=qtp1766728254-111, 
state=TIMED_WAITING, group=TGRP-TestExternalValueFeatures]
   [junit4]    >         at 
java.base@9.0.4/jdk.internal.misc.Unsafe.park(Native Method)
   [junit4]    >         at 
java.base@9.0.4/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:234)
   [junit4]    >         at 
java.base@9.0.4/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2192)
   [junit4]    >         at 
app//org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
   [junit4]    >         at 
app//org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
   [junit4]    >         at 
app//org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)
   [junit4]    >         at 
app//org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
   [junit4]    >         at 
java.base@9.0.4/java.lang.Thread.run(Thread.java:844)
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([E7B72E4C529707D0]:0)
   [junit4] Completed [35/36 (1!)] on J0 in 53.69s, 2 tests, 2 errors <<< 
FAILURES!

[...truncated 33715 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to