Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-MacOSX/406/
Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseG1GC
2 tests failed.
FAILED:
junit.framework.TestSuite.org.apache.solr.ltr.feature.TestUserTermScoreWithQ
Error Message:
1 thread leaked from SUITE scope at
org.apache.solr.ltr.feature.TestUserTermScoreWithQ: 1) Thread[id=89,
name=qtp531507010-89, state=TIMED_WAITING, group=TGRP-TestUserTermScoreWithQ]
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.feature.TestUserTermScoreWithQ:
1) Thread[id=89, name=qtp531507010-89, state=TIMED_WAITING,
group=TGRP-TestUserTermScoreWithQ]
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([DFE82B7B342E5B03]:0)
FAILED:
junit.framework.TestSuite.org.apache.solr.ltr.feature.TestUserTermScoreWithQ
Error Message:
There are still zombie threads that couldn't be terminated: 1) Thread[id=89,
name=qtp531507010-89, state=TIMED_WAITING, group=TGRP-TestUserTermScoreWithQ]
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=89, name=qtp531507010-89, state=TIMED_WAITING,
group=TGRP-TestUserTermScoreWithQ]
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([DFE82B7B342E5B03]:0)
Build Log:
[...truncated 21610 lines...]
[junit4] Suite: org.apache.solr.ltr.feature.TestUserTermScoreWithQ
[junit4] 2> Creating dataDir:
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.feature.TestUserTermScoreWithQ_DFE82B7B342E5B03-001/init-core-data-001
[junit4] 2> 23955 WARN
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=3 numCloses=3
[junit4] 2> 23955 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 23960 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
w/ MAC_OS_X supressed clientAuth
[junit4] 2> 24557 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 24558 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 24636 WARN
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.c.SolrConfig Couldn't add files from
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/contrib/ltr/src/test-files/solr/models
filtered by null to classpath:
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/contrib/ltr/src/test-files/solr/models
[junit4] 2> 24641 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.0
[junit4] 2> 24685 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.s.IndexSchema [null] Schema name=example
[junit4] 2> 24804 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.s.IndexSchema Loaded schema example/1.5 with uniqueid field id
[junit4] 2> 25210 WARN
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via
JMX.
[junit4] 2> 25210 WARN
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via
JMX.
[junit4] 2> 25210 WARN
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via
JMX.
[junit4] 2> 25212 INFO (coreLoadExecutor-58-thread-1) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 25255 WARN (coreLoadExecutor-58-thread-1) [ x:collection1]
o.a.s.c.SolrConfig Couldn't add files from
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/contrib/ltr/src/test-files/solr/models
filtered by null to classpath:
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/contrib/ltr/src/test-files/solr/models
[junit4] 2> 25260 INFO (coreLoadExecutor-58-thread-1) [ x:collection1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.0
[junit4] 2> 25280 INFO (coreLoadExecutor-58-thread-1) [ x:collection1]
o.a.s.s.IndexSchema [collection1] Schema name=example
[junit4] 2> 25307 INFO (coreLoadExecutor-58-thread-1) [ x:collection1]
o.a.s.s.IndexSchema Loaded schema example/1.5 with uniqueid field id
[junit4] 2> 25313 INFO (coreLoadExecutor-58-thread-1) [ x:collection1]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
instancedir
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/contrib/ltr/src/test-files/solr/collection1,
trusted=true
[junit4] 2> 25314 WARN (coreLoadExecutor-58-thread-1) [ x:collection1]
o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via
JMX.
[junit4] 2> 25314 INFO (coreLoadExecutor-58-thread-1) [ x:collection1]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 25315 INFO (coreLoadExecutor-58-thread-1) [ x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/contrib/ltr/src/test-files/solr/collection1],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.feature.TestUserTermScoreWithQ_DFE82B7B342E5B03-001/init-core-data-001/]
[junit4] 2> 25681 WARN (coreLoadExecutor-58-thread-1) [ x:collection1]
o.a.s.c.RequestHandlers no default request handler is registered (either
'/select' or 'standard')
[junit4] 2> 25683 INFO (coreLoadExecutor-58-thread-1) [ x:collection1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 25683 INFO (coreLoadExecutor-58-thread-1) [ x:collection1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 25693 INFO (coreLoadExecutor-58-thread-1) [ x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 15000ms;
[junit4] 2> 25693 INFO (coreLoadExecutor-58-thread-1) [ x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: if uncommited for 1000ms;
[junit4] 2> 25730 INFO (coreLoadExecutor-58-thread-1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@786a86f4[collection1] main]
[junit4] 2> 25731 WARN (coreLoadExecutor-58-thread-1) [ x:collection1]
o.a.s.r.ManagedResourceStorage Cannot write to config directory
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/contrib/ltr/src/test-files/solr/collection1/conf;
switching to use InMemory storage instead.
[junit4] 2> 25731 INFO (coreLoadExecutor-58-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> 25731 WARN (coreLoadExecutor-58-thread-1) [ x:collection1]
o.a.s.r.ManagedResource No stored data found for /schema/feature-store
[junit4] 2> 25731 INFO (coreLoadExecutor-58-thread-1) [ x:collection1]
o.a.s.l.s.r.ManagedFeatureStore ------ managed feature ~ loading ------
[junit4] 2> 25731 INFO (coreLoadExecutor-58-thread-1) [ x:collection1]
o.a.s.r.ManagedResource Notified 1 observers of /schema/feature-store
[junit4] 2> 25731 INFO (coreLoadExecutor-58-thread-1) [ x:collection1]
o.a.s.r.RestManager Registered new managed resource /schema/feature-store
[junit4] 2> 25732 INFO (coreLoadExecutor-58-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> 25732 WARN (coreLoadExecutor-58-thread-1) [ x:collection1]
o.a.s.r.ManagedResource No stored data found for /schema/model-store
[junit4] 2> 25732 INFO (coreLoadExecutor-58-thread-1) [ x:collection1]
o.a.s.l.s.r.ManagedModelStore INIT model store
[junit4] 2> 25732 INFO (coreLoadExecutor-58-thread-1) [ x:collection1]
o.a.s.l.s.r.ManagedModelStore ------ managed models ~ loading ------
[junit4] 2> 25732 INFO (coreLoadExecutor-58-thread-1) [ x:collection1]
o.a.s.r.ManagedResource Notified 1 observers of /schema/model-store
[junit4] 2> 25732 INFO (coreLoadExecutor-58-thread-1) [ x:collection1]
o.a.s.r.RestManager Registered new managed resource /schema/model-store
[junit4] 2> 25732 INFO (coreLoadExecutor-58-thread-1) [ x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 25734 INFO
(searcherExecutor-59-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@786a86f4[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 25734 INFO (coreLoadExecutor-58-thread-1) [ x:collection1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1589913400727568384
[junit4] 2> 25742 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 25762 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 25762 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 25764 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.feature.TestUserTermScoreWithQ_DFE82B7B342E5B03-001/tempDir-003/cores/core
[junit4] 2> 25804 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-21T11:27:37-10:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 25807 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 25808 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 25808 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 25809 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@5709853c{/solr,null,AVAILABLE}
[junit4] 2> 25849 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@5713ccab{SSL,[ssl,
http/1.1]}{127.0.0.1:64958}
[junit4] 2> 25849 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.e.j.s.Server Started @29693ms
[junit4] 2> 25849 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=64958,
configSetBaseDir=/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.feature.TestUserTermScoreWithQ_DFE82B7B342E5B03-001/tempDir-001,
coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.feature.TestUserTermScoreWithQ_DFE82B7B342E5B03-001/tempDir-003/cores}
[junit4] 2> 25850 ERROR
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 25858 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.3.0
[junit4] 2> 25858 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on
port null
[junit4] 2> 25858 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 25859 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-01-18T07:12:55.709Z
[junit4] 2> 25859 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.feature.TestUserTermScoreWithQ_DFE82B7B342E5B03-001/tempDir-001/solr.xml
[junit4] 2> 26149 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.feature.TestUserTermScoreWithQ_DFE82B7B342E5B03-001/tempDir-003/cores
[junit4] 2> 26150 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 26153 INFO (coreLoadExecutor-69-thread-1) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 26189 WARN (coreLoadExecutor-69-thread-1) [ x:collection1]
o.a.s.c.SolrConfig Couldn't add files from
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.feature.TestUserTermScoreWithQ_DFE82B7B342E5B03-001/tempDir-001/models
filtered by null to classpath:
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.feature.TestUserTermScoreWithQ_DFE82B7B342E5B03-001/tempDir-001/models
[junit4] 2> 26194 INFO (coreLoadExecutor-69-thread-1) [ x:collection1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.0
[junit4] 2> 26214 INFO (coreLoadExecutor-69-thread-1) [ x:collection1]
o.a.s.s.IndexSchema [collection1] Schema name=example
[junit4] 2> 26265 INFO (coreLoadExecutor-69-thread-1) [ x:collection1]
o.a.s.s.IndexSchema Loaded schema example/1.5 with uniqueid field id
[junit4] 2> 26280 INFO (coreLoadExecutor-69-thread-1) [ x:collection1]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
configset
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.feature.TestUserTermScoreWithQ_DFE82B7B342E5B03-001/tempDir-001/collection1,
trusted=true
[junit4] 2> 26281 INFO (coreLoadExecutor-69-thread-1) [ x:collection1]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 26281 INFO (coreLoadExecutor-69-thread-1) [ x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.feature.TestUserTermScoreWithQ_DFE82B7B342E5B03-001/tempDir-001/collection1],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.feature.TestUserTermScoreWithQ_DFE82B7B342E5B03-001/tempDir-003/cores/core/data/]
[junit4] 2> 26492 WARN (coreLoadExecutor-69-thread-1) [ x:collection1]
o.a.s.c.RequestHandlers no default request handler is registered (either
'/select' or 'standard')
[junit4] 2> 26494 INFO (coreLoadExecutor-69-thread-1) [ x:collection1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 26494 INFO (coreLoadExecutor-69-thread-1) [ x:collection1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 26497 INFO (coreLoadExecutor-69-thread-1) [ x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 15000ms;
[junit4] 2> 26497 INFO (coreLoadExecutor-69-thread-1) [ x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: if uncommited for 1000ms;
[junit4] 2> 26539 INFO (coreLoadExecutor-69-thread-1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@57cd6a03[collection1] main]
[junit4] 2> 26540 INFO (coreLoadExecutor-69-thread-1) [ x:collection1]
o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir:
/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.feature.TestUserTermScoreWithQ_DFE82B7B342E5B03-001/tempDir-001/collection1/conf
[junit4] 2> 26541 INFO (coreLoadExecutor-69-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> 26543 WARN (coreLoadExecutor-69-thread-1) [ x:collection1]
o.a.s.r.ManagedResource No stored data found for /schema/feature-store
[junit4] 2> 26543 INFO (coreLoadExecutor-69-thread-1) [ x:collection1]
o.a.s.l.s.r.ManagedFeatureStore ------ managed feature ~ loading ------
[junit4] 2> 26543 INFO (coreLoadExecutor-69-thread-1) [ x:collection1]
o.a.s.r.ManagedResource Notified 1 observers of /schema/feature-store
[junit4] 2> 26543 INFO (coreLoadExecutor-69-thread-1) [ x:collection1]
o.a.s.r.RestManager Registered new managed resource /schema/feature-store
[junit4] 2> 26543 INFO (coreLoadExecutor-69-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> 26543 WARN (coreLoadExecutor-69-thread-1) [ x:collection1]
o.a.s.r.ManagedResource No stored data found for /schema/model-store
[junit4] 2> 26544 INFO (coreLoadExecutor-69-thread-1) [ x:collection1]
o.a.s.l.s.r.ManagedModelStore INIT model store
[junit4] 2> 26544 INFO (coreLoadExecutor-69-thread-1) [ x:collection1]
o.a.s.l.s.r.ManagedModelStore ------ managed models ~ loading ------
[junit4] 2> 26544 INFO (coreLoadExecutor-69-thread-1) [ x:collection1]
o.a.s.r.ManagedResource Notified 1 observers of /schema/model-store
[junit4] 2> 26544 INFO (coreLoadExecutor-69-thread-1) [ x:collection1]
o.a.s.r.RestManager Registered new managed resource /schema/model-store
[junit4] 2> 26544 INFO (coreLoadExecutor-69-thread-1) [ x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 26544 INFO (coreLoadExecutor-69-thread-1) [ x:collection1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1589913401576914944
[junit4] 2> 26545 INFO
(searcherExecutor-70-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@57cd6a03[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 26547 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.SolrJettyTestBase Jetty Assigned Port#64958
[junit4] 2> 26938 INFO (qtp531507010-87) [ 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
(1589913401952305152)]} 0 37
[junit4] 2> 26955 INFO (qtp531507010-89) [ 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+2asd+asdd+didid</field><field+name%3D"description">w2+2asd+asdd+didid</field><field+name%3D"popularity">2</field></doc></add>}{add=[2
(1589913402001588224)]} 0 6
[junit4] 2> 26963 INFO (qtp531507010-87) [ 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
(1589913402015219712)]} 0 2
[junit4] 2> 26970 INFO (qtp531507010-89) [ 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
(1589913402022559744)]} 0 1
[junit4] 2> 26973 INFO (qtp531507010-87) [ 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
(1589913402026754048)]} 0 0
[junit4] 2> 26984 INFO (qtp531507010-89) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
params={stream.body=<add><doc><field+name%3D"id">6</field><field+name%3D"title">w1+w2</field><field+name%3D"description">w1+w2</field><field+name%3D"popularity">6</field></doc></add>}{add=[6
(1589913402037239808)]} 0 1
[junit4] 2> 27000 INFO (qtp531507010-87) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
params={stream.body=<add><doc><field+name%3D"id">7</field><field+name%3D"title">w1+w2+w3+w4+w5</field><field+name%3D"description">w1+w2+w3+w4+w5+w8</field><field+name%3D"popularity">7</field></doc></add>}{add=[7
(1589913402043531264)]} 0 12
[junit4] 2> 27006 INFO (qtp531507010-89) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
params={stream.body=<add><doc><field+name%3D"id">8</field><field+name%3D"title">w1+w1+w1+w2+w2+w8</field><field+name%3D"description">w1+w1+w1+w2+w2</field><field+name%3D"popularity">8</field></doc></add>}{add=[8
(1589913402061357056)]} 0 1
[junit4] 2> 27013 INFO (qtp531507010-87) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1589913402068697088,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 27013 INFO (qtp531507010-87) [ x:collection1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@306e4e61
commitCommandVersion:1589913402068697088
[junit4] 2> 27377 INFO (qtp531507010-87) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@7809dc55[collection1] main]
[junit4] 2> 27378 INFO (qtp531507010-87) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 27379 INFO
(searcherExecutor-70-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@7809dc55[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.3.0):C8)))}
[junit4] 2> 27379 INFO (qtp531507010-87) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
params={stream.body=<commit/>}{commit=} 0 366
[junit4] 2> 27390 INFO
(TEST-TestUserTermScoreWithQ.testUserTermScoreWithQ-seed#[DFE82B7B342E5B03]) [
] o.a.s.SolrTestCaseJ4 ###Starting testUserTermScoreWithQ
[junit4] 2> 27390 INFO
(TEST-TestUserTermScoreWithQ.testUserTermScoreWithQ-seed#[DFE82B7B342E5B03]) [
] o.a.s.l.TestRerankBase loading feauture
[junit4] 2> {
[junit4] 2> "name":"SomeTermQ",
[junit4] 2> "store":"test",
[junit4] 2> "class":"org.apache.solr.ltr.feature.SolrFeature",
[junit4] 2> "params":{"q":"{!terms f=popularity}88888"}
[junit4] 2> }
[junit4] 2>
[junit4] 2> 27393 INFO (qtp531507010-89) [ x:collection1]
o.e.j.s.h.C.solr SolrSchemaRestApi: [Restlet] ServerServlet: component class is
null
[junit4] 2> 27395 INFO (qtp531507010-89) [ x:collection1]
o.e.j.s.h.C.solr SolrSchemaRestApi: [Restlet] Attaching application:
org.apache.solr.rest.SolrSchemaRestApi@54d869b1 to URI: /solr/schema
[junit4] 2> Jan 17, 2018 11:12:57 PM org.restlet.Application start
[junit4] 2> INFO: Starting org.apache.solr.rest.SolrSchemaRestApi
application
[junit4] 2> 27418 INFO (qtp531507010-89) [ x:collection1]
o.a.s.r.SolrSchemaRestApi createInboundRoot started for /schema
[junit4] 2> 27419 INFO (qtp531507010-89) [ x:collection1]
o.a.s.r.RestManager Attached managed resource at path: /feature-store
[junit4] 2> 27420 INFO (qtp531507010-89) [ x:collection1]
o.a.s.r.RestManager Attached managed resource at path: /managed
[junit4] 2> 27420 INFO (qtp531507010-89) [ x:collection1]
o.a.s.r.RestManager Attached managed resource at path: /model-store
[junit4] 2> 27420 INFO (qtp531507010-89) [ x:collection1]
o.a.s.r.RestManager Attached 3 ManagedResource endpoints to Restlet router:
/schema
[junit4] 2> 27420 INFO (qtp531507010-89) [ x:collection1]
o.a.s.r.SolrSchemaRestApi createInboundRoot complete for /schema
[junit4] 2> 27421 INFO (qtp531507010-89) [ x:collection1]
o.a.s.r.RestManager Found ManagedResource
[org.apache.solr.ltr.store.rest.ManagedFeatureStore@581629cd] for
/schema/feature-store
[junit4] 2> 27421 INFO (qtp531507010-89) [ x:collection1]
o.a.s.r.ManagedResource Processing update to /schema/feature-store:
{name=SomeTermQ, store=test, class=org.apache.solr.ltr.feature.SolrFeature,
params={q={!terms f=popularity}88888}} is a java.util.LinkedHashMap
[junit4] 2> 27421 INFO (qtp531507010-89) [ x:collection1]
o.a.s.l.s.r.ManagedFeatureStore register feature based on {name=SomeTermQ,
store=test, class=org.apache.solr.ltr.feature.SolrFeature, params={q={!terms
f=popularity}88888}}
[junit4] 2> 27449 INFO (qtp531507010-89) [ x:collection1]
o.a.s.r.ManagedResourceStorage Saved JSON object to path
_schema_feature-store.json using
file:dir=/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.feature.TestUserTermScoreWithQ_DFE82B7B342E5B03-001/tempDir-001/collection1/conf
[junit4] 2> 27449 INFO (qtp531507010-89) [ x:collection1]
o.a.s.r.RestManager [collection1] webapp=/solr path=/schema/feature-store
params={indent=on&wt=json} status=0 QTime=57
[junit4] 2> Jan 17, 2018 11:12:57 PM org.restlet.engine.log.LogFilter
afterHandle
[junit4] 2> INFO: 2018-01-17 23:12:57 127.0.0.1 -
127.0.0.1 64958 PUT /solr/schema/feature-store
wt=json&indent=on 200 - 135 53 https://127.0.0.1:64958
Apache-HttpClient/4.5.3 (Java/1.8.0_144) -
[junit4] 2> 27452 INFO
(TEST-TestUserTermScoreWithQ.testUserTermScoreWithQ-seed#[DFE82B7B342E5B03]) [
] o.a.s.l.TestRerankBase loading model
[junit4] 2> {
[junit4] 2> "name":"Term-modelQ",
[junit4] 2> "store":"test",
[junit4] 2> "class":"org.apache.solr.ltr.model.LinearModel",
[junit4] 2> "features":[
[junit4] 2> { "name":"SomeTermQ"}
[junit4] 2> ]
[junit4] 2> ,
[junit4] 2> "params":{"weights":{"SomeTermQ":1.0}}
[junit4] 2> }
[junit4] 2>
[junit4] 2> 27454 INFO (qtp531507010-87) [ x:collection1]
o.a.s.r.RestManager Found ManagedResource [ManagedModelStore [store=ModelStore
[availableModels=[]],
featureStores=org.apache.solr.ltr.store.rest.ManagedFeatureStore@581629cd]] for
/schema/model-store
[junit4] 2> 27456 INFO (qtp531507010-87) [ x:collection1]
o.a.s.r.ManagedResource Processing update to /schema/model-store:
{name=Term-modelQ, store=test, class=org.apache.solr.ltr.model.LinearModel,
features=[{name=SomeTermQ}], params={weights={SomeTermQ=1.0}}} is a
java.util.LinkedHashMap
[junit4] 2> 27483 INFO (qtp531507010-87) [ x:collection1]
o.a.s.l.s.r.ManagedModelStore adding model Term-modelQ
[junit4] 2> 27484 INFO (qtp531507010-87) [ x:collection1]
o.a.s.r.ManagedResourceStorage Saved JSON object to path
_schema_model-store.json using
file:dir=/Users/jenkins/workspace/Lucene-Solr-7.x-MacOSX/solr/build/contrib/solr-ltr/test/J0/temp/solr.ltr.feature.TestUserTermScoreWithQ_DFE82B7B342E5B03-001/tempDir-001/collection1/conf
[junit4] 2> 27484 INFO (qtp531507010-87) [ x:collection1]
o.a.s.r.RestManager [collection1] webapp=/solr path=/schema/model-store
params={indent=on&wt=json} status=0 QTime=31
[junit4] 2> Jan 17, 2018 11:12:57 PM org.restlet.engine.log.LogFilter
afterHandle
[junit4] 2> INFO: 2018-01-17 23:12:57 127.0.0.1 -
127.0.0.1 64958 PUT /solr/schema/model-store
wt=json&indent=on 200 - 170 30 https://127.0.0.1:64958
Apache-HttpClient/4.5.3 (Java/1.8.0_144) -
[junit4] 2> 27628 INFO (qtp531507010-89) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/query
params={q=title:w1&indent=on&fl=*,+score&rows=4&wt=json&debugQuery=on&rq={!ltr+model%3DTerm-modelQ+reRankDocs%3D4}}
hits=4 status=0 QTime=139
[junit4] 2> 27637 INFO (qtp531507010-87) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/query
params={q=title:w1&indent=on&fl=*,+score&rows=4&wt=json&debugQuery=on&rq={!ltr+model%3DTerm-modelQ+reRankDocs%3D4}}
hits=4 status=0 QTime=6
[junit4] 2> 27644 INFO (qtp531507010-89) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/query
params={q=title:w1&indent=on&fl=*,+score&rows=4&wt=json&debugQuery=on&rq={!ltr+model%3DTerm-modelQ+reRankDocs%3D4}}
hits=4 status=0 QTime=3
[junit4] 2> 27646 INFO
(TEST-TestUserTermScoreWithQ.testUserTermScoreWithQ-seed#[DFE82B7B342E5B03]) [
] o.a.s.SolrTestCaseJ4 ###Ending testUserTermScoreWithQ
[junit4] 2> 27651 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@5713ccab{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 27651 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1905165106
[junit4] 2> 27651 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 27651 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 27651 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 27652 INFO (coreCloseExecutor-75-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@7e2294fd
[junit4] 2> 27653 INFO (coreCloseExecutor-75-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=2116195581
[junit4] 2> 27668 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@5709853c{/solr,null,UNAVAILABLE}
[junit4] 2> 27669 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.e.j.s.session Stopped scavenging
[junit4] 2> 57693 WARN
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.e.j.u.t.QueuedThreadPool
QueuedThreadPool@qtp531507010{STOPPING,8<=8<=10000,i=0,q=1} Couldn't stop
Thread[qtp531507010-89,5,TGRP-TestUserTermScoreWithQ]
[junit4] 2> 57700 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 57701 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1979240355
[junit4] 2> 57701 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 57701 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@59d17b47: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ null
[junit4] 2> 57701 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 57701 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@73fa2ade: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
null
[junit4] 2> 57702 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 57702 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@50ee89e: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / null
[junit4] 2> 57704 INFO (coreCloseExecutor-77-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@4d14939d
[junit4] 2> 57704 INFO (coreCloseExecutor-77-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=1293194141
[junit4] 2> 57705 INFO (coreCloseExecutor-77-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@37d36e68: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / null
[junit4] 2> 57741 INFO
(SUITE-TestUserTermScoreWithQ-seed#[DFE82B7B342E5B03]-worker) [ ]
o.a.s.SolrTestCaseJ4 -------------------------------------------------------
Done waiting for tracked resources to be released
[junit4] 2> Jan 18, 2018 7:13:27 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> Jan 18, 2018 7:13:47 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> SEVERE: 1 thread leaked from SUITE scope at
org.apache.solr.ltr.feature.TestUserTermScoreWithQ:
[junit4] 2> 1) Thread[id=89, name=qtp531507010-89, state=TIMED_WAITING,
group=TGRP-TestUserTermScoreWithQ]
[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> Jan 18, 2018 7:13:47 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: Starting to interrupt leaked threads:
[junit4] 2> 1) Thread[id=89, name=qtp531507010-89, state=TIMED_WAITING,
group=TGRP-TestUserTermScoreWithQ]
[junit4] 2> Jan 18, 2018 7:13:50 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> SEVERE: There are still zombie threads that couldn't be
terminated:
[junit4] 2> 1) Thread[id=89, name=qtp531507010-89, state=TIMED_WAITING,
group=TGRP-TestUserTermScoreWithQ]
[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=DummyCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=DUMMY,
chunkSize=9, maxDocsPerChunk=10, blockSize=6),
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=DUMMY,
chunkSize=9, blockSize=6)), sim=RandomSimilarity(queryNorm=true): {},
locale=id-ID, timezone=America/Tijuana
[junit4] 2> NOTE: Mac OS X 10.11.6 x86_64/Oracle Corporation 1.8.0_144
(64-bit)/cpus=3,threads=2,free=112279184,total=198180864
[junit4] 2> NOTE: All tests run in this JVM: [TestLTRWithSort,
TestUserTermScorereQDF, TestUserTermScoreWithQ]
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=TestUserTermScoreWithQ -Dtests.seed=DFE82B7B342E5B03
-Dtests.slow=true -Dtests.locale=id-ID -Dtests.timezone=America/Tijuana
-Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J0 | TestUserTermScoreWithQ (suite) <<<
[junit4] > Throwable #1:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE
scope at org.apache.solr.ltr.feature.TestUserTermScoreWithQ:
[junit4] > 1) Thread[id=89, name=qtp531507010-89, state=TIMED_WAITING,
group=TGRP-TestUserTermScoreWithQ]
[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([DFE82B7B342E5B03]:0)Throwable #2:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
[junit4] > 1) Thread[id=89, name=qtp531507010-89, state=TIMED_WAITING,
group=TGRP-TestUserTermScoreWithQ]
[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([DFE82B7B342E5B03]:0)
[junit4] Completed [29/35 (1!)] on J0 in 56.88s, 1 test, 2 errors <<<
FAILURES!
[...truncated 40780 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]