I'll investigate. I added this test in SOLR-7493 On Fri, Jul 10, 2015 at 1:17 PM, Policeman Jenkins Server <[email protected]> wrote: > Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Windows/4889/ > Java: 64bit/jdk1.8.0_45 -XX:-UseCompressedOops -XX:+UseParallelGC > > 1 tests failed. > FAILED: > org.apache.solr.cloud.TestRandomRequestDistribution.testRequestTracking > > Error Message: > Shard a1x2_shard1_replica1 received all 10 requests > > Stack Trace: > java.lang.AssertionError: Shard a1x2_shard1_replica1 received all 10 requests > at > __randomizedtesting.SeedInfo.seed([F719E8B96F0F4665:BF25B1799B0457F3]:0) > at org.junit.Assert.fail(Assert.java:93) > at org.junit.Assert.assertTrue(Assert.java:43) > at > org.apache.solr.cloud.TestRandomRequestDistribution.testRequestTracking(TestRandomRequestDistribution.java:109) > at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) > at > sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) > at > sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) > at java.lang.reflect.Method.invoke(Method.java:497) > 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$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:960) > 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 11177 lines...] > [junit4] Suite: org.apache.solr.cloud.TestRandomRequestDistribution > [junit4] 2> Creating dataDir: > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\init-core-data-001 > [junit4] 2> 2097969 INFO > (SUITE-TestRandomRequestDistribution-seed#[F719E8B96F0F4665]-worker) [ ] > o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: / > [junit4] 2> 2097972 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER > [junit4] 2> 2097972 INFO (Thread-5069) [ ] o.a.s.c.ZkTestServer > client port:0.0.0.0/0.0.0.0:0 > [junit4] 2> 2097972 INFO (Thread-5069) [ ] o.a.s.c.ZkTestServer > Starting server > [junit4] 2> 2098068 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.ZkTestServer start zk server on port:51827 > [junit4] 2> 2098086 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.AbstractZkTestCase put > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig-tlog.xml > to /configs/conf1/solrconfig.xml > [junit4] 2> 2098090 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.AbstractZkTestCase put > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\schema.xml > to /configs/conf1/schema.xml > [junit4] 2> 2098093 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.AbstractZkTestCase put > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig.snippet.randomindexconfig.xml > to /configs/conf1/solrconfig.snippet.randomindexconfig.xml > [junit4] 2> 2098095 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.AbstractZkTestCase put > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\stopwords.txt > to /configs/conf1/stopwords.txt > [junit4] 2> 2098097 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.AbstractZkTestCase put > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\protwords.txt > to /configs/conf1/protwords.txt > [junit4] 2> 2098099 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.AbstractZkTestCase put > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\currency.xml > to /configs/conf1/currency.xml > [junit4] 2> 2098101 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.AbstractZkTestCase put > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\enumsConfig.xml > to /configs/conf1/enumsConfig.xml > [junit4] 2> 2098104 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.AbstractZkTestCase put > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\open-exchange-rates.json > to /configs/conf1/open-exchange-rates.json > [junit4] 2> 2098106 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.AbstractZkTestCase put > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\mapping-ISOLatin1Accent.txt > to /configs/conf1/mapping-ISOLatin1Accent.txt > [junit4] 2> 2098109 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.AbstractZkTestCase put > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\old_synonyms.txt > to /configs/conf1/old_synonyms.txt > [junit4] 2> 2098111 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.AbstractZkTestCase put > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\synonyms.txt > to /configs/conf1/synonyms.txt > [junit4] 2> 2098389 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\control-001\cores\collection1 > [junit4] 2> 2098393 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.e.j.s.Server jetty-9.2.11.v20150529 > [junit4] 2> 2098395 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.e.j.s.h.ContextHandler Started > o.e.j.s.ServletContextHandler@5392ecdd{/,null,AVAILABLE} > [junit4] 2> 2098396 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.e.j.s.ServerConnector Started > ServerConnector@67a60148{HTTP/1.1}{127.0.0.1:51834} > [junit4] 2> 2098397 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.e.j.s.Server Started @2102128ms > [junit4] 2> 2098397 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: > {solr.data.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\tempDir-001/control/data, > hostContext=/, hostPort=51834, > coreRootDirectory=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\control-001\cores} > [junit4] 2> 2098397 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): > sun.misc.Launcher$AppClassLoader@4e0e2f2a > [junit4] 2> 2098397 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: > 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\control-001\' > [junit4] 2> 2098422 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.SolrXmlConfig Loading container configuration from > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\control-001\solr.xml > [junit4] 2> 2098428 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.CoresLocator Config-defined core root directory: > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\control-001\cores > [junit4] 2> 2098429 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.CoreContainer New CoreContainer 1357057658 > [junit4] 2> 2098429 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer > [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\control-001\] > [junit4] 2> 2098429 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.CoreContainer loading shared library: > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\control-001\lib > [junit4] 2> 2098429 WARN > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to > classloader: lib (resolved as: > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\control-001\lib). > [junit4] 2> 2098438 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] 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> 2098442 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client > with params: socketTimeout=340000&connTimeout=45000&retry=true > [junit4] 2> 2098442 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory > [junit4] 2> 2098442 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j > (org.slf4j.impl.Log4jLoggerFactory)] > [junit4] 2> 2098442 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51827/solr > [junit4] 2> 2098442 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.ZkController zkHost includes chroot > [junit4] 2> 2098465 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [n:127.0.0.1:51834_ ] o.a.s.c.ZkController Register node as live in > ZooKeeper:/live_nodes/127.0.0.1:51834_ > [junit4] 2> 2098471 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [n:127.0.0.1:51834_ ] o.a.s.c.Overseer Overseer (id=null) closing > [junit4] 2> 2098471 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [n:127.0.0.1:51834_ ] o.a.s.c.LeaderElector Joined leadership election > with path: > /overseer_elect/election/94143379560595459-127.0.0.1:51834_-n_0000000000 > [junit4] 2> 2098472 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [n:127.0.0.1:51834_ ] o.a.s.c.OverseerElectionContext I am going to be > the leader 127.0.0.1:51834_ > [junit4] 2> 2098474 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [n:127.0.0.1:51834_ ] o.a.s.c.Overseer Overseer > (id=94143379560595459-127.0.0.1:51834_-n_0000000000) starting > [junit4] 2> 2098482 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [n:127.0.0.1:51834_ ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting > OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 > autoReplicaFailoverWaitAfterExpiration=30000 > autoReplicaFailoverBadNodeExpiration=60000 > [junit4] 2> 2098483 INFO > (OverseerCollectionProcessor-94143379560595459-127.0.0.1:51834_-n_0000000000) > [n:127.0.0.1:51834_ ] o.a.s.c.OverseerCollectionProcessor Process current > queue of collection creations > [junit4] 2> 2098483 INFO > (OverseerStateUpdate-94143379560595459-127.0.0.1:51834_-n_0000000000) > [n:127.0.0.1:51834_ ] o.a.s.c.Overseer Starting to work on the main queue > [junit4] 2> 2098486 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [n:127.0.0.1:51834_ ] o.a.s.c.CoreContainer No authentication plugin used. > [junit4] 2> 2098486 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [n:127.0.0.1:51834_ ] o.a.s.c.CoreContainer Security conf doesn't exist. > Skipping setup for authorization module. > [junit4] 2> 2098488 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [n:127.0.0.1:51834_ ] o.a.s.c.CoresLocator Looking for core definitions > underneath > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\control-001\cores > [junit4] 2> 2098490 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [n:127.0.0.1:51834_ ] o.a.s.c.SolrCore Created CoreDescriptor: > {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, > loadOnStartup=true, > instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\control-001\cores\collection1, > collection=control_collection, > absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\control-001\cores\collection1\, > coreNodeName=, dataDir=data\, shard=} > [junit4] 2> 2098490 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [n:127.0.0.1:51834_ ] o.a.s.c.CoresLocator Found core collection1 in > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\control-001\cores\collection1\ > [junit4] 2> 2098490 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [n:127.0.0.1:51834_ ] o.a.s.c.CoresLocator Found 1 core definitions > [junit4] 2> 2098491 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection x:collection1] > o.a.s.c.ZkController publishing state=down > [junit4] 2> 2098491 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection x:collection1] > o.a.s.c.ZkController numShards not found on descriptor - reading it from > system property > [junit4] 2> 2098491 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [n:127.0.0.1:51834_ ] o.a.s.s.SolrDispatchFilter > user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0 > [junit4] 2> 2098491 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [n:127.0.0.1:51834_ ] o.a.s.s.SolrDispatchFilter > SolrDispatchFilter.init() done > [junit4] 2> 2098491 INFO > (zkCallback-1827-thread-1-processing-n:127.0.0.1:51834_) [n:127.0.0.1:51834_ > ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path > /overseer/queue state SyncConnected > [junit4] 2> 2098492 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection x:collection1] > o.a.s.c.ZkController look for our core node name > [junit4] 2> 2098492 INFO > (OverseerStateUpdate-94143379560595459-127.0.0.1:51834_-n_0000000000) > [n:127.0.0.1:51834_ ] o.a.s.c.Overseer processMessage: queueSize: 1, > message = { > [junit4] 2> "core":"collection1", > [junit4] 2> "roles":null, > [junit4] 2> "base_url":"http://127.0.0.1:51834";, > [junit4] 2> "node_name":"127.0.0.1:51834_", > [junit4] 2> "numShards":"1", > [junit4] 2> "state":"down", > [junit4] 2> "shard":null, > [junit4] 2> "collection":"control_collection", > [junit4] 2> "operation":"state"} current state version: 0 > [junit4] 2> 2098493 INFO > (OverseerStateUpdate-94143379560595459-127.0.0.1:51834_-n_0000000000) > [n:127.0.0.1:51834_ ] o.a.s.c.o.ReplicaMutator Update state numShards=1 > message={ > [junit4] 2> "core":"collection1", > [junit4] 2> "roles":null, > [junit4] 2> "base_url":"http://127.0.0.1:51834";, > [junit4] 2> "node_name":"127.0.0.1:51834_", > [junit4] 2> "numShards":"1", > [junit4] 2> "state":"down", > [junit4] 2> "shard":null, > [junit4] 2> "collection":"control_collection", > [junit4] 2> "operation":"state"} > [junit4] 2> 2098493 INFO > (OverseerStateUpdate-94143379560595459-127.0.0.1:51834_-n_0000000000) > [n:127.0.0.1:51834_ ] o.a.s.c.o.ClusterStateMutator building a new cName: > control_collection > [junit4] 2> 2098493 INFO > (OverseerStateUpdate-94143379560595459-127.0.0.1:51834_-n_0000000000) > [n:127.0.0.1:51834_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard > shard=shard1 > [junit4] 2> 2099453 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection x:collection1] > o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1 > [junit4] 2> 2099453 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection x:collection1] > o.a.s.c.ZkController Check for collection zkNode:control_collection > [junit4] 2> 2099454 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection x:collection1] > o.a.s.c.ZkController Collection zkNode exists > [junit4] 2> 2099455 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection x:collection1] > o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: > 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\control-001\cores\collection1\' > [junit4] 2> 2099468 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection x:collection1] o.a.s.c.Config > loaded config solrconfig.xml with version 0 > [junit4] 2> 2099477 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection x:collection1] o.a.s.c.SolrConfig > current version of requestparams : -1 > [junit4] 2> 2099481 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection x:collection1] o.a.s.c.SolrConfig > Using Lucene MatchVersion: 5.3.0 > [junit4] 2> 2099488 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection x:collection1] o.a.s.c.Config > Loaded SolrConfig: solrconfig.xml > [junit4] 2> 2099489 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection x:collection1] o.a.s.s.IndexSchema > Reading Solr Schema from /configs/conf1/schema.xml > [junit4] 2> 2099492 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection x:collection1] o.a.s.s.IndexSchema > [collection1] Schema name=test > [junit4] 2> 2099598 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection x:collection1] > o.a.s.s.OpenExchangeRatesOrgProvider Initialized with > rates=open-exchange-rates.json, refreshInterval=1440. > [junit4] 2> 2099606 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection x:collection1] o.a.s.s.IndexSchema > default search field in schema is text > [junit4] 2> 2099607 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection x:collection1] o.a.s.s.IndexSchema > unique key field: id > [junit4] 2> 2099616 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection x:collection1] > o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file > currency.xml > [junit4] 2> 2099618 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection x:collection1] > o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file > currency.xml > [junit4] 2> 2099621 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection x:collection1] > o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from > open-exchange-rates.json > [junit4] 2> 2099622 WARN > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection x:collection1] > o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE > [junit4] 2> 2099622 WARN > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection x:collection1] > o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING > [junit4] 2> 2099622 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection x:collection1] > o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from > open-exchange-rates.json > [junit4] 2> 2099623 WARN > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection x:collection1] > o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE > [junit4] 2> 2099623 WARN > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection x:collection1] > o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING > [junit4] 2> 2099623 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection x:collection1] > o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration > from collection control_collection > [junit4] 2> 2099623 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory > [junit4] 2> 2099623 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at > [C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\control-001\cores\collection1\], > dataDir=[null] > [junit4] 2> 2099624 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX > Server: com.sun.jmx.mbeanserver.JmxMBeanServer@38f3c99e > [junit4] 2> 2099624 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.CachingDirectoryFactory return new directory for > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\control-001\cores\collection1\data\ > [junit4] 2> 2099624 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.SolrCore New index directory detected: old=null > new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\control-001\cores\collection1\data\index/ > [junit4] 2> 2099625 WARN > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.SolrCore [collection1] Solr index directory > 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\control-001\cores\collection1\data\index' > doesn't exist. Creating new index... > [junit4] 2> 2099625 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.CachingDirectoryFactory return new directory for > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\control-001\cores\collection1\data\index > [junit4] 2> 2099625 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class > org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: > maxMergeAtOnce=14, maxMergeAtOnceExplicit=20, maxMergedSegmentMB=34.25, > floorSegmentMB=1.970703125, forceMergeDeletesPctAllowed=5.131283657209968, > segmentsPerTier=41.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 > [junit4] 2> 2099625 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1 > [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@177c45a > lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4d82aa9b),segFN=segments_1,generation=1} > [junit4] 2> 2099625 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.SolrCore newest commit generation = 1 > [junit4] 2> 2099626 INFO > (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:51834_ > c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore > Looking for old index directories to cleanup for core collection1 in > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\control-001\cores\collection1\data\ > [junit4] 2> 2099626 WARN > (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:51834_ > c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.DirectoryFactory > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\control-001\cores\collection1\data\ > does not point to a valid data directory; skipping clean-up of old index > directories. > [junit4] 2> 2099628 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain > "nodistrib" > [junit4] 2> 2099628 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain > "dedupe" > [junit4] 2> 2099629 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.u.p.UpdateRequestProcessorChain inserting > DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" > [junit4] 2> 2099629 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain > "stored_sig" > [junit4] 2> 2099629 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.u.p.UpdateRequestProcessorChain inserting > DistributedUpdateProcessorFactory into updateRequestProcessorChain > "stored_sig" > [junit4] 2> 2099629 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain > "distrib-dup-test-chain-explicit" > [junit4] 2> 2099629 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain > "distrib-dup-test-chain-implicit" > [junit4] 2> 2099630 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.u.p.UpdateRequestProcessorChain inserting > DistributedUpdateProcessorFactory into updateRequestProcessorChain > "distrib-dup-test-chain-implicit" > [junit4] 2> 2099630 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating > implicit default > [junit4] 2> 2099633 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 > [junit4] 2> 2099634 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 > [junit4] 2> 2099635 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 > [junit4] 2> 2099636 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 > [junit4] 2> 2099639 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.RequestHandlers Registered paths: > /admin/mbeans,standard,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file > [junit4] 2> 2099639 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.SolrCore Using default statsCache cache: > org.apache.solr.search.stats.LocalStatsCache > [junit4] 2> 2099640 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.u.UpdateHandler Using UpdateLog implementation: > org.apache.solr.update.UpdateLog > [junit4] 2> 2099640 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH > numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 > [junit4] 2> 2099642 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.SolrCore Hard AutoCommit: disabled > [junit4] 2> 2099642 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.SolrCore Soft AutoCommit: disabled > [junit4] 2> 2099642 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class > org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: > minMergeSize=1677721, mergeFactor=11, maxMergeSize=2147483648, > maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, > maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, > noCFSRatio=0.6779019862181269] > [junit4] 2> 2099642 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1 > [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@177c45a > lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4d82aa9b),segFN=segments_1,generation=1} > [junit4] 2> 2099642 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.SolrCore newest commit generation = 1 > [junit4] 2> 2099642 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.s.SolrIndexSearcher Opening Searcher@7c756c57[collection1] main > [junit4] 2> 2099643 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.r.ManagedResourceStorage Setting up ZooKeeper-based storage for the > RestManager with znodeBase: /configs/conf1 > [junit4] 2> 2099643 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: > /configs/conf1 > [junit4] 2> 2099644 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.r.RestManager Initializing RestManager with initArgs: {} > [junit4] 2> 2099644 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using > ZooKeeperStorageIO:path=/configs/conf1 > [junit4] 2> 2099644 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.r.ManagedResourceStorage No data found for znode > /configs/conf1/_rest_managed.json > [junit4] 2> 2099644 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using > ZooKeeperStorageIO:path=/configs/conf1 > [junit4] 2> 2099644 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.r.RestManager Initializing 0 registered ManagedResources > [junit4] 2> 2099644 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.h.ReplicationHandler Commits will be reserved for 10000 > [junit4] 2> 2099645 INFO > (searcherExecutor-6703-thread-1-processing-n:127.0.0.1:51834_ x:collection1 > s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:51834_ > c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore > [collection1] Registered new searcher Searcher@7c756c57[collection1] > main{ExitableDirectoryReader(UninvertingDirectoryReader())} > [junit4] 2> 2099645 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.u.UpdateLog Looking up max value of version field to seed version > buckets > [junit4] 2> 2099646 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version > buckets from index > [junit4] 2> 2099646 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket > highest value from index > [junit4] 2> 2099646 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.u.UpdateLog Could not find max version in index or recent updates, > using new clock 1506294074721697792 > [junit4] 2> 2099648 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.u.UpdateLog Took 2 ms to seed version buckets with highest version > 1506294074721697792 > [junit4] 2> 2099648 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.ZkController watch zkdir /configs/conf1 > [junit4] 2> 2099649 INFO > (coreLoadExecutor-6702-thread-1-processing-n:127.0.0.1:51834_) > [n:127.0.0.1:51834_ c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.CoreContainer registering core: collection1 > [junit4] 2> 2099649 INFO > (coreZkRegister-6696-thread-1-processing-n:127.0.0.1:51834_ x:collection1 > s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:51834_ > c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.ZkController Register replica - core:collection1 > address:http://127.0.0.1:51834 collection:control_collection shard:shard1 > [junit4] 2> 2099654 INFO > (coreZkRegister-6696-thread-1-processing-n:127.0.0.1:51834_ x:collection1 > s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:51834_ > c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.LeaderElector Joined leadership election with path: > /collections/control_collection/leader_elect/shard1/election/94143379560595459-core_node1-n_0000000000 > [junit4] 2> 2099656 INFO > (coreZkRegister-6696-thread-1-processing-n:127.0.0.1:51834_ x:collection1 > s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:51834_ > c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.ShardLeaderElectionContext Running the leader process for shard shard1 > [junit4] 2> 2099657 INFO > (zkCallback-1827-thread-1-processing-n:127.0.0.1:51834_) [n:127.0.0.1:51834_ > ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path > /overseer/queue state SyncConnected > [junit4] 2> 2099657 INFO > (coreZkRegister-6696-thread-1-processing-n:127.0.0.1:51834_ x:collection1 > s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:51834_ > c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. > [junit4] 2> 2099657 INFO > (coreZkRegister-6696-thread-1-processing-n:127.0.0.1:51834_ x:collection1 > s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:51834_ > c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync > [junit4] 2> 2099657 INFO > (coreZkRegister-6696-thread-1-processing-n:127.0.0.1:51834_ x:collection1 > s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:51834_ > c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:51834/collection1/ > [junit4] 2> 2099657 INFO > (coreZkRegister-6696-thread-1-processing-n:127.0.0.1:51834_ x:collection1 > s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:51834_ > c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.SyncStrategy Sync Success - now sync replicas to me > [junit4] 2> 2099657 INFO > (coreZkRegister-6696-thread-1-processing-n:127.0.0.1:51834_ x:collection1 > s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:51834_ > c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.SyncStrategy http://127.0.0.1:51834/collection1/ has no replicas > [junit4] 2> 2099657 INFO > (OverseerStateUpdate-94143379560595459-127.0.0.1:51834_-n_0000000000) > [n:127.0.0.1:51834_ ] o.a.s.c.Overseer processMessage: queueSize: 1, > message = { > [junit4] 2> "operation":"leader", > [junit4] 2> "shard":"shard1", > [junit4] 2> "collection":"control_collection"} current state version: 1 > [junit4] 2> 2099657 INFO > (coreZkRegister-6696-thread-1-processing-n:127.0.0.1:51834_ x:collection1 > s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:51834_ > c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.ShardLeaderElectionContext I am the new leader: > http://127.0.0.1:51834/collection1/ shard1 > [junit4] 2> 2099662 INFO > (zkCallback-1827-thread-1-processing-n:127.0.0.1:51834_) [n:127.0.0.1:51834_ > ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path > /overseer/queue state SyncConnected > [junit4] 2> 2099663 INFO > (OverseerStateUpdate-94143379560595459-127.0.0.1:51834_-n_0000000000) > [n:127.0.0.1:51834_ ] o.a.s.c.Overseer processMessage: queueSize: 1, > message = { > [junit4] 2> "operation":"leader", > [junit4] 2> "shard":"shard1", > [junit4] 2> "collection":"control_collection", > [junit4] 2> "base_url":"http://127.0.0.1:51834";, > [junit4] 2> "core":"collection1", > [junit4] 2> "state":"active"} current state version: 1 > [junit4] 2> 2099809 INFO > (coreZkRegister-6696-thread-1-processing-n:127.0.0.1:51834_ x:collection1 > s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:51834_ > c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.ZkController We are http://127.0.0.1:51834/collection1/ and leader is > http://127.0.0.1:51834/collection1/ > [junit4] 2> 2099809 INFO > (coreZkRegister-6696-thread-1-processing-n:127.0.0.1:51834_ x:collection1 > s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:51834_ > c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.ZkController No LogReplay needed for core=collection1 > baseURL=http://127.0.0.1:51834 > [junit4] 2> 2099809 INFO > (coreZkRegister-6696-thread-1-processing-n:127.0.0.1:51834_ x:collection1 > s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:51834_ > c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.ZkController I am the leader, no recovery necessary > [junit4] 2> 2099809 INFO > (coreZkRegister-6696-thread-1-processing-n:127.0.0.1:51834_ x:collection1 > s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:51834_ > c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.ZkController publishing state=active > [junit4] 2> 2099809 INFO > (coreZkRegister-6696-thread-1-processing-n:127.0.0.1:51834_ x:collection1 > s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:51834_ > c:control_collection s:shard1 r:core_node1 x:collection1] > o.a.s.c.ZkController numShards not found on descriptor - reading it from > system property > [junit4] 2> 2099810 INFO > (zkCallback-1827-thread-1-processing-n:127.0.0.1:51834_) [n:127.0.0.1:51834_ > ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path > /overseer/queue state SyncConnected > [junit4] 2> 2099811 INFO > (OverseerStateUpdate-94143379560595459-127.0.0.1:51834_-n_0000000000) > [n:127.0.0.1:51834_ ] o.a.s.c.Overseer processMessage: queueSize: 1, > message = { > [junit4] 2> "core":"collection1", > [junit4] 2> "core_node_name":"core_node1", > [junit4] 2> "roles":null, > [junit4] 2> "base_url":"http://127.0.0.1:51834";, > [junit4] 2> "node_name":"127.0.0.1:51834_", > [junit4] 2> "numShards":"1", > [junit4] 2> "state":"active", > [junit4] 2> "shard":"shard1", > [junit4] 2> "collection":"control_collection", > [junit4] 2> "operation":"state"} current state version: 2 > [junit4] 2> 2099812 INFO > (OverseerStateUpdate-94143379560595459-127.0.0.1:51834_-n_0000000000) > [n:127.0.0.1:51834_ ] o.a.s.c.o.ReplicaMutator Update state numShards=1 > message={ > [junit4] 2> "core":"collection1", > [junit4] 2> "core_node_name":"core_node1", > [junit4] 2> "roles":null, > [junit4] 2> "base_url":"http://127.0.0.1:51834";, > [junit4] 2> "node_name":"127.0.0.1:51834_", > [junit4] 2> "numShards":"1", > [junit4] 2> "state":"active", > [junit4] 2> "shard":"shard1", > [junit4] 2> "collection":"control_collection", > [junit4] 2> "operation":"state"} > [junit4] 2> 2099939 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause > connection loss:false > [junit4] 2> 2099939 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.AbstractFullDistribZkTestBase Creating collection1 with > stateFormat=2 > [junit4] 2> 2099943 INFO > (zkCallback-1827-thread-1-processing-n:127.0.0.1:51834_) [n:127.0.0.1:51834_ > ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path > /overseer/queue state SyncConnected > [junit4] 2> 2099944 INFO > (OverseerStateUpdate-94143379560595459-127.0.0.1:51834_-n_0000000000) > [n:127.0.0.1:51834_ ] o.a.s.c.Overseer processMessage: queueSize: 1, > message = { > [junit4] 2> "operation":"create", > [junit4] 2> "name":"collection1", > [junit4] 2> "numShards":"2", > [junit4] 2> "stateFormat":"2"} current state version: 3 > [junit4] 2> 2099945 INFO > (OverseerStateUpdate-94143379560595459-127.0.0.1:51834_-n_0000000000) > [n:127.0.0.1:51834_ ] o.a.s.c.o.ClusterStateMutator building a new cName: > collection1 > [junit4] 2> 2100043 INFO > (OverseerStateUpdate-94143379560595459-127.0.0.1:51834_-n_0000000000) > [n:127.0.0.1:51834_ ] o.a.s.c.o.ZkStateWriter going to create_collection > /collections/collection1/state.json > [junit4] 2> 2100311 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\shard-1-001\cores\collection1 > [junit4] 2> 2100314 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\shard-1-001 > [junit4] 2> 2100315 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.e.j.s.Server jetty-9.2.11.v20150529 > [junit4] 2> 2100318 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.e.j.s.h.ContextHandler Started > o.e.j.s.ServletContextHandler@459099f1{/,null,AVAILABLE} > [junit4] 2> 2100319 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.e.j.s.ServerConnector Started > ServerConnector@3b393461{HTTP/1.1}{127.0.0.1:51894} > [junit4] 2> 2100319 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.e.j.s.Server Started @2104134ms > [junit4] 2> 2100319 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: > {solr.data.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\tempDir-001/jetty1, > solrconfig=solrconfig.xml, hostContext=/, hostPort=51894, > coreRootDirectory=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\shard-1-001\cores} > [junit4] 2> 2100320 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): > sun.misc.Launcher$AppClassLoader@4e0e2f2a > [junit4] 2> 2100320 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: > 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\shard-1-001\' > [junit4] 2> 2100354 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.SolrXmlConfig Loading container configuration from > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\shard-1-001\solr.xml > [junit4] 2> 2100362 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.CoresLocator Config-defined core root directory: > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\shard-1-001\cores > [junit4] 2> 2100363 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.CoreContainer New CoreContainer 2050168389 > [junit4] 2> 2100363 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer > [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\shard-1-001\] > [junit4] 2> 2100363 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.CoreContainer loading shared library: > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\shard-1-001\lib > [junit4] 2> 2100363 WARN > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to > classloader: lib (resolved as: > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\shard-1-001\lib). > [junit4] 2> 2100374 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] 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> 2100377 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client > with params: socketTimeout=340000&connTimeout=45000&retry=true > [junit4] 2> 2100379 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory > [junit4] 2> 2100379 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j > (org.slf4j.impl.Log4jLoggerFactory)] > [junit4] 2> 2100379 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51827/solr > [junit4] 2> 2100379 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.a.s.c.ZkController zkHost includes chroot > [junit4] 2> 2101307 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [n:127.0.0.1:51894_ ] o.a.s.c.ZkController Register node as live in > ZooKeeper:/live_nodes/127.0.0.1:51894_ > [junit4] 2> 2101310 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [n:127.0.0.1:51894_ ] o.a.s.c.Overseer Overseer (id=null) closing > [junit4] 2> 2101310 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [n:127.0.0.1:51894_ ] o.a.s.c.LeaderElector Joined leadership election > with path: > /overseer_elect/election/94143379560595463-127.0.0.1:51894_-n_0000000001 > [junit4] 2> 2101311 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [n:127.0.0.1:51894_ ] o.a.s.c.LeaderElector Watching path > /overseer_elect/election/94143379560595459-127.0.0.1:51834_-n_0000000000 to > know if I could be the leader > [junit4] 2> 2101312 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [n:127.0.0.1:51894_ ] o.a.s.c.CoreContainer No authentication plugin used. > [junit4] 2> 2101312 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [n:127.0.0.1:51894_ ] o.a.s.c.CoreContainer Security conf doesn't exist. > Skipping setup for authorization module. > [junit4] 2> 2101313 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [n:127.0.0.1:51894_ ] o.a.s.c.CoresLocator Looking for core definitions > underneath > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\shard-1-001\cores > [junit4] 2> 2101314 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [n:127.0.0.1:51894_ ] o.a.s.c.SolrCore Created CoreDescriptor: > {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, > loadOnStartup=true, > instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\shard-1-001\cores\collection1, > collection=collection1, > absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\shard-1-001\cores\collection1\, > coreNodeName=, dataDir=data\, shard=} > [junit4] 2> 2101314 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [n:127.0.0.1:51894_ ] o.a.s.c.CoresLocator Found core collection1 in > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\shard-1-001\cores\collection1\ > [junit4] 2> 2101314 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [n:127.0.0.1:51894_ ] o.a.s.c.CoresLocator Found 1 core definitions > [junit4] 2> 2101316 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [n:127.0.0.1:51894_ ] o.a.s.s.SolrDispatchFilter > user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0 > [junit4] 2> 2101316 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [n:127.0.0.1:51894_ ] o.a.s.s.SolrDispatchFilter > SolrDispatchFilter.init() done > [junit4] 2> 2101316 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 x:collection1] o.a.s.c.ZkController > publishing state=down > [junit4] 2> 2101316 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 x:collection1] o.a.s.c.ZkController > numShards not found on descriptor - reading it from system property > [junit4] 2> 2101316 INFO > (zkCallback-1827-thread-1-processing-n:127.0.0.1:51834_) [n:127.0.0.1:51834_ > ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path > /overseer/queue state SyncConnected > [junit4] 2> 2101317 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 x:collection1] o.a.s.c.ZkController > Registering watch for external collection collection1 > [junit4] 2> 2101317 INFO > (OverseerStateUpdate-94143379560595459-127.0.0.1:51834_-n_0000000000) > [n:127.0.0.1:51834_ ] o.a.s.c.Overseer processMessage: queueSize: 1, > message = { > [junit4] 2> "core":"collection1", > [junit4] 2> "roles":null, > [junit4] 2> "base_url":"http://127.0.0.1:51894";, > [junit4] 2> "node_name":"127.0.0.1:51894_", > [junit4] 2> "numShards":"2", > [junit4] 2> "state":"down", > [junit4] 2> "shard":null, > [junit4] 2> "collection":"collection1", > [junit4] 2> "operation":"state"} current state version: 4 > [junit4] 2> 2101318 INFO > (OverseerStateUpdate-94143379560595459-127.0.0.1:51834_-n_0000000000) > [n:127.0.0.1:51834_ ] o.a.s.c.o.ReplicaMutator Update state numShards=2 > message={ > [junit4] 2> "core":"collection1", > [junit4] 2> "roles":null, > [junit4] 2> "base_url":"http://127.0.0.1:51894";, > [junit4] 2> "node_name":"127.0.0.1:51894_", > [junit4] 2> "numShards":"2", > [junit4] 2> "state":"down", > [junit4] 2> "shard":null, > [junit4] 2> "collection":"collection1", > [junit4] 2> "operation":"state"} > [junit4] 2> 2101318 INFO > (OverseerStateUpdate-94143379560595459-127.0.0.1:51834_-n_0000000000) > [n:127.0.0.1:51834_ ] o.a.s.c.o.ReplicaMutator Collection already exists > with numShards=2 > [junit4] 2> 2101318 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 x:collection1] o.a.s.c.ZkController look > for our core node name > [junit4] 2> 2101318 INFO > (OverseerStateUpdate-94143379560595459-127.0.0.1:51834_-n_0000000000) > [n:127.0.0.1:51834_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard > shard=shard2 > [junit4] 2> 2101408 INFO > (OverseerStateUpdate-94143379560595459-127.0.0.1:51834_-n_0000000000) > [n:127.0.0.1:51834_ ] o.a.s.c.o.ZkStateWriter going to update_collection > /collections/collection1/state.json version: 0 > [junit4] 2> 2102183 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 x:collection1] o.a.s.c.ZkController > waiting to find shard id in clusterstate for collection1 > [junit4] 2> 2102183 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 x:collection1] o.a.s.c.ZkController Check > for collection zkNode:collection1 > [junit4] 2> 2102183 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 x:collection1] o.a.s.c.ZkController > Collection zkNode exists > [junit4] 2> 2102183 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 x:collection1] o.a.s.c.SolrResourceLoader > new SolrResourceLoader for directory: > 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\shard-1-001\cores\collection1\' > [junit4] 2> 2102205 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 x:collection1] o.a.s.c.Config loaded > config solrconfig.xml with version 0 > [junit4] 2> 2102211 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 x:collection1] o.a.s.c.SolrConfig current > version of requestparams : -1 > [junit4] 2> 2102214 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 x:collection1] o.a.s.c.SolrConfig Using > Lucene MatchVersion: 5.3.0 > [junit4] 2> 2102220 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 x:collection1] o.a.s.c.Config Loaded > SolrConfig: solrconfig.xml > [junit4] 2> 2102221 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 x:collection1] o.a.s.s.IndexSchema > Reading Solr Schema from /configs/conf1/schema.xml > [junit4] 2> 2102224 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 x:collection1] o.a.s.s.IndexSchema > [collection1] Schema name=test > [junit4] 2> 2102308 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 x:collection1] > o.a.s.s.OpenExchangeRatesOrgProvider Initialized with > rates=open-exchange-rates.json, refreshInterval=1440. > [junit4] 2> 2102314 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 x:collection1] o.a.s.s.IndexSchema > default search field in schema is text > [junit4] 2> 2102315 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 x:collection1] o.a.s.s.IndexSchema unique > key field: id > [junit4] 2> 2102324 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 x:collection1] > o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file > currency.xml > [junit4] 2> 2102326 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 x:collection1] > o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file > currency.xml > [junit4] 2> 2102328 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 x:collection1] > o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from > open-exchange-rates.json > [junit4] 2> 2102329 WARN > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 x:collection1] > o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE > [junit4] 2> 2102330 WARN > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 x:collection1] > o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING > [junit4] 2> 2102330 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 x:collection1] > o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from > open-exchange-rates.json > [junit4] 2> 2102330 WARN > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 x:collection1] > o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE > [junit4] 2> 2102330 WARN > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 x:collection1] > o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING > [junit4] 2> 2102330 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 x:collection1] o.a.s.c.CoreContainer > Creating SolrCore 'collection1' using configuration from collection > collection1 > [junit4] 2> 2102330 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory > [junit4] 2> 2102330 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at > [C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\shard-1-001\cores\collection1\], > dataDir=[null] > [junit4] 2> 2102330 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX > Server: com.sun.jmx.mbeanserver.JmxMBeanServer@38f3c99e > [junit4] 2> 2102331 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.c.CachingDirectoryFactory return new directory for > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\shard-1-001\cores\collection1\data\ > [junit4] 2> 2102331 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.c.SolrCore New index directory detected: old=null > new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\shard-1-001\cores\collection1\data\index/ > [junit4] 2> 2102331 WARN > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.c.SolrCore [collection1] Solr index directory > 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\shard-1-001\cores\collection1\data\index' > doesn't exist. Creating new index... > [junit4] 2> 2102331 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.c.CachingDirectoryFactory return new directory for > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\shard-1-001\cores\collection1\data\index > [junit4] 2> 2102331 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class > org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: > maxMergeAtOnce=14, maxMergeAtOnceExplicit=20, maxMergedSegmentMB=34.25, > floorSegmentMB=1.970703125, forceMergeDeletesPctAllowed=5.131283657209968, > segmentsPerTier=41.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 > [junit4] 2> 2102332 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1 > [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@5d35affd > lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1f5fbd84),segFN=segments_1,generation=1} > [junit4] 2> 2102332 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.c.SolrCore newest commit generation = 1 > [junit4] 2> 2102333 INFO > (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:51894_ > c:collection1 s:shard2 r:core_node1 x:collection1] o.a.s.c.SolrCore Looking > for old index directories to cleanup for core collection1 in > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\shard-1-001\cores\collection1\data\ > [junit4] 2> 2102333 WARN > (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:51894_ > c:collection1 s:shard2 r:core_node1 x:collection1] o.a.s.c.DirectoryFactory > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001\shard-1-001\cores\collection1\data\ > does not point to a valid data directory; skipping clean-up of old index > directories. > [junit4] 2> 2102335 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain > "nodistrib" > [junit4] 2> 2102335 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain > "dedupe" > [junit4] 2> 2102335 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.u.p.UpdateRequestProcessorChain inserting > DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" > [junit4] 2> 2102335 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain > "stored_sig" > [junit4] 2> 2102335 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.u.p.UpdateRequestProcessorChain inserting > DistributedUpdateProcessorFactory into updateRequestProcessorChain > "stored_sig" > [junit4] 2> 2102335 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain > "distrib-dup-test-chain-explicit" > [junit4] 2> 2102335 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain > "distrib-dup-test-chain-implicit" > [junit4] 2> 2102335 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.u.p.UpdateRequestProcessorChain inserting > DistributedUpdateProcessorFactory into updateRequestProcessorChain > "distrib-dup-test-chain-implicit" > [junit4] 2> 2102335 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating > implicit default > [junit4] 2> 2102339 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 > [junit4] 2> 2102340 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 > [junit4] 2> 2102341 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 > [junit4] 2> 2102341 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 > [junit4] 2> 2102345 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.c.RequestHandlers Registered paths: > /admin/mbeans,standard,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file > [junit4] 2> 2102345 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.c.SolrCore Using default statsCache cache: > org.apache.solr.search.stats.LocalStatsCache > [junit4] 2> 2102346 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.u.UpdateHandler Using UpdateLog implementation: > org.apache.solr.update.UpdateLog > [junit4] 2> 2102346 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH > numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 > [junit4] 2> 2102346 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.c.SolrCore Hard AutoCommit: disabled > [junit4] 2> 2102346 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.c.SolrCore Soft AutoCommit: disabled > [junit4] 2> 2102347 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class > org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: > minMergeSize=1677721, mergeFactor=11, maxMergeSize=2147483648, > maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, > maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, > noCFSRatio=0.6779019862181269] > [junit4] 2> 2102347 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1 > [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@5d35affd > lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1f5fbd84),segFN=segments_1,generation=1} > [junit4] 2> 2102347 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.c.SolrCore newest commit generation = 1 > [junit4] 2> 2102347 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.s.SolrIndexSearcher Opening Searcher@2f202bc4[collection1] main > [junit4] 2> 2102348 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.r.ManagedResourceStorage Setting up ZooKeeper-based storage for the > RestManager with znodeBase: /configs/conf1 > [junit4] 2> 2102349 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: > /configs/conf1 > [junit4] 2> 2102349 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.r.RestManager Initializing RestManager with initArgs: {} > [junit4] 2> 2102349 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using > ZooKeeperStorageIO:path=/configs/conf1 > [junit4] 2> 2102350 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.r.ManagedResourceStorage No data found for znode > /configs/conf1/_rest_managed.json > [junit4] 2> 2102350 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using > ZooKeeperStorageIO:path=/configs/conf1 > [junit4] 2> 2102350 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.r.RestManager Initializing 0 registered ManagedResources > [junit4] 2> 2102350 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.h.ReplicationHandler Commits will be reserved for 10000 > [junit4] 2> 2102350 INFO > (searcherExecutor-6714-thread-1-processing-n:127.0.0.1:51894_ x:collection1 > s:shard2 c:collection1 r:core_node1) [n:127.0.0.1:51894_ c:collection1 > s:shard2 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] > Registered new searcher Searcher@2f202bc4[collection1] > main{ExitableDirectoryReader(UninvertingDirectoryReader())} > [junit4] 2> 2102351 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.u.UpdateLog Looking up max value of version field to seed version > buckets > [junit4] 2> 2102351 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version > buckets from index > [junit4] 2> 2102351 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket > highest value from index > [junit4] 2> 2102351 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.u.UpdateLog Could not find max version in index or recent updates, > using new clock 1506294077558095872 > [junit4] 2> 2102352 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.u.UpdateLog Took 1 ms to seed version buckets with highest version > 1506294077558095872 > [junit4] 2> 2102352 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.c.ZkController watch zkdir /configs/conf1 > [junit4] 2> 2102352 INFO > (coreLoadExecutor-6713-thread-1-processing-n:127.0.0.1:51894_) > [n:127.0.0.1:51894_ c:collection1 s:shard2 r:core_node1 x:collection1] > o.a.s.c.CoreContainer registering core: collection1 > [junit4] 2> 2102353 INFO > (coreZkRegister-6708-thread-1-processing-n:127.0.0.1:51894_ x:collection1 > s:shard2 c:collection1 r:core_node1) [n:127.0.0.1:51894_ c:collection1 > s:shard2 r:core_node1 x:collection1] o.a.s.c.ZkController Register replica - > core:collection1 address:http://127.0.0.1:51894 collection:collection1 > shard:shard2 > [junit4] 2> 2102357 INFO > (coreZkRegister-6708-thread-1-processing-n:127.0.0.1:51894_ x:collection1 > s:shard2 c:collection1 r:core_node1) [n:127.0.0.1:51894_ c:collection1 > s:shard2 r:core_node1 x:collection1] o.a.s.c.LeaderElector Joined leadership > election with path: > /collections/collection1/leader_elect/shard2/election/94143379560595463-core_node1-n_0000000000 > [junit4] 2> 2102358 INFO > (coreZkRegister-6708-thread-1-processing-n:127.0.0.1:51894_ x:collection1 > s:shard2 c:collection1 r:core_node1) [n:127.0.0.1:51894_ c:collection1 > s:shard2 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext > Running the leader process for shard shard2 > [junit4] 2> 2102359 INFO > (zkCallback-1827-thread-1-processing-n:127.0.0.1:51834_) [n:127.0.0.1:51834_ > ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path > /overseer/queue state SyncConnected > [junit4] 2> 2102359 INFO > (coreZkRegister-6708-thread-1-processing-n:127.0.0.1:51894_ x:collection1 > s:shard2 c:collection1 r:core_node1) [n:127.0.0.1:51894_ c:collection1 > s:shard2 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext > Enough replicas found to continue. > [junit4] 2> 2102360 INFO > (coreZkRegister-6708-thread-1-processing-n:127.0.0.1:51894_ x:collection1 > s:shard2 c:collection1 r:core_node1) [n:127.0.0.1:51894_ c:collection1 > s:shard2 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I may > be the new leader - try and sync > [junit4] 2> 2102360 INFO > (coreZkRegister-6708-thread-1-processing-n:127.0.0.1:51894_ x:collection1 > s:shard2 c:collection1 r:core_node1) [n:127.0.0.1:51894_ c:collection1 > s:shard2 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to > http://127.0.0.1:51894/collection1/ > [junit4] 2> 2102360 INFO > (coreZkRegister-6708-thread-1-processing-n:127.0.0.1:51894_ x:collection1 > s:shard2 c:collection1 r:core_node1) [n:127.0.0.1:51894_ c:collection1 > s:shard2 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now > sync replicas to me > [junit4] 2> 2102360 INFO > (coreZkRegister-6708-thread-1-processing-n:127.0.0.1:51894_ x:collection1 > s:shard2 c:collection1 r:core_node1) [n:127.0.0.1:51894_ c:collection1 > s:shard2 r:core_node1 x:collection1] o.a.s.c.SyncStrategy > http://127.0.0.1:51894/collection1/ has no replicas > [junit4] 2> 2102360 INFO > (OverseerStateUpdate-94143379560595459-127.0.0.1:51834_-n_0000000000) > [n:127.0.0.1:51834_ ] o.a.s.c.Overseer processMessage: queueSize: 1, > message = { > [junit4] 2> "operation":"leader", > [junit4] 2> "shard":"shard2", > [junit4] 2> "collection":"collection1"} current state version: 4 > [junit4] 2> 2102360 INFO > (coreZkRegister-6708-thread-1-processing-n:127.0.0.1:51894_ x:collection1 > s:shard2 c:collection1 r:core_node1) [n:127.0.0.1:51894_ c:collection1 > s:shard2 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I am > the new leader: http://127.0.0.1:51894/collection1/ shard2 > [junit4] 2> 2102361 INFO > (OverseerStateUpdate-94143379560595459-127.0.0.1:51834_-n_0000000000) > [n:127.0.0.1:51834_ ] o.a.s.c.o.ZkStateWriter going to update_collection > /collections/collection1/state.json version: 1 > [junit4] 2> 2102364 INFO > (OverseerStateUpdate-94143379560595459-127.0.0.1:51834_-n_0000000000) > [n:127.0.0.1:51834_ ] o.a.s.c.Overseer processMessage: queueSize: 1, > message = { > [junit4] 2> "operation":"leader", > [junit4] 2> "shard":"shard2", > [junit4] 2> "collection":"collection1", > [junit4] 2> "base_url":"http://127.0.0.1:51894";, > [junit4] 2> "core":"collection1", > [junit4] 2> "state":"active"} current state version: 4 > [junit4] 2> 2102365 INFO > (OverseerStateUpdate-94143379560595459-127.0.0.1:51834_-n_0000000000) > [n:127.0.0.1:51834_ ] o.a.s.c.o.ZkStateWriter going to update_collection > /collections/collection1/state.json version: 2 > [junit4] 2> 2102368 INFO > (zkCallback-1827-thread-1-processing-n:127.0.0.1:51834_) [n:127.0.0.1:51834_ > ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path > /overseer/queue state SyncConnected > [junit4] 2> 2102407 INFO > (coreZkRegister-6708-thread-1-processing-n:127.0.0.1:51894_ x:collection1 > s:shard2 c:collection1 r:core_node1) [n:127.0.0.1:51894_ c:collection1 > s:shard2 r:core_node1 x:collection1] o.a.s.c.ZkController We are > http://127.0.0.1:51894/collection1/ and leader is > http://127.0.0.1:51894/collection1/ > [junit4] 2> 2102407 INFO > (coreZkRegister-6708-thread-1-processing-n:127.0.0.1:51894_ x:collection1 > s:shard2 c:collection1 r:core_node1) [n:127.0.0.1:51894_ > > [...truncated too long message...] > > olrZkClient.exists(SolrZkClient.java:291) > [junit4] 2> at > org.apache.solr.common.cloud.SolrZkClient.makePath(SolrZkClient.java:486) > [junit4] 2> at > org.apache.solr.common.cloud.SolrZkClient.makePath(SolrZkClient.java:455) > [junit4] 2> at > org.apache.solr.common.cloud.SolrZkClient.makePath(SolrZkClient.java:442) > [junit4] 2> at > org.apache.solr.cloud.ShardLeaderElectionContextBase$1.execute(ElectionContext.java:140) > [junit4] 2> at > org.apache.solr.common.util.RetryUtil.retryOnThrowable(RetryUtil.java:31) > [junit4] 2> at > org.apache.solr.cloud.ShardLeaderElectionContextBase.runLeaderProcess(ElectionContext.java:136) > [junit4] 2> ... 12 more > [junit4] 2> > [junit4] 2> 2129034 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.e.j.s.ServerConnector Stopped > ServerConnector@19d46bbf{HTTP/1.1}{127.0.0.1:0} > [junit4] 2> 2129034 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [ ] o.e.j.s.h.ContextHandler Stopped > o.e.j.s.ServletContextHandler@15867313{/,null,UNAVAILABLE} > [junit4] 2> 2129036 INFO > (TEST-TestRandomRequestDistribution.testRequestTracking-seed#[F719E8B96F0F4665]) > [n:127.0.0.1:51996_ c:b1x1 s:shard1 r:core_node1 x:b1x1_shard1_replica1] > o.a.s.c.ZkTestServer connecting to 127.0.0.1:51827 51827 > [junit4] 2> 2131584 INFO (Thread-5069) [ ] o.a.s.c.ZkTestServer > connecting to 127.0.0.1:51827 51827 > [junit4] 2> 2131585 WARN (Thread-5069) [ ] o.a.s.c.ZkTestServer > Watch limit violations: > [junit4] 2> Maximum concurrent create/delete watches above limit: > [junit4] 2> > [junit4] 2> 5 /solr/aliases.json > [junit4] 2> 5 /solr/clusterstate.json > [junit4] 2> 4 /solr/configs/conf1 > [junit4] 2> 3 /solr/collections/collection1/state.json > [junit4] 2> 2 /solr/collections/a1x2/state.json > [junit4] 2> > [junit4] 2> Maximum concurrent children watches above limit: > [junit4] 2> > [junit4] 2> 5 /solr/live_nodes > [junit4] 2> 4 /solr/overseer/collection-queue-work > [junit4] 2> 3 /solr/overseer/queue > [junit4] 2> > [junit4] 2> NOTE: reproduce with: ant test > -Dtestcase=TestRandomRequestDistribution -Dtests.method=testRequestTracking > -Dtests.seed=F719E8B96F0F4665 -Dtests.slow=true -Dtests.locale=mk > -Dtests.timezone=Canada/Pacific -Dtests.asserts=true > -Dtests.file.encoding=ISO-8859-1 > [junit4] FAILURE 33.6s J0 | > TestRandomRequestDistribution.testRequestTracking <<< > [junit4] > Throwable #1: java.lang.AssertionError: Shard > a1x2_shard1_replica1 received all 10 requests > [junit4] > at > __randomizedtesting.SeedInfo.seed([F719E8B96F0F4665:BF25B1799B0457F3]:0) > [junit4] > at > org.apache.solr.cloud.TestRandomRequestDistribution.testRequestTracking(TestRandomRequestDistribution.java:109) > [junit4] > at > org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:960) > [junit4] > at > org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:935) > [junit4] > at java.lang.Thread.run(Thread.java:745) > [junit4] 2> 2131592 INFO > (SUITE-TestRandomRequestDistribution-seed#[F719E8B96F0F4665]-worker) > [n:127.0.0.1:51996_ c:b1x1 s:shard1 r:core_node1 x:b1x1_shard1_replica1] > o.a.s.SolrTestCaseJ4 ###deleteCore > [junit4] 2> NOTE: leaving temporary files on disk at: > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestRandomRequestDistribution_F719E8B96F0F4665-001 > [junit4] 2> NOTE: test params are: codec=Asserting(Lucene53), > sim=DefaultSimilarity, locale=mk, timezone=Canada/Pacific > [junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.8.0_45 > (64-bit)/cpus=3,threads=1,free=76690152,total=498073600 > [junit4] 2> NOTE: All tests run in this JVM: [TestBM25SimilarityFactory, > TestExactStatsCache, VersionInfoTest, TestClusterStateMutator, > BlockCacheTest, DataDrivenBlockJoinTest, TimeZoneUtilsTest, CircularListTest, > DocExpirationUpdateProcessorFactoryTest, DirectUpdateHandlerTest, > PingRequestHandlerTest, TestSolrConfigHandlerCloud, > TestAnalyzeInfixSuggestions, TestLRUCache, UnloadDistributedZkTest, > ActionThrottleTest, DistribJoinFromCollectionTest, SynonymTokenizerTest, > HdfsDirectoryFactoryTest, TestTrackingShardHandlerFactory, > BlockDirectoryTest, TestSchemaResource, ZkCLITest, SystemInfoHandlerTest, > ShowFileRequestHandlerTest, TestClassNameShortening, > TestOverriddenPrefixQueryForCustomFieldType, SpatialHeatmapFacetsTest, > TestSolrIndexConfig, TestOmitPositions, TestShortCircuitedRequests, > TestCollationField, SolrIndexSplitterTest, SolrCloudExampleTest, > DocumentAnalysisRequestHandlerTest, ExitableDirectoryReaderTest, > TriLevelCompositeIdRoutingTest, TestRebalanceLeaders, > TestSerializedLuceneMatchVersion, DistributedIntervalFacetingTest, > PrimUtilsTest, TestWordDelimiterFilterFactory, TestSolrCloudWithKerberosAlt, > TestInitQParser, TestDynamicFieldCollectionResource, ResponseHeaderTest, > AlternateDirectoryTest, ParsingFieldUpdateProcessorsTest, TestFunctionQuery, > DistributedQueryComponentCustomSortTest, TestStressVersions, > TestAuthorizationFramework, TestLeaderElectionZkExpiry, ScriptEngineTest, > FieldAnalysisRequestHandlerTest, SimpleFacetsTest, OutputWriterTest, > TestRandomDVFaceting, DocValuesMultiTest, CloudMLTQParserTest, PeerSyncTest, > ChaosMonkeyNothingIsSafeTest, RequestLoggingTest, TestCharFilters, > SolrCoreTest, CursorMarkTest, BJQParserTest, LukeRequestHandlerTest, > TestSearcherReuse, TestPostingsSolrHighlighter, PreAnalyzedFieldTest, > TestIndexSearcher, MultiTermTest, DirectSolrConnectionTest, > TestDownShardTolerantSearch, SuggesterFSTTest, BasicDistributedZkTest, > TestDistributedSearch, PathHierarchyTokenizerFactoryTest, > TestPartialUpdateDeduplication, BadComponentTest, TestWriterPerf, > TestFastLRUCache, TestShardHandlerFactory, DistributedFacetPivotLargeTest, > NumericFieldsTest, SegmentsInfoRequestHandlerTest, TestTrieFacet, > TestRestManager, ClusterStateUpdateTest, UUIDFieldTest, OverseerTest, > TestCollectionAPI, RequiredFieldsTest, > OutOfBoxZkACLAndCredentialsProvidersTest, SolrTestCaseJ4Test, > TestFieldTypeResource, IndexSchemaRuntimeFieldTest, TestLFUCache, > DistanceFunctionTest, AddSchemaFieldsUpdateProcessorFactoryTest, > TestJsonRequest, TestAtomicUpdateErrorCases, TestFaceting, > TestIndexingPerformance, NoCacheHeaderTest, SOLR749Test, SortByFunctionTest, > TestCustomDocTransformer, ZkStateWriterTest, TestCoreContainer, > DistributedFacetPivotLongTailTest, DistributedFacetPivotWhiteBoxTest, > TestComponentsName, AsyncMigrateRouteKeyTest, TestDynamicLoading, > HdfsRecoverLeaseTest, TestExtendedDismaxParser, TestDistributedMissingSort, > TestUniqueKeyFieldResource, TestPhraseSuggestions, LeaderElectionTest, > TestZkChroot, TestRecovery, DistributedSpellCheckComponentTest, > ZkControllerTest, TestStressReorder, HardAutoCommitTest, TestGroupingSearch, > QueryElevationComponentTest, BadIndexSchemaTest, TestSort, TestBadConfig, > OverseerCollectionProcessorTest, SoftAutoCommitTest, > CurrencyFieldXmlFileTest, SimplePostToolTest, AnalysisAfterCoreReloadTest, > SignatureUpdateProcessorFactoryTest, SpellCheckCollatorTest, > TestFoldingMultitermQuery, DocValuesTest, TestStressLucene, TestTrie, > TestCSVLoader, SolrCoreCheckLockOnStartupTest, > DefaultValueUpdateProcessorTest, SolrInfoMBeanTest, DebugComponentTest, > TestSurroundQueryParser, DirectSolrSpellCheckerTest, TestQueryTypes, > XmlUpdateRequestHandlerTest, MoreLikeThisHandlerTest, TestArbitraryIndexDir, > LoggingHandlerTest, SolrPluginUtilsTest, TestJmxIntegration, JSONWriterTest, > MBeansHandlerTest, TestAnalyzedSuggestions, TestPHPSerializedResponseWriter, > TestBinaryResponseWriter, UpdateParamsTest, TestStressRecovery, > TestSolrDeletionPolicy2, SampleTest, TestBinaryField, > TestFuzzyAnalyzedSuggestions, TestXIncludeConfig, > TestSweetSpotSimilarityFactory, TestPerFieldSimilarity, > TestIBSimilarityFactory, TestJmxMonitoredMap, TestSuggestSpellingConverter, > DOMUtilTest, RAMDirectoryFactoryTest, ClusterStateTest, TestDocumentBuilder, > SliceStateTest, FileUtilsTest, TestRTGBase, CursorPagingTest, > TestSimpleTrackingShardHandler, AssignTest, > AsyncCallRequestStatusResponseTest, CleanupOldIndexTest, > CollectionsAPIAsyncDistributedZkTest, CustomCollectionTest, > HttpPartitionTest, MultiThreadedOCPTest, ReplicationFactorTest, > SSLMigrationTest, ShardSplitTest, TestCloudInspectUtil, TestCloudPivotFacet, > TestDistribDocBasedVersion, TestRandomRequestDistribution] > [junit4] Completed [414/507] on J0 in 33.65s, 1 test, 1 failure <<< > FAILURES! > > [...truncated 298 lines...] > BUILD FAILED > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:536: The > following error occurred while executing this line: > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:484: The > following error occurred while executing this line: > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:61: The > following error occurred while executing this line: > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\extra-targets.xml:39: > The following error occurred while executing this line: > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build.xml:230: > The following error occurred while executing this line: > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\common-build.xml:512: > The following error occurred while executing this line: > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:1444: > The following error occurred while executing this line: > C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:999: > There were test failures: 507 suites, 2009 tests, 1 failure, 68 ignored (34 > assumptions) > > Total time: 61 minutes 22 seconds > Build step 'Invoke Ant' marked build as failure > Archiving artifacts > Recording test results > Email was triggered for: Failure - Any > Sending email for trigger: Failure - Any > > > > > --------------------------------------------------------------------- > To unsubscribe, e-mail: [email protected] > For additional commands, e-mail: [email protected]
-- Regards, Shalin Shekhar Mangar. --------------------------------------------------------------------- To unsubscribe, e-mail: [email protected] For additional commands, e-mail: [email protected]
