Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-5.x/898/
1 tests failed. REGRESSION: org.apache.solr.TestDistributedSearch.test Error Message: Stack Trace: java.lang.NullPointerException at __randomizedtesting.SeedInfo.seed([D216D987AB6BA35D:5A42E65D0597CEA5]:0) at org.apache.solr.TestDistributedSearch.test(TestDistributedSearch.java:568) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:606) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:982) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:935) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845) at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747) at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at java.lang.Thread.run(Thread.java:745) Build Log: [...truncated 10515 lines...] [junit4] Suite: org.apache.solr.TestDistributedSearch [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/init-core-data-001 [junit4] 2> 1350158 INFO (SUITE-TestDistributedSearch-seed#[D216D987AB6BA35D]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) [junit4] 2> 1350158 INFO (SUITE-TestDistributedSearch-seed#[D216D987AB6BA35D]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /ocp/ [junit4] 2> 1350475 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/control/cores/collection1 [junit4] 2> 1350477 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.e.j.s.Server jetty-9.2.11.v20150529 [junit4] 2> 1350508 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@d10686{/ocp,null,AVAILABLE} [junit4] 2> 1350524 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.e.j.s.ServerConnector Started ServerConnector@7460fecd{HTTP/1.1}{127.0.0.1:48638} [junit4] 2> 1350524 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.e.j.s.Server Started @1353859ms [junit4] 2> 1350524 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/control/cores, hostPort=48638, hostContext=/ocp} [junit4] 2> 1350525 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@1fe91485 [junit4] 2> 1350525 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/control/' [junit4] 2> 1350552 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/control/solr.xml [junit4] 2> 1350591 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/control/cores [junit4] 2> 1350592 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.c.CoreContainer New CoreContainer 1612960516 [junit4] 2> 1350592 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/control/] [junit4] 2> 1350592 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.c.CoreContainer loading shared library: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/control/lib [junit4] 2> 1350592 WARN (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/control/lib). [junit4] 2> 1350604 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 1350605 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 1350606 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 1350606 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 1350606 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 1350608 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.c.CoresLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/control/cores [junit4] 2> 1350608 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.c.SolrCore Created CoreDescriptor: {config=solrconfig.xml, schema=schema.xml, name=collection1, absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/control/cores/collection1/, transient=false, configSet=collection1, instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/control/cores/collection1, loadOnStartup=true, dataDir=data/} [junit4] 2> 1350609 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.c.CoresLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/control/cores/collection1/ [junit4] 2> 1350609 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.c.CoresLocator Found 1 core definitions [junit4] 2> 1350619 INFO (coreLoadExecutor-2207-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/' [junit4] 2> 1350643 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0 [junit4] 2> 1350644 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 1350645 INFO (coreLoadExecutor-2207-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader [junit4] 2> 1350645 INFO (coreLoadExecutor-2207-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 1350645 INFO (coreLoadExecutor-2207-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 1350684 INFO (coreLoadExecutor-2207-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 1350716 INFO (coreLoadExecutor-2207-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.3.0 [junit4] 2> 1350778 INFO (coreLoadExecutor-2207-thread-1) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml [junit4] 2> 1350779 INFO (coreLoadExecutor-2207-thread-1) [ ] o.a.s.s.IndexSchema Reading Solr Schema from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/schema.xml [junit4] 2> 1350786 INFO (coreLoadExecutor-2207-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1351154 INFO (coreLoadExecutor-2207-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 1351165 INFO (coreLoadExecutor-2207-thread-1) [ ] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 1351168 INFO (coreLoadExecutor-2207-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 1351174 INFO (coreLoadExecutor-2207-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 1351177 INFO (coreLoadExecutor-2207-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 1351180 INFO (coreLoadExecutor-2207-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1351180 WARN (coreLoadExecutor-2207-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE [junit4] 2> 1351180 WARN (coreLoadExecutor-2207-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING [junit4] 2> 1351181 INFO (coreLoadExecutor-2207-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1351181 WARN (coreLoadExecutor-2207-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE [junit4] 2> 1351181 WARN (coreLoadExecutor-2207-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING [junit4] 2> 1351181 INFO (coreLoadExecutor-2207-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1 [junit4] 2> 1351181 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 1351181 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/], dataDir=[null] [junit4] 2> 1351182 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@470336d7 [junit4] 2> 1351182 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/control/cores/collection1/data [junit4] 2> 1351182 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/control/cores/collection1/data/index/ [junit4] 2> 1351182 WARN (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/control/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 1351183 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/control/cores/collection1/data/index [junit4] 2> 1351183 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=49, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=2.0556640625, noCFSRatio=0.0] [junit4] 2> 1351183 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@423dfdd4 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73e38b45),segFN=segments_1,generation=1} [junit4] 2> 1351184 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 1351188 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe" [junit4] 2> 1351189 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 1351189 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 1351189 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 1351189 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig" [junit4] 2> 1351189 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 1351189 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "uniq-fields" [junit4] 2> 1351189 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields" [junit4] 2> 1351190 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 1351190 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 1351190 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 1351190 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 1351193 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1351194 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1351195 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/control/cores/collection1/data/ [junit4] 2> 1351196 WARN (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.DirectoryFactory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/control/cores/collection1/data/ does not point to a valid data directory; skipping clean-up of old index directories. [junit4] 2> 1351208 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1351210 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1351214 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy [junit4] 2> 1351217 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: dismax,/config,/update/csv,spellCheckCompRH,/admin/segments,spellCheckCompRH_Direct,/search-facet-def,/admin/logging,spellCheckCompRH1,/admin/threads,lazy,/terms,mock,mltrh,/admin/ping,/admin/system,/mlt,/schema,/admin/mbeans,/admin/file,/update/json/docs,/get,spellCheckWithWordbreak_Direct,/admin/luke,tvrh,/debug/dump,/search-facet-invariants,/admin/properties,/update/json,/admin/plugins,standard,/update,spellCheckWithWordbreak,/replication,defaults [junit4] 2> 1351218 WARN (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.c.SolrCore solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler. [junit4] 2> 1351219 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 1351228 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 1351228 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 1351229 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled [junit4] 2> 1351229 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled [junit4] 2> 1351229 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=592211097, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1] [junit4] 2> 1351230 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@423dfdd4 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73e38b45),segFN=segments_1,generation=1} [junit4] 2> 1351230 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 1351230 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@115ec040[collection1] main [junit4] 2> 1351230 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO} [junit4] 2> 1351230 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage [junit4] 2> 1351231 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 1351231 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 1351254 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1351297 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 1351298 INFO (searcherExecutor-2208-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 1351298 INFO (searcherExecutor-2208-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 1351298 INFO (searcherExecutor-2208-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 1351298 INFO (searcherExecutor-2208-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 1351299 INFO (searcherExecutor-2208-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 1351299 INFO (searcherExecutor-2208-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 1351299 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets [junit4] 2> 1351299 INFO (searcherExecutor-2208-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 1351299 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version buckets from index [junit4] 2> 1351300 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket highest value from index [junit4] 2> 1351300 INFO (searcherExecutor-2208-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 1351300 INFO (searcherExecutor-2208-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 1351301 INFO (searcherExecutor-2208-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@115ec040[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1351300 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1506330010416316416 [junit4] 2> 1351313 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.u.UpdateLog Took 14 ms to seed version buckets with highest version 1506330010416316416 [junit4] 2> 1351314 INFO (coreLoadExecutor-2207-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 1352035 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/shard0/cores/collection1 [junit4] 2> 1352036 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.e.j.s.Server jetty-9.2.11.v20150529 [junit4] 2> 1352038 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@77d12a41{/ocp,null,AVAILABLE} [junit4] 2> 1352038 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.e.j.s.ServerConnector Started ServerConnector@452d4edb{HTTP/1.1}{127.0.0.1:41298} [junit4] 2> 1352038 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.e.j.s.Server Started @1355373ms [junit4] 2> 1352039 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/ocp, hostPort=41298, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/shard0/cores} [junit4] 2> 1352039 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@1fe91485 [junit4] 2> 1352039 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/shard0/' [junit4] 2> 1352055 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/shard0/solr.xml [junit4] 2> 1352069 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/shard0/cores [junit4] 2> 1352069 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.c.CoreContainer New CoreContainer 1369714050 [junit4] 2> 1352069 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/shard0/] [junit4] 2> 1352069 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.c.CoreContainer loading shared library: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/shard0/lib [junit4] 2> 1352070 WARN (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/shard0/lib). [junit4] 2> 1352078 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 1352079 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 1352079 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 1352080 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 1352080 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 1352080 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.c.CoresLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/shard0/cores [junit4] 2> 1352081 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.c.SolrCore Created CoreDescriptor: {absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/shard0/cores/collection1/, transient=false, instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/shard0/cores/collection1, name=collection1, dataDir=data/, configSet=collection1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml} [junit4] 2> 1352081 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.c.CoresLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/shard0/cores/collection1/ [junit4] 2> 1352081 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.c.CoresLocator Found 1 core definitions [junit4] 2> 1352082 INFO (coreLoadExecutor-2218-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/' [junit4] 2> 1352082 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0 [junit4] 2> 1352083 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 1352083 INFO (coreLoadExecutor-2218-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader [junit4] 2> 1352083 INFO (coreLoadExecutor-2218-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 1352084 INFO (coreLoadExecutor-2218-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 1352105 INFO (coreLoadExecutor-2218-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 1352184 INFO (coreLoadExecutor-2218-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.3.0 [junit4] 2> 1352268 INFO (coreLoadExecutor-2218-thread-1) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml [junit4] 2> 1352270 INFO (coreLoadExecutor-2218-thread-1) [ ] o.a.s.s.IndexSchema Reading Solr Schema from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/schema.xml [junit4] 2> 1352283 INFO (coreLoadExecutor-2218-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1352627 INFO (coreLoadExecutor-2218-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 1352635 INFO (coreLoadExecutor-2218-thread-1) [ ] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 1352636 INFO (coreLoadExecutor-2218-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 1352642 INFO (coreLoadExecutor-2218-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 1352645 INFO (coreLoadExecutor-2218-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 1352647 INFO (coreLoadExecutor-2218-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1352647 WARN (coreLoadExecutor-2218-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE [junit4] 2> 1352648 WARN (coreLoadExecutor-2218-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING [junit4] 2> 1352648 INFO (coreLoadExecutor-2218-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1352648 WARN (coreLoadExecutor-2218-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE [junit4] 2> 1352648 WARN (coreLoadExecutor-2218-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING [junit4] 2> 1352648 INFO (coreLoadExecutor-2218-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1 [junit4] 2> 1352648 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 1352649 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/], dataDir=[null] [junit4] 2> 1352649 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@470336d7 [junit4] 2> 1352649 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/shard0/cores/collection1/data [junit4] 2> 1352649 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/shard0/cores/collection1/data/index/ [junit4] 2> 1352650 WARN (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/shard0/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 1352650 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/shard0/cores/collection1/data/index [junit4] 2> 1352650 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=49, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=2.0556640625, noCFSRatio=0.0] [junit4] 2> 1352651 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@48e55ca2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4a24b511),segFN=segments_1,generation=1} [junit4] 2> 1352651 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 1352656 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe" [junit4] 2> 1352657 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 1352657 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 1352657 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 1352657 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig" [junit4] 2> 1352657 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 1352657 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "uniq-fields" [junit4] 2> 1352658 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields" [junit4] 2> 1352658 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 1352658 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 1352658 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 1352658 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 1352661 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1352662 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1352663 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/shard0/cores/collection1/data/ [junit4] 2> 1352664 WARN (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.DirectoryFactory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_D216D987AB6BA35D-001/tempDir-001/shard0/cores/collection1/data/ does not point to a valid data directory; skipping clean-up of old index directories. [junit4] 2> 1352665 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1352667 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1352672 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy [junit4] 2> 1352675 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: dismax,/config,/update/csv,spellCheckCompRH,/admin/segments,spellCheckCompRH_Direct,/search-facet-def,/admin/logging,spellCheckCompRH1,/admin/threads,lazy,/terms,mock,mltrh,/admin/ping,/admin/system,/mlt,/schema,/admin/mbeans,/admin/file,/update/json/docs,/get,spellCheckWithWordbreak_Direct,/admin/luke,tvrh,/debug/dump,/search-facet-invariants,/admin/properties,/update/json,/admin/plugins,standard,/update,spellCheckWithWordbreak,/replication,defaults [junit4] 2> 1352676 WARN (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.c.SolrCore solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler. [junit4] 2> 1352677 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 1352678 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 1352678 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 1352679 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled [junit4] 2> 1352679 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled [junit4] 2> 1352687 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=592211097, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1] [junit4] 2> 1352687 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@48e55ca2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4a24b511),segFN=segments_1,generation=1} [junit4] 2> 1352687 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 1352688 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@50e98a60[collection1] main [junit4] 2> 1352688 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO} [junit4] 2> 1352688 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage [junit4] 2> 1352688 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 1352688 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 1352709 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1352740 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 1352741 INFO (searcherExecutor-2219-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 1352741 INFO (searcherExecutor-2219-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 1352741 INFO (searcherExecutor-2219-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 1352741 INFO (searcherExecutor-2219-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 1352742 INFO (searcherExecutor-2219-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 1352742 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets [junit4] 2> 1352742 INFO (searcherExecutor-2219-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 1352742 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version buckets from index [junit4] 2> 1352742 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket highest value from index [junit4] 2> 1352742 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1506330011928363008 [junit4] 2> 1352742 INFO (searcherExecutor-2219-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 1352743 INFO (searcherExecutor-2219-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 1352743 INFO (searcherExecutor-2219-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 1352744 INFO (searcherExecutor-2219-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@50e98a60[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1352744 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.u.UpdateLog Took 2 ms to seed version buckets with highest version 1506330011928363008 [junit4] 2> 1352745 INFO (coreLoadExecutor-2218-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 1353084 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test [junit4] 2> 1353102 INFO (qtp241294005-3909) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1506330012304801792)} 0 1 [junit4] 2> 1353121 INFO (qtp1736485992-3928) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1506330012324724736)} 0 1 [junit4] 2> 1353127 INFO (qtp241294005-3910) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[1 (1506330012328919040)]} 0 2 [junit4] 2> 1353132 INFO (qtp1736485992-3926) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[1 (1506330012334161920)]} 0 2 [junit4] 2> 1353135 INFO (qtp241294005-3911) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[2 (1506330012339404800)]} 0 1 [junit4] 2> 1353138 INFO (qtp1736485992-3930) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[2 (1506330012342550528)]} 0 0 [junit4] 2> 1353146 INFO (qtp241294005-3912) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[3 (1506330012350939136)]} 0 1 [junit4] 2> 1353149 INFO (qtp1736485992-3929) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[3 (1506330012354084864)]} 0 1 [junit4] 2> 1353152 INFO (qtp241294005-3913) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[4 (1506330012357230592)]} 0 1 [junit4] 2> 1353156 INFO (qtp1736485992-3934) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[4 (1506330012361424896)]} 0 1 [junit4] 2> 1353159 INFO (qtp241294005-3909) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[5 (1506330012364570624)]} 0 1 [junit4] 2> 1353162 INFO (qtp1736485992-3935) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[5 (1506330012367716352)]} 0 0 [junit4] 2> 1353164 INFO (qtp241294005-3910) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[6 (1506330012370862080)]} 0 0 [junit4] 2> 1353167 INFO (qtp1736485992-3936) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[6 (1506330012372959232)]} 0 1 [junit4] 2> 1353170 INFO (qtp241294005-3911) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[7 (1506330012376104960)]} 0 0 [junit4] 2> 1353173 INFO (qtp1736485992-3937) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[7 (1506330012379250688)]} 0 1 [junit4] 2> 1353175 INFO (qtp241294005-3912) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[8 (1506330012382396416)]} 0 0 [junit4] 2> 1353178 INFO (qtp1736485992-3928) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[8 (1506330012384493568)]} 0 0 [junit4] 2> 1353180 INFO (qtp241294005-3913) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[9 (1506330012387639296)]} 0 0 [junit4] 2> 1353183 INFO (qtp1736485992-3926) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[9 (1506330012389736448)]} 0 0 [junit4] 2> 1353185 INFO (qtp241294005-3909) [ x:collection1] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1353217 INFO (qtp241294005-3909) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@423dfdd4 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73e38b45),segFN=segments_1,generation=1} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@423dfdd4 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73e38b45),segFN=segments_2,generation=2} [junit4] 2> 1353218 INFO (qtp241294005-3909) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 2 [junit4] 2> 1353221 INFO (qtp241294005-3909) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@2225fce7[collection1] main [junit4] 2> 1353222 INFO (qtp241294005-3909) [ x:collection1] o.a.s.u.UpdateHandler end_commit_flush [junit4] 2> 1353224 INFO (searcherExecutor-2208-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2225fce7[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C9)))} [junit4] 2> 1353224 INFO (qtp241294005-3909) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&softCommit=false&waitSearcher=true&commit=true&wt=javabin} {commit=} 0 39 [junit4] 2> 1353226 INFO (qtp1736485992-3930) [ x:collection1] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1353270 INFO (qtp1736485992-3930) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@48e55ca2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4a24b511),segFN=segments_1,generation=1} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@48e55ca2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4a24b511),segFN=segments_2,generation=2} [junit4] 2> 1353270 INFO (qtp1736485992-3930) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 2 [junit4] 2> 1353273 INFO (qtp1736485992-3930) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@67d199cb[collection1] main [junit4] 2> 1353274 INFO (searcherExecutor-2219-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@67d199cb[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C9)))} [junit4] 2> 1353275 INFO (qtp1736485992-3930) [ x:collection1] o.a.s.u.UpdateHandler end_commit_flush [junit4] 2> 1353275 INFO (qtp1736485992-3930) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&softCommit=false&waitSearcher=true&commit=true&wt=javabin} {commit=} 0 48 [junit4] 2> 1353279 INFO (qtp241294005-3910) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[10 (1506330012489351168)]} 0 1 [junit4] 2> 1353283 INFO (qtp1736485992-3929) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[10 (1506330012493545472)]} 0 2 [junit4] 2> 1353286 INFO (qtp241294005-3911) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[11 (1506330012497739776)]} 0 1 [junit4] 2> 1353289 INFO (qtp1736485992-3934) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[11 (1506330012500885504)]} 0 0 [junit4] 2> 1353291 INFO (qtp241294005-3912) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[12 (1506330012504031232)]} 0 0 [junit4] 2> 1353294 INFO (qtp1736485992-3935) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[12 (1506330012506128384)]} 0 0 [junit4] 2> 1353296 INFO (qtp241294005-3913) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[13 (1506330012509274112)]} 0 0 [junit4] 2> 1353298 INFO (qtp1736485992-3936) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[13 (1506330012511371264)]} 0 0 [junit4] 2> 1353301 INFO (qtp241294005-3909) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[1001 (1506330012513468416)]} 0 0 [junit4] 2> 1353304 INFO (qtp1736485992-3937) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[1001 (1506330012516614144)]} 0 0 [junit4] 2> 1353306 INFO (qtp241294005-3910) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[14 (1506330012518711296)]} 0 0 [junit4] 2> 1353308 INFO (qtp1736485992-3928) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[14 (1506330012521857024)]} 0 0 [junit4] 2> 1353311 INFO (qtp241294005-3911) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[15 (1506330012523954176)]} 0 0 [junit4] 2> 1353313 INFO (qtp1736485992-3926) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[15 (1506330012527099904)]} 0 0 [junit4] 2> 1353316 INFO (qtp241294005-3912) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[16 (1506330012530245632)]} 0 0 [junit4] 2> 1353319 INFO (qtp1736485992-3930) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[16 (1506330012532342784)]} 0 0 [junit4] 2> 1353322 INFO (qtp241294005-3913) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[17 (1506330012535488512)]} 0 0 [junit4] 2> 1353324 INFO (qtp1736485992-3929) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[17 (1506330012538634240)]} 0 0 [junit4] 2> 1353326 INFO (qtp241294005-3909) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[100 (1506330012540731392)]} 0 0 [junit4] 2> 1353330 INFO (qtp1736485992-3934) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[100 (1506330012544925696)]} 0 0 [junit4] 2> 1353333 INFO (qtp241294005-3910) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[101 (1506330012547022848)]} 0 0 [junit4] 2> 1353335 INFO (qtp1736485992-3935) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[101 (1506330012550168576)]} 0 0 [junit4] 2> 1353337 INFO (qtp241294005-3911) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[102 (1506330012552265728)]} 0 0 [junit4] 2> 1353339 INFO (qtp1736485992-3936) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[102 (1506330012554362880)]} 0 0 [junit4] 2> 1353342 INFO (qtp241294005-3912) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[103 (1506330012556460032)]} 0 0 [junit4] 2> 1353344 INFO (qtp1736485992-3937) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[103 (1506330012558557184)]} 0 0 [junit4] 2> 1353346 INFO (qtp241294005-3913) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[104 (1506330012561702912)]} 0 0 [junit4] 2> 1353348 INFO (qtp1736485992-3928) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[104 (1506330012563800064)]} 0 0 [junit4] 2> 1353351 INFO (qtp241294005-3909) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[105 (1506330012565897216)]} 0 0 [junit4] 2> 1353353 INFO (qtp1736485992-3926) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[105 (1506330012567994368)]} 0 0 [junit4] 2> 1353355 INFO (qtp241294005-3910) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[106 (1506330012571140096)]} 0 0 [junit4] 2> 1353357 INFO (qtp1736485992-3930) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[106 (1506330012573237248)]} 0 0 [junit4] 2> 1353359 INFO (qtp241294005-3911) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[107 (1506330012575334400)]} 0 0 [junit4] 2> 1353362 INFO (qtp1736485992-3929) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[107 (1506330012577431552)]} 0 0 [junit4] 2> 1353364 INFO (qtp241294005-3912) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[108 (1506330012580577280)]} 0 0 [junit4] 2> 1353366 INFO (qtp1736485992-3934) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[108 (1506330012582674432)]} 0 0 [junit4] 2> 1353369 INFO (qtp241294005-3913) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[109 (1506330012584771584)]} 0 0 [junit4] 2> 1353371 INFO (qtp1736485992-3935) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[109 (1506330012586868736)]} 0 0 [junit4] 2> 1353373 INFO (qtp241294005-3909) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[110 (1506330012590014464)]} 0 0 [junit4] 2> 1353375 INFO (qtp1736485992-3936) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[110 (1506330012592111616)]} 0 0 [junit4] 2> 1353377 INFO (qtp241294005-3910) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[111 (1506330012594208768)]} 0 0 [junit4] 2> 1353380 INFO (qtp1736485992-3937) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[111 (1506330012596305920)]} 0 0 [junit4] 2> 1353382 INFO (qtp241294005-3911) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[112 (1506330012598403072)]} 0 0 [junit4] 2> 1353384 INFO (qtp1736485992-3928) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[112 (1506330012601548800)]} 0 0 [junit4] 2> 1353386 INFO (qtp241294005-3912) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[113 (1506330012603645952)]} 0 0 [junit4] 2> 1353389 INFO (qtp1736485992-3926) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[113 (1506330012605743104)]} 0 0 [junit4] 2> 1353391 INFO (qtp241294005-3913) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[114 (1506330012607840256)]} 0 0 [junit4] 2> 1353393 INFO (qtp1736485992-3930) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[114 (1506330012609937408)]} 0 0 [junit4] 2> 1353395 INFO (qtp241294005-3909) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[115 (1506330012613083136)]} 0 0 [junit4] 2> 1353397 INFO (qtp1736485992-3929) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[115 (1506330012615180288)]} 0 0 [junit4] 2> 1353399 INFO (qtp241294005-3910) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[116 (1506330012617277440)]} 0 0 [junit4] 2> 1353402 INFO (qtp1736485992-3934) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[116 (1506330012619374592)]} 0 0 [junit4] 2> 1353404 INFO (qtp241294005-3911) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[117 (1506330012621471744)]} 0 0 [junit4] 2> 1353410 INFO (qtp1736485992-3935) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[117 (1506330012627763200)]} 0 0 [junit4] 2> 1353412 INFO (qtp241294005-3912) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[118 (1506330012630908928)]} 0 0 [junit4] 2> 1353416 INFO (qtp1736485992-3936) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[118 (1506330012635103232)]} 0 0 [junit4] 2> 1353430 INFO (qtp241294005-3913) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[119 (1506330012648734720)]} 0 0 [junit4] 2> 1353433 INFO (qtp1736485992-3937) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[119 (1506330012651880448)]} 0 0 [junit4] 2> 1353436 INFO (qtp241294005-3909) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[120 (1506330012656074752)]} 0 0 [junit4] 2> 1353439 INFO (qtp1736485992-3928) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[120 (1506330012659220480)]} 0 0 [junit4] 2> 1353442 INFO (qtp241294005-3910) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[121 (1506330012661317632)]} 0 0 [junit4] 2> 1353445 INFO (qtp1736485992-3926) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[121 (1506330012664463360)]} 0 0 [junit4] 2> 1353447 INFO (qtp241294005-3911) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[122 (1506330012667609088)]} 0 0 [junit4] 2> 1353450 INFO (qtp1736485992-3930) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[122 (1506330012669706240)]} 0 0 [junit4] 2> 1353452 INFO (qtp241294005-3912) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[123 (1506330012672851968)]} 0 0 [junit4] 2> 1353455 INFO (qtp1736485992-3929) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[123 (1506330012675997696)]} 0 0 [junit4] 2> 1353458 INFO (qtp241294005-3913) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[124 (1506330012678094848)]} 0 0 [junit4] 2> 1353461 INFO (qtp1736485992-3934) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[124 (1506330012681240576)]} 0 0 [junit4] 2> 1353464 INFO (qtp241294005-3909) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[125 (1506330012684386304)]} 0 1 [junit4] 2> 1353467 INFO (qtp1736485992-3935) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[125 (1506330012687532032)]} 0 0 [junit4] 2> 1353469 INFO (qtp241294005-3910) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[126 (1506330012690677760)]} 0 0 [junit4] 2> 1353471 INFO (qtp1736485992-3936) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[126 (1506330012692774912)]} 0 0 [junit4] 2> 1353474 INFO (qtp241294005-3911) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[127 (1506330012695920640)]} 0 0 [junit4] 2> 1353477 INFO (qtp1736485992-3937) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[127 (1506330012699066368)]} 0 0 [junit4] 2> 1353480 INFO (qtp241294005-3912) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[128 (1506330012702212096)]} 0 0 [junit4] 2> 1353483 INFO (qtp1736485992-3928) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[128 (1506330012704309248)]} 0 0 [junit4] 2> 1353486 INFO (qtp241294005-3913) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[129 (1506330012707454976)]} 0 0 [junit4] 2> 1353488 INFO (qtp1736485992-3926) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[129 (1506330012710600704)]} 0 0 [junit4] 2> 1353491 INFO (qtp241294005-3909) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[130 (1506330012712697856)]} 0 0 [junit4] 2> 1353493 INFO (qtp1736485992-3930) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[130 (1506330012715843584)]} 0 0 [junit4] 2> 1353496 INFO (qtp241294005-3910) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[131 (1506330012717940736)]} 0 0 [junit4] 2> 1353498 INFO (qtp1736485992-3929) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[131 (1506330012720037888)]} 0 0 [junit4] 2> 1353501 INFO (qtp241294005-3911) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[132 (1506330012723183616)]} 0 0 [junit4] 2> 1353503 INFO (qtp1736485992-3934) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[132 (1506330012726329344)]} 0 0 [junit4] 2> 1353506 INFO (qtp241294005-3912) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[133 (1506330012728426496)]} 0 0 [junit4] 2> 1353508 INFO (qtp1736485992-3935) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[133 (1506330012731572224)]} 0 0 [junit4] 2> 1353511 INFO (qtp241294005-3913) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[134 (1506330012733669376)]} 0 0 [junit4] 2> 1353513 INFO (qtp1736485992-3936) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[134 (1506330012736815104)]} 0 0 [junit4] 2> 1353516 INFO (qtp241294005-3909) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[135 (1506330012739960832)]} 0 0 [junit4] 2> 1353519 INFO (qtp1736485992-3937) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[135 (1506330012742057984)]} 0 0 [junit4] 2> 1353521 INFO (qtp241294005-3910) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[136 (1506330012745203712)]} 0 0 [junit4] 2> 1353524 INFO (qtp1736485992-3928) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[136 (1506330012747300864)]} 0 0 [junit4] 2> 1353527 INFO (qtp241294005-3911) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[137 (1506330012750446592)]} 0 0 [junit4] 2> 1353529 INFO (qtp1736485992-3926) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[137 (1506330012753592320)]} 0 0 [junit4] 2> 1353532 INFO (qtp241294005-3912) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[138 (1506330012755689472)]} 0 0 [junit4] 2> 1353535 INFO (qtp1736485992-3930) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[138 (1506330012758835200)]} 0 0 [junit4] 2> 1353538 INFO (qtp241294005-3913) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[139 (1506330012761980928)]} 0 0 [junit4] 2> 1353541 INFO (qtp1736485992-3929) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[139 (1506330012765126656)]} 0 0 [junit4] 2> 1353544 INFO (qtp241294005-3909) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[140 (1506330012768272384)]} 0 0 [junit4] 2> 1353547 INFO (qtp1736485992-3934) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[140 (1506330012771418112)]} 0 0 [junit4] 2> 1353550 INFO (qtp241294005-3910) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[141 (1506330012775612416)]} 0 0 [junit4] 2> 1353553 INFO (qtp1736485992-3935) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[141 (1506330012777709568)]} 0 0 [junit4] 2> 1353556 INFO (qtp241294005-3911) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[142 (1506330012780855296)]} 0 0 [junit4] 2> 1353559 INFO (qtp1736485992-3936) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[142 (1506330012784001024)]} 0 0 [junit4] 2> 1353562 INFO (qtp241294005-3912) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[143 (1506330012787146752)]} 0 0 [junit4] 2> 1353564 INFO (qtp1736485992-3937) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[143 (1506330012790292480)]} 0 0 [junit4] 2> 1353567 INFO (qtp241294005-3913) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[144 (1506330012793438208)]} 0 0 [junit4] 2> 1353570 INFO (qtp1736485992-3928) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[144 (1506330012795535360)]} 0 0 [junit4] 2> 1353573 INFO (qtp241294005-3909) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[145 (1506330012798681088)]} 0 0 [junit4] 2> 1353575 INFO (qtp1736485992-3926) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[145 (1506330012801826816)]} 0 0 [junit4] 2> 1353578 INFO (qtp241294005-3910) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[146 (1506330012804972544)]} 0 0 [junit4] 2> 1353580 INFO (qtp1736485992-3930) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[146 (1506330012807069696)]} 0 0 [junit4] 2> 1353583 INFO (qtp241294005-3911) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[147 (1506330012809166848)]} 0 0 [junit4] 2> 1353586 INFO (qtp1736485992-3929) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[147 (1506330012812312576)]} 0 0 [junit4] 2> 1353589 INFO (qtp241294005-3912) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[148 (1506330012815458304)]} 0 0 [junit4] 2> 1353591 INFO (qtp1736485992-3934) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[148 (1506330012818604032)]} 0 0 [junit4] 2> 1353594 INFO (qtp241294005-3913) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[149 (1506330012821749760)]} 0 0 [junit4] 2> 1353597 INFO (qtp1736485992-3935) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&wt=javabin} {add=[149 (1506330012823846912)]} 0 0 [junit4] 2> 1353599 INFO (qtp241294005-3909) [ x:collection1] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1353707 INFO (qtp241294005-3909) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@423dfdd4 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73e38b45),segFN=segments_2,generation=2} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@423dfdd4 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73e38b45),segFN=segments_3,generation=3} [junit4] 2> 1353707 INFO (qtp241294005-3909) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 3 [junit4] 2> 1353708 INFO (qtp241294005-3909) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@279a56eb[collection1] main [junit4] 2> 1353708 INFO (qtp241294005-3909) [ x:collection1] o.a.s.u.UpdateHandler end_commit_flush [junit4] 2> 1353710 INFO (searcherExecutor-2208-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@279a56eb[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C9) Uninverting(_1(5.3.0):C59)))} [junit4] 2> 1353710 INFO (qtp241294005-3909) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&softCommit=false&waitSearcher=true&commit=true&wt=javabin} {commit=} 0 111 [junit4] 2> 1353712 INFO (qtp1736485992-3936) [ x:collection1] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1353757 INFO (qtp1736485992-3936) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@48e55ca2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4a24b511),segFN=segments_2,generation=2} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@48e55ca2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4a24b511),segFN=segments_3,generation=3} [junit4] 2> 1353757 INFO (qtp1736485992-3936) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 3 [junit4] 2> 1353758 INFO (qtp1736485992-3936) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@3b2b9e40[collection1] main [junit4] 2> 1353758 INFO (qtp1736485992-3936) [ x:collection1] o.a.s.u.UpdateHandler end_commit_flush [junit4] 2> 1353759 INFO (searcherExecutor-2219-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3b2b9e40[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C9) Uninverting(_1(5.3.0):C59)))} [junit4] 2> 1353760 INFO (qtp1736485992-3936) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/ocp path=/update params={version=2&softCommit=false&waitSearcher=true&commit=true&wt=javabin} {commit=} 0 47 [junit4] 2> 1353763 INFO (qtp241294005-3910) [ x:collection1] o.a.s.c.SolrCore Ignoring exception matching parameter cannot be negative [junit4] 2> 1353763 INFO (qtp241294005-3910) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/ocp path=/select params={start=-1&distrib=false&version=2&wt=javabin&q=*} status=400 QTime=1 [junit4] 2> 1353765 INFO (qtp241294005-3911) [ x:collection1] o.a.s.c.SolrCore Ignoring exception matching parameter cannot be negative [junit4] 2> 1353766 INFO (qtp241294005-3911) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/ocp path=/select params={start=0&distrib=false&version=2&rows=-1&wt=javabin&q=*} status=400 QTime=0 [junit4] 2> 1353768 INFO (qtp241294005-3912) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/ocp path=/select params={distrib=false&version=2&wt=javabin&q=*:*&sort=n_ti1+desc} hits=68 status=0 QTime=0 [junit4] 2> 1354060 INFO (qtp1736485992-3928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/ocp path=/select params={isShard=true&fl=id&NOW=1436548245438&start=0&distrib=false&fsv=true&version=2&rows=10&wt=javabin&q=*:*&shards.purpose=4&shard.url=[ff01::114]:33332/ocp|[ff01::213]:33332/ocp|http://127.0.0.1:41298/ocp/collection1&sort=n_ti1+desc} hits=68 status=0 QTime=1 [junit4] 2> 1354065 INFO (qtp1736485992-3926) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/ocp path=/select params={isShard=true&NOW=1436548245438&ids=7,148,103,140,138,136,111,119,2,139&distrib=false&version=2&wt=javabin&q=*:*&shards.purpose=64&shard.url=[ff01::114]:33332/ocp|[ff01::213]:33332/ocp|http://127.0.0.1:41298/ocp/collection1} status=0 QTime=0 [junit4] 2> 1354067 INFO (qtp1736485992-3937) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/ocp path=/select params={shards=[ff01::114]:33332/ocp|[ff01::213]:33332/ocp|http://127.0.0.1:41298/ocp/collection1&version=2&wt=javabin&q=*:*&sort=n_ti1+desc} hits=68 status=0 QTime=295 [junit4] 2> 1354068 INFO (TEST-TestDistributedSearch.test-seed#[D216D987AB6BA35D]) [ ] o.a.s.BaseDistributedSearchTestCase starting stress... [junit4] 2> 1354140 INFO (qtp1736485992-3935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/ocp path=/select params={isShard=true&fl=id&NOW=1436548245804&start=0&distrib=false&fsv=true&version=2&rows=10&wt=javabin&q=*:*&shards.purpose=4&shard.url=[ff01::114]:33332/ocp|[ff01::213]:33332/ocp|http://127.0.0.1:41298/ocp/collection1&sort=n_ti1+desc} hits=68 status=0 QTime=0 [junit4] 2> 1354143 INFO (qtp1736485992-3936) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/ocp path=/select params={isShard=true&NOW=1436548245804&ids=7,148,103,140,138,136,111,119,2,139&distrib=false&version=2&wt=javabin&q=*:*&shards.purpose=64 [...truncated too long message...] ightlyTests-5.x/solr/core/test-lib/apacheds-interceptors-changelog-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/apacheds-interceptors-collective-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/apacheds-interceptors-event-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/apacheds-interceptors-exception-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/apacheds-interceptors-journal-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/apacheds-interceptors-normalization-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/apacheds-interceptors-operational-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/apacheds-interceptors-referral-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/apacheds-interceptors-schema-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/apacheds-interceptors-subtree-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/apacheds-interceptors-trigger-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/apacheds-jdbm-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/apacheds-jdbm1-2.0.0-M2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/apacheds-kerberos-codec-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/apacheds-ldif-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/apacheds-mavibot-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/apacheds-protocol-kerberos-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/apacheds-protocol-ldap-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/apacheds-protocol-shared-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/apacheds-xdbm-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/api-all-1.0.0-M20.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/bcprov-jdk15-1.45.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/cglib-nodep-2.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/commons-collections-3.2.1.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/commons-math3-3.4.1.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/easymock-3.0.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/ehcache-core-2.4.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/hadoop-common-2.6.0-tests.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/hadoop-hdfs-2.6.0-tests.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/hadoop-minikdc-2.6.0.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/jackson-annotations-2.5.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/jackson-databind-2.5.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/jcl-over-slf4j-1.7.7.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/jersey-core-1.9.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/jersey-server-1.9.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/jetty-6.1.26.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/jetty-util-6.1.26.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/mina-core-2.0.0-M5.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/test-lib/objenesis-1.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/lucene/build/analysis/icu/lucene-analyzers-icu-5.3.0-SNAPSHOT.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/contrib/solr-analysis-extras/classes/java:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/contrib/analysis-extras/lib/icu4j-54.1.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-launcher.jar:/x1/jenkins/.ant/lib/ivy-2.3.0.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-antlr.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-regexp.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-resolver.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-commons-net.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jmf.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-oro.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-xalan2.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-commons-logging.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jsch.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-junit4.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-javamail.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jai.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jdepend.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-junit.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-bsf.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-swing.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-netrexx.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-bcel.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-testutil.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-log4j.jar:/x1/jenkins/jenkins-slave/tools/hudson.model.JDK/latest1.7/lib/tools.jar:/x1/jenkins/.ivy2/cache/com.carrotsearch.randomizedtesting/junit4-ant/jars/junit4-ant-2.1.13.jar com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe -eventsfile /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/temp/junit4-J1-20150710_124808_200.events @/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/temp/junit4-J1-20150710_124808_200.suites [junit4] ERROR: JVM J1 ended with an exception: Quit event not received from the forked process? This may indicate JVM crash or runner bugs. [junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4.executeSlave(JUnit4.java:1504) [junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4.access$000(JUnit4.java:133) [junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4$2.call(JUnit4.java:964) [junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4$2.call(JUnit4.java:961) [junit4] at java.util.concurrent.FutureTask.run(FutureTask.java:262) [junit4] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) [junit4] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [junit4] at java.lang.Thread.run(Thread.java:745) BUILD FAILED /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/build.xml:543: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/build.xml:484: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/build.xml:61: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/extra-targets.xml:39: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build.xml:230: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/common-build.xml:512: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/lucene/common-build.xml:1444: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/lucene/common-build.xml:999: At least one slave process threw an exception, first: Quit event not received from the forked process? This may indicate JVM crash or runner bugs. Total time: 298 minutes 6 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts Sending artifact delta relative to Lucene-Solr-NightlyTests-5.x #874 Archived 5 artifacts Archive block size is 32768 Received 0 blocks and 1285439655 bytes Compression is 0.0% Took 3 min 56 sec Recording test results Email was triggered for: Failure Sending email for trigger: Failure
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org