You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2013/06/27 19:30:04 UTC
[JENKINS] Lucene-Solr-trunk-Windows (64bit/jdk1.7.0_25) - Build #
2977 - Still Failing!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/2977/
Java: 64bit/jdk1.7.0_25 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC
13 tests failed.
REGRESSION: org.apache.solr.cloud.SyncSliceTest.testDistribSearch
Error Message:
shard1 is not consistent. Got 305 from http://127.0.0.1:57973/collection1lastClient and got 256 from http://127.0.0.1:57992/collection1
Stack Trace:
java.lang.AssertionError: shard1 is not consistent. Got 305 from http://127.0.0.1:57973/collection1lastClient and got 256 from http://127.0.0.1:57992/collection1
at __randomizedtesting.SeedInfo.seed([30F6417CE1069825:B110CF649659F819]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.apache.solr.cloud.AbstractFullDistribZkTestBase.checkShardConsistency(AbstractFullDistribZkTestBase.java:1045)
at org.apache.solr.cloud.SyncSliceTest.doTest(SyncSliceTest.java:237)
at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:835)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
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:358)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
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:358)
at java.lang.Thread.run(Thread.java:724)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.hdfs.BasicHdfsTest
Error Message:
access denied ("java.io.FilePermission" "C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test" "write")
Stack Trace:
java.security.AccessControlException: access denied ("java.io.FilePermission" "C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test" "write")
at __randomizedtesting.SeedInfo.seed([30F6417CE1069825]:0)
at java.security.AccessControlContext.checkPermission(AccessControlContext.java:372)
at java.security.AccessController.checkPermission(AccessController.java:559)
at java.lang.SecurityManager.checkPermission(SecurityManager.java:549)
at java.lang.SecurityManager.checkWrite(SecurityManager.java:979)
at java.io.File.canWrite(File.java:750)
at org.apache.hadoop.hdfs.MiniDFSCluster.createPermissionsDiagnosisString(MiniDFSCluster.java:683)
at org.apache.hadoop.hdfs.MiniDFSCluster.initMiniDFSCluster(MiniDFSCluster.java:647)
at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:585)
at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:456)
at org.apache.solr.cloud.hdfs.HdfsTestUtil.setupClass(HdfsTestUtil.java:52)
at org.apache.solr.cloud.hdfs.BasicHdfsTest.setupClass(BasicHdfsTest.java:50)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:677)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
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:358)
at java.lang.Thread.run(Thread.java:724)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.hdfs.HdfsBasicDistributedZk2Test
Error Message:
access denied ("java.io.FilePermission" "C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test" "write")
Stack Trace:
java.security.AccessControlException: access denied ("java.io.FilePermission" "C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test" "write")
at __randomizedtesting.SeedInfo.seed([30F6417CE1069825]:0)
at java.security.AccessControlContext.checkPermission(AccessControlContext.java:372)
at java.security.AccessController.checkPermission(AccessController.java:559)
at java.lang.SecurityManager.checkPermission(SecurityManager.java:549)
at java.lang.SecurityManager.checkWrite(SecurityManager.java:979)
at java.io.File.canWrite(File.java:750)
at org.apache.hadoop.hdfs.MiniDFSCluster.createPermissionsDiagnosisString(MiniDFSCluster.java:683)
at org.apache.hadoop.hdfs.MiniDFSCluster.initMiniDFSCluster(MiniDFSCluster.java:647)
at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:585)
at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:456)
at org.apache.solr.cloud.hdfs.HdfsTestUtil.setupClass(HdfsTestUtil.java:52)
at org.apache.solr.cloud.hdfs.HdfsBasicDistributedZk2Test.setupClass(HdfsBasicDistributedZk2Test.java:41)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:677)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
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:358)
at java.lang.Thread.run(Thread.java:724)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.hdfs.HdfsBasicDistributedZkTest
Error Message:
access denied ("java.io.FilePermission" "C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test" "write")
Stack Trace:
java.security.AccessControlException: access denied ("java.io.FilePermission" "C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test" "write")
at __randomizedtesting.SeedInfo.seed([30F6417CE1069825]:0)
at java.security.AccessControlContext.checkPermission(AccessControlContext.java:372)
at java.security.AccessController.checkPermission(AccessController.java:559)
at java.lang.SecurityManager.checkPermission(SecurityManager.java:549)
at java.lang.SecurityManager.checkWrite(SecurityManager.java:979)
at java.io.File.canWrite(File.java:750)
at org.apache.hadoop.hdfs.MiniDFSCluster.createPermissionsDiagnosisString(MiniDFSCluster.java:683)
at org.apache.hadoop.hdfs.MiniDFSCluster.initMiniDFSCluster(MiniDFSCluster.java:647)
at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:585)
at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:456)
at org.apache.solr.cloud.hdfs.HdfsTestUtil.setupClass(HdfsTestUtil.java:52)
at org.apache.solr.cloud.hdfs.HdfsBasicDistributedZkTest.setupClass(HdfsBasicDistributedZkTest.java:41)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:677)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
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:358)
at java.lang.Thread.run(Thread.java:724)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.hdfs.HdfsChaosMonkeySafeLeaderTest
Error Message:
access denied ("java.io.FilePermission" "C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test" "write")
Stack Trace:
java.security.AccessControlException: access denied ("java.io.FilePermission" "C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test" "write")
at __randomizedtesting.SeedInfo.seed([30F6417CE1069825]:0)
at java.security.AccessControlContext.checkPermission(AccessControlContext.java:372)
at java.security.AccessController.checkPermission(AccessController.java:559)
at java.lang.SecurityManager.checkPermission(SecurityManager.java:549)
at java.lang.SecurityManager.checkWrite(SecurityManager.java:979)
at java.io.File.canWrite(File.java:750)
at org.apache.hadoop.hdfs.MiniDFSCluster.createPermissionsDiagnosisString(MiniDFSCluster.java:683)
at org.apache.hadoop.hdfs.MiniDFSCluster.initMiniDFSCluster(MiniDFSCluster.java:647)
at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:585)
at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:456)
at org.apache.solr.cloud.hdfs.HdfsTestUtil.setupClass(HdfsTestUtil.java:52)
at org.apache.solr.cloud.hdfs.HdfsChaosMonkeySafeLeaderTest.setupClass(HdfsChaosMonkeySafeLeaderTest.java:42)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:677)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
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:358)
at java.lang.Thread.run(Thread.java:724)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest
Error Message:
access denied ("java.io.FilePermission" "C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test" "write")
Stack Trace:
java.security.AccessControlException: access denied ("java.io.FilePermission" "C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test" "write")
at __randomizedtesting.SeedInfo.seed([30F6417CE1069825]:0)
at java.security.AccessControlContext.checkPermission(AccessControlContext.java:372)
at java.security.AccessController.checkPermission(AccessController.java:559)
at java.lang.SecurityManager.checkPermission(SecurityManager.java:549)
at java.lang.SecurityManager.checkWrite(SecurityManager.java:979)
at java.io.File.canWrite(File.java:750)
at org.apache.hadoop.hdfs.MiniDFSCluster.createPermissionsDiagnosisString(MiniDFSCluster.java:683)
at org.apache.hadoop.hdfs.MiniDFSCluster.initMiniDFSCluster(MiniDFSCluster.java:647)
at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:585)
at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:456)
at org.apache.solr.cloud.hdfs.HdfsTestUtil.setupClass(HdfsTestUtil.java:52)
at org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.setupClass(HdfsCollectionsAPIDistributedZkTest.java:41)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:677)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
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:358)
at java.lang.Thread.run(Thread.java:724)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.hdfs.HdfsRecoveryZkTest
Error Message:
access denied ("java.io.FilePermission" "C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test" "write")
Stack Trace:
java.security.AccessControlException: access denied ("java.io.FilePermission" "C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test" "write")
at __randomizedtesting.SeedInfo.seed([30F6417CE1069825]:0)
at java.security.AccessControlContext.checkPermission(AccessControlContext.java:372)
at java.security.AccessController.checkPermission(AccessController.java:559)
at java.lang.SecurityManager.checkPermission(SecurityManager.java:549)
at java.lang.SecurityManager.checkWrite(SecurityManager.java:979)
at java.io.File.canWrite(File.java:750)
at org.apache.hadoop.hdfs.MiniDFSCluster.createPermissionsDiagnosisString(MiniDFSCluster.java:683)
at org.apache.hadoop.hdfs.MiniDFSCluster.initMiniDFSCluster(MiniDFSCluster.java:647)
at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:585)
at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:456)
at org.apache.solr.cloud.hdfs.HdfsTestUtil.setupClass(HdfsTestUtil.java:52)
at org.apache.solr.cloud.hdfs.HdfsRecoveryZkTest.setupClass(HdfsRecoveryZkTest.java:41)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:677)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
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:358)
at java.lang.Thread.run(Thread.java:724)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.hdfs.HdfsSyncSliceTest
Error Message:
access denied ("java.io.FilePermission" "C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test" "write")
Stack Trace:
java.security.AccessControlException: access denied ("java.io.FilePermission" "C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test" "write")
at __randomizedtesting.SeedInfo.seed([30F6417CE1069825]:0)
at java.security.AccessControlContext.checkPermission(AccessControlContext.java:372)
at java.security.AccessController.checkPermission(AccessController.java:559)
at java.lang.SecurityManager.checkPermission(SecurityManager.java:549)
at java.lang.SecurityManager.checkWrite(SecurityManager.java:979)
at java.io.File.canWrite(File.java:750)
at org.apache.hadoop.hdfs.MiniDFSCluster.createPermissionsDiagnosisString(MiniDFSCluster.java:683)
at org.apache.hadoop.hdfs.MiniDFSCluster.initMiniDFSCluster(MiniDFSCluster.java:647)
at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:585)
at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:456)
at org.apache.solr.cloud.hdfs.HdfsTestUtil.setupClass(HdfsTestUtil.java:52)
at org.apache.solr.cloud.hdfs.HdfsSyncSliceTest.setupClass(HdfsSyncSliceTest.java:43)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:677)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
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:358)
at java.lang.Thread.run(Thread.java:724)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.hdfs.HdfsUnloadDistributedZkTest
Error Message:
access denied ("java.io.FilePermission" "C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test" "write")
Stack Trace:
java.security.AccessControlException: access denied ("java.io.FilePermission" "C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test" "write")
at __randomizedtesting.SeedInfo.seed([30F6417CE1069825]:0)
at java.security.AccessControlContext.checkPermission(AccessControlContext.java:372)
at java.security.AccessController.checkPermission(AccessController.java:559)
at java.lang.SecurityManager.checkPermission(SecurityManager.java:549)
at java.lang.SecurityManager.checkWrite(SecurityManager.java:979)
at java.io.File.canWrite(File.java:750)
at org.apache.hadoop.hdfs.MiniDFSCluster.createPermissionsDiagnosisString(MiniDFSCluster.java:683)
at org.apache.hadoop.hdfs.MiniDFSCluster.initMiniDFSCluster(MiniDFSCluster.java:647)
at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:585)
at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:456)
at org.apache.solr.cloud.hdfs.HdfsTestUtil.setupClass(HdfsTestUtil.java:52)
at org.apache.solr.cloud.hdfs.HdfsUnloadDistributedZkTest.setupClass(HdfsUnloadDistributedZkTest.java:44)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:677)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
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:358)
at java.lang.Thread.run(Thread.java:724)
FAILED: junit.framework.TestSuite.org.apache.solr.search.TestRecoveryHdfs
Error Message:
access denied ("java.io.FilePermission" "C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test" "write")
Stack Trace:
java.security.AccessControlException: access denied ("java.io.FilePermission" "C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test" "write")
at __randomizedtesting.SeedInfo.seed([30F6417CE1069825]:0)
at java.security.AccessControlContext.checkPermission(AccessControlContext.java:372)
at java.security.AccessController.checkPermission(AccessController.java:559)
at java.lang.SecurityManager.checkPermission(SecurityManager.java:549)
at java.lang.SecurityManager.checkWrite(SecurityManager.java:979)
at java.io.File.canWrite(File.java:750)
at org.apache.hadoop.hdfs.MiniDFSCluster.createPermissionsDiagnosisString(MiniDFSCluster.java:683)
at org.apache.hadoop.hdfs.MiniDFSCluster.initMiniDFSCluster(MiniDFSCluster.java:647)
at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:585)
at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:456)
at org.apache.solr.cloud.hdfs.HdfsTestUtil.setupClass(HdfsTestUtil.java:52)
at org.apache.solr.search.TestRecoveryHdfs.beforeClass(TestRecoveryHdfs.java:78)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:677)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
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:358)
at java.lang.Thread.run(Thread.java:724)
FAILED: org.apache.solr.store.blockcache.BlockDirectoryTest.testEOF
Error Message:
Unable to delete file: .\org.apache.solr.store.hdfs.HdfsDirectory-1372354167990\normal\test.eof
Stack Trace:
java.io.IOException: Unable to delete file: .\org.apache.solr.store.hdfs.HdfsDirectory-1372354167990\normal\test.eof
at __randomizedtesting.SeedInfo.seed([30F6417CE1069825:A19D0374A3223E59]:0)
at org.apache.commons.io.FileUtils.forceDelete(FileUtils.java:1919)
at org.apache.commons.io.FileUtils.cleanDirectory(FileUtils.java:1399)
at org.apache.commons.io.FileUtils.deleteDirectory(FileUtils.java:1331)
at org.apache.commons.io.FileUtils.forceDelete(FileUtils.java:1910)
at org.apache.commons.io.FileUtils.cleanDirectory(FileUtils.java:1399)
at org.apache.commons.io.FileUtils.deleteDirectory(FileUtils.java:1331)
at org.apache.solr.store.blockcache.BlockDirectoryTest.tearDown(BlockDirectoryTest.java:118)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:795)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
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:358)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
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:358)
at java.lang.Thread.run(Thread.java:724)
FAILED: junit.framework.TestSuite.org.apache.solr.store.hdfs.HdfsDirectoryTest
Error Message:
access denied ("java.io.FilePermission" "C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test" "write")
Stack Trace:
java.security.AccessControlException: access denied ("java.io.FilePermission" "C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test" "write")
at __randomizedtesting.SeedInfo.seed([30F6417CE1069825]:0)
at java.security.AccessControlContext.checkPermission(AccessControlContext.java:372)
at java.security.AccessController.checkPermission(AccessController.java:559)
at java.lang.SecurityManager.checkPermission(SecurityManager.java:549)
at java.lang.SecurityManager.checkWrite(SecurityManager.java:979)
at java.io.File.canWrite(File.java:750)
at org.apache.hadoop.hdfs.MiniDFSCluster.createPermissionsDiagnosisString(MiniDFSCluster.java:683)
at org.apache.hadoop.hdfs.MiniDFSCluster.initMiniDFSCluster(MiniDFSCluster.java:647)
at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:585)
at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:456)
at org.apache.solr.cloud.hdfs.HdfsTestUtil.setupClass(HdfsTestUtil.java:52)
at org.apache.solr.store.hdfs.HdfsDirectoryTest.beforeClass(HdfsDirectoryTest.java:62)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:677)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
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:358)
at java.lang.Thread.run(Thread.java:724)
FAILED: junit.framework.TestSuite.org.apache.solr.store.hdfs.HdfsLockFactoryTest
Error Message:
access denied ("java.io.FilePermission" "C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test" "write")
Stack Trace:
java.security.AccessControlException: access denied ("java.io.FilePermission" "C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test" "write")
at __randomizedtesting.SeedInfo.seed([30F6417CE1069825]:0)
at java.security.AccessControlContext.checkPermission(AccessControlContext.java:372)
at java.security.AccessController.checkPermission(AccessController.java:559)
at java.lang.SecurityManager.checkPermission(SecurityManager.java:549)
at java.lang.SecurityManager.checkWrite(SecurityManager.java:979)
at java.io.File.canWrite(File.java:750)
at org.apache.hadoop.hdfs.MiniDFSCluster.createPermissionsDiagnosisString(MiniDFSCluster.java:683)
at org.apache.hadoop.hdfs.MiniDFSCluster.initMiniDFSCluster(MiniDFSCluster.java:647)
at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:585)
at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:456)
at org.apache.solr.cloud.hdfs.HdfsTestUtil.setupClass(HdfsTestUtil.java:52)
at org.apache.solr.store.hdfs.HdfsLockFactoryTest.beforeClass(HdfsLockFactoryTest.java:47)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:677)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
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:358)
at java.lang.Thread.run(Thread.java:724)
Build Log:
[...truncated 9181 lines...]
[junit4:junit4] Suite: org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest
[junit4:junit4] 2> 413104 T693 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /c_us/
[junit4:junit4] 2> 414976 T693 oahu.NativeCodeLoader.<clinit> WARN Unable to load native-hadoop library for your platform... using builtin-java classes where applicable
[junit4:junit4] 2> 415508 T693 oahc.Configuration.warnOnceIfDeprecated WARN hadoop.configured.node.mapping is deprecated. Instead, use net.topology.configured.node.mapping
[junit4:junit4] 2> 416506 T693 oahmi.MetricsConfig.loadFirst WARN Cannot locate configuration: tried hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
[junit4:junit4] 2> 418327 T693 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4:junit4] 1> Formatting using clusterid: testClusterID
[junit4:junit4] 2> NOTE: test params are: codec=Lucene42: {}, docValues:{}, sim=DefaultSimilarity, locale=zh_CN, timezone=Asia/Urumqi
[junit4:junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.7.0_25 (64-bit)/cpus=2,threads=2,free=79399712,total=160317440
[junit4:junit4] 2> NOTE: All tests run in this JVM: [UniqFieldsUpdateProcessorFactoryTest, TestElisionMultitermQuery, PrimUtilsTest, JsonLoaderTest, UpdateParamsTest, TestCoreContainer, SolrRequestParserTest, DirectSolrConnectionTest, DebugComponentTest, TestIndexSearcher, TestUpdate, LeaderElectionIntegrationTest, TestCharFilters, UUIDFieldTest, DisMaxRequestHandlerTest, TestConfig, TestRemoteStreaming, BasicDistributedZkTest, TestReversedWildcardFilterFactory, AutoCommitTest, OpenExchangeRatesOrgProviderTest, CircularListTest, SortByFunctionTest, ZkSolrClientTest, DocValuesTest, NotRequiredUniqueKeyTest, HdfsCollectionsAPIDistributedZkTest]
[junit4:junit4] 2> NOTE: reproduce with: ant test -Dtestcase=HdfsCollectionsAPIDistributedZkTest -Dtests.seed=30F6417CE1069825 -Dtests.slow=true -Dtests.locale=zh_CN -Dtests.timezone=Asia/Urumqi -Dtests.file.encoding=Cp1252
[junit4:junit4] ERROR 0.00s | HdfsCollectionsAPIDistributedZkTest (suite) <<<
[junit4:junit4] > Throwable #1: java.security.AccessControlException: access denied ("java.io.FilePermission" "C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test" "write")
[junit4:junit4] > at __randomizedtesting.SeedInfo.seed([30F6417CE1069825]:0)
[junit4:junit4] > at java.security.AccessControlContext.checkPermission(AccessControlContext.java:372)
[junit4:junit4] > at java.security.AccessController.checkPermission(AccessController.java:559)
[junit4:junit4] > at java.lang.SecurityManager.checkPermission(SecurityManager.java:549)
[junit4:junit4] > at java.lang.SecurityManager.checkWrite(SecurityManager.java:979)
[junit4:junit4] > at java.io.File.canWrite(File.java:750)
[junit4:junit4] > at org.apache.hadoop.hdfs.MiniDFSCluster.createPermissionsDiagnosisString(MiniDFSCluster.java:683)
[junit4:junit4] > at org.apache.hadoop.hdfs.MiniDFSCluster.initMiniDFSCluster(MiniDFSCluster.java:647)
[junit4:junit4] > at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:585)
[junit4:junit4] > at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:456)
[junit4:junit4] > at org.apache.solr.cloud.hdfs.HdfsTestUtil.setupClass(HdfsTestUtil.java:52)
[junit4:junit4] > at org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.setupClass(HdfsCollectionsAPIDistributedZkTest.java:41)
[junit4:junit4] > at java.lang.Thread.run(Thread.java:724)
[junit4:junit4] Completed in 5.34s, 0 tests, 1 error <<< FAILURES!
[...truncated 136 lines...]
[junit4:junit4] Suite: org.apache.solr.cloud.hdfs.HdfsChaosMonkeySafeLeaderTest
[junit4:junit4] 2> 666706 T1283 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /zfj/lg
[junit4:junit4] 2> 666796 T1283 oahmi.MetricsConfig.loadFirst WARN Cannot locate configuration: tried hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
[junit4:junit4] 2> 666873 T1283 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4:junit4] 1> Formatting using clusterid: testClusterID
[junit4:junit4] 2> NOTE: test params are: codec=Lucene42: {}, docValues:{}, sim=DefaultSimilarity, locale=ja_JP, timezone=America/Costa_Rica
[junit4:junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.7.0_25 (64-bit)/cpus=2,threads=1,free=84293160,total=224100352
[junit4:junit4] 2> NOTE: All tests run in this JVM: [UniqFieldsUpdateProcessorFactoryTest, TestElisionMultitermQuery, PrimUtilsTest, JsonLoaderTest, UpdateParamsTest, TestCoreContainer, SolrRequestParserTest, DirectSolrConnectionTest, DebugComponentTest, TestIndexSearcher, TestUpdate, LeaderElectionIntegrationTest, TestCharFilters, UUIDFieldTest, DisMaxRequestHandlerTest, TestConfig, TestRemoteStreaming, BasicDistributedZkTest, TestReversedWildcardFilterFactory, AutoCommitTest, OpenExchangeRatesOrgProviderTest, CircularListTest, SortByFunctionTest, ZkSolrClientTest, DocValuesTest, NotRequiredUniqueKeyTest, HdfsCollectionsAPIDistributedZkTest, NoCacheHeaderTest, TestValueSourceCache, PingRequestHandlerTest, BasicDistributedZk2Test, TestWriterPerf, OutputWriterTest, ClusterStateTest, QueryResultKeyTest, IndexBasedSpellCheckerTest, TestReloadAndDeleteDocs, TestSearchPerf, StandardRequestHandlerTest, CSVRequestHandlerTest, DocumentAnalysisRequestHandlerTest, TestPostingsSolrHighlighter, RequestHandlersTest, TestCSVLoader, SolrCoreCheckLockOnStartupTest, CoreContainerCoreInitFailuresTest, TestRecovery, ResponseLogComponentTest, DistanceFunctionTest, TestSchemaResource, TestUtils, TestCloudManagedSchema, TestAnalyzedSuggestions, TestRTGBase, MBeansHandlerTest, SignatureUpdateProcessorFactoryTest, TestTrie, TestSolrDeletionPolicy1, TestPerFieldSimilarity, TestFastWriter, SystemInfoHandlerTest, TestSurroundQueryParser, SuggesterTSTTest, BadIndexSchemaTest, TestSolrQueryParserDefaultOperatorResource, TestDefaultSearchFieldResource, TestDynamicFieldCollectionResource, ReturnFieldsTest, HdfsChaosMonkeySafeLeaderTest]
[junit4:junit4] 2> NOTE: reproduce with: ant test -Dtestcase=HdfsChaosMonkeySafeLeaderTest -Dtests.seed=30F6417CE1069825 -Dtests.slow=true -Dtests.locale=ja_JP -Dtests.timezone=America/Costa_Rica -Dtests.file.encoding=Cp1252
[junit4:junit4] ERROR 0.00s | HdfsChaosMonkeySafeLeaderTest (suite) <<<
[junit4:junit4] > Throwable #1: java.security.AccessControlException: access denied ("java.io.FilePermission" "C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test" "write")
[junit4:junit4] > at __randomizedtesting.SeedInfo.seed([30F6417CE1069825]:0)
[junit4:junit4] > at java.security.AccessControlContext.checkPermission(AccessControlContext.java:372)
[junit4:junit4] > at java.security.AccessController.checkPermission(AccessController.java:559)
[junit4:junit4] > at java.lang.SecurityManager.checkPermission(SecurityManager.java:549)
[junit4:junit4] > at java.lang.SecurityManager.checkWrite(SecurityManager.java:979)
[junit4:junit4] > at java.io.File.canWrite(File.java:750)
[junit4:junit4] > at org.apache.hadoop.hdfs.MiniDFSCluster.createPermissionsDiagnosisString(MiniDFSCluster.java:683)
[junit4:junit4] > at org.apache.hadoop.hdfs.MiniDFSCluster.initMiniDFSCluster(MiniDFSCluster.java:647)
[junit4:junit4] > at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:585)
[junit4:junit4] > at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:456)
[junit4:junit4] > at org.apache.solr.cloud.hdfs.HdfsTestUtil.setupClass(HdfsTestUtil.java:52)
[junit4:junit4] > at org.apache.solr.cloud.hdfs.HdfsChaosMonkeySafeLeaderTest.setupClass(HdfsChaosMonkeySafeLeaderTest.java:42)
[junit4:junit4] > at java.lang.Thread.run(Thread.java:724)
[junit4:junit4] Completed in 0.20s, 0 tests, 1 error <<< FAILURES!
[...truncated 58 lines...]
[junit4:junit4] Suite: org.apache.solr.cloud.hdfs.BasicHdfsTest
[junit4:junit4] 2> 704915 T1498 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /w/hb
[junit4:junit4] 2> 705016 T1498 oahmi.MetricsConfig.loadFirst WARN Cannot locate configuration: tried hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
[junit4:junit4] 2> 705109 T1498 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4:junit4] 1> Formatting using clusterid: testClusterID
[junit4:junit4] 2> NOTE: test params are: codec=Lucene42: {}, docValues:{}, sim=DefaultSimilarity, locale=et_EE, timezone=MET
[junit4:junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.7.0_25 (64-bit)/cpus=2,threads=1,free=109278328,total=265248768
[junit4:junit4] 2> NOTE: All tests run in this JVM: [UniqFieldsUpdateProcessorFactoryTest, TestElisionMultitermQuery, PrimUtilsTest, JsonLoaderTest, UpdateParamsTest, TestCoreContainer, SolrRequestParserTest, DirectSolrConnectionTest, DebugComponentTest, TestIndexSearcher, TestUpdate, LeaderElectionIntegrationTest, TestCharFilters, UUIDFieldTest, DisMaxRequestHandlerTest, TestConfig, TestRemoteStreaming, BasicDistributedZkTest, TestReversedWildcardFilterFactory, AutoCommitTest, OpenExchangeRatesOrgProviderTest, CircularListTest, SortByFunctionTest, ZkSolrClientTest, DocValuesTest, NotRequiredUniqueKeyTest, HdfsCollectionsAPIDistributedZkTest, NoCacheHeaderTest, TestValueSourceCache, PingRequestHandlerTest, BasicDistributedZk2Test, TestWriterPerf, OutputWriterTest, ClusterStateTest, QueryResultKeyTest, IndexBasedSpellCheckerTest, TestReloadAndDeleteDocs, TestSearchPerf, StandardRequestHandlerTest, CSVRequestHandlerTest, DocumentAnalysisRequestHandlerTest, TestPostingsSolrHighlighter, RequestHandlersTest, TestCSVLoader, SolrCoreCheckLockOnStartupTest, CoreContainerCoreInitFailuresTest, TestRecovery, ResponseLogComponentTest, DistanceFunctionTest, TestSchemaResource, TestUtils, TestCloudManagedSchema, TestAnalyzedSuggestions, TestRTGBase, MBeansHandlerTest, SignatureUpdateProcessorFactoryTest, TestTrie, TestSolrDeletionPolicy1, TestPerFieldSimilarity, TestFastWriter, SystemInfoHandlerTest, TestSurroundQueryParser, SuggesterTSTTest, BadIndexSchemaTest, TestSolrQueryParserDefaultOperatorResource, TestDefaultSearchFieldResource, TestDynamicFieldCollectionResource, ReturnFieldsTest, HdfsChaosMonkeySafeLeaderTest, TestQuerySenderListener, TestManagedSchemaFieldResource, TestFuzzyAnalyzedSuggestions, SpellPossibilityIteratorTest, DistributedQueryElevationComponentTest, QueryElevationComponentTest, TestQuerySenderNoQuery, SpellingQueryConverterTest, TestOmitPositions, FastVectorHighlighterTest, TestComponentsName, ExternalFileFieldSortTest, SuggesterFSTTest, TestPhraseSuggestions, TestIBSimilarityFactory, TestFieldResource, TestSolrQueryParser, TestDynamicFieldResource, BasicHdfsTest]
[junit4:junit4] 2> NOTE: reproduce with: ant test -Dtestcase=BasicHdfsTest -Dtests.seed=30F6417CE1069825 -Dtests.slow=true -Dtests.locale=et_EE -Dtests.timezone=MET -Dtests.file.encoding=Cp1252
[junit4:junit4] ERROR 0.00s | BasicHdfsTest (suite) <<<
[junit4:junit4] > Throwable #1: java.security.AccessControlException: access denied ("java.io.FilePermission" "C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test" "write")
[junit4:junit4] > at __randomizedtesting.SeedInfo.seed([30F6417CE1069825]:0)
[junit4:junit4] > at java.security.AccessControlContext.checkPermission(AccessControlContext.java:372)
[junit4:junit4] > at java.security.AccessController.checkPermission(AccessController.java:559)
[junit4:junit4] > at java.lang.SecurityManager.checkPermission(SecurityManager.java:549)
[junit4:junit4] > at java.lang.SecurityManager.checkWrite(SecurityManager.java:979)
[junit4:junit4] > at java.io.File.canWrite(File.java:750)
[junit4:junit4] > at org.apache.hadoop.hdfs.MiniDFSCluster.createPermissionsDiagnosisString(MiniDFSCluster.java:683)
[junit4:junit4] > at org.apache.hadoop.hdfs.MiniDFSCluster.initMiniDFSCluster(MiniDFSCluster.java:647)
[junit4:junit4] > at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:585)
[junit4:junit4] > at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:456)
[junit4:junit4] > at org.apache.solr.cloud.hdfs.HdfsTestUtil.setupClass(HdfsTestUtil.java:52)
[junit4:junit4] > at org.apache.solr.cloud.hdfs.BasicHdfsTest.setupClass(BasicHdfsTest.java:50)
[junit4:junit4] > at java.lang.Thread.run(Thread.java:724)
[junit4:junit4] Completed in 0.24s, 0 tests, 1 error <<< FAILURES!
[...truncated 78 lines...]
[junit4:junit4] Suite: org.apache.solr.search.TestRecoveryHdfs
[junit4:junit4] 2> 838776 T2132 oahmi.MetricsConfig.loadFirst WARN Cannot locate configuration: tried hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
[junit4:junit4] 2> 838867 T2132 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4:junit4] 1> Formatting using clusterid: testClusterID
[junit4:junit4] 2> NOTE: test params are: codec=Lucene42: {}, docValues:{}, sim=DefaultSimilarity, locale=ru_RU, timezone=America/Marigot
[junit4:junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.7.0_25 (64-bit)/cpus=2,threads=1,free=106908200,total=265248768
[junit4:junit4] 2> NOTE: All tests run in this JVM: [UniqFieldsUpdateProcessorFactoryTest, TestElisionMultitermQuery, PrimUtilsTest, JsonLoaderTest, UpdateParamsTest, TestCoreContainer, SolrRequestParserTest, DirectSolrConnectionTest, DebugComponentTest, TestIndexSearcher, TestUpdate, LeaderElectionIntegrationTest, TestCharFilters, UUIDFieldTest, DisMaxRequestHandlerTest, TestConfig, TestRemoteStreaming, BasicDistributedZkTest, TestReversedWildcardFilterFactory, AutoCommitTest, OpenExchangeRatesOrgProviderTest, CircularListTest, SortByFunctionTest, ZkSolrClientTest, DocValuesTest, NotRequiredUniqueKeyTest, HdfsCollectionsAPIDistributedZkTest, NoCacheHeaderTest, TestValueSourceCache, PingRequestHandlerTest, BasicDistributedZk2Test, TestWriterPerf, OutputWriterTest, ClusterStateTest, QueryResultKeyTest, IndexBasedSpellCheckerTest, TestReloadAndDeleteDocs, TestSearchPerf, StandardRequestHandlerTest, CSVRequestHandlerTest, DocumentAnalysisRequestHandlerTest, TestPostingsSolrHighlighter, RequestHandlersTest, TestCSVLoader, SolrCoreCheckLockOnStartupTest, CoreContainerCoreInitFailuresTest, TestRecovery, ResponseLogComponentTest, DistanceFunctionTest, TestSchemaResource, TestUtils, TestCloudManagedSchema, TestAnalyzedSuggestions, TestRTGBase, MBeansHandlerTest, SignatureUpdateProcessorFactoryTest, TestTrie, TestSolrDeletionPolicy1, TestPerFieldSimilarity, TestFastWriter, SystemInfoHandlerTest, TestSurroundQueryParser, SuggesterTSTTest, BadIndexSchemaTest, TestSolrQueryParserDefaultOperatorResource, TestDefaultSearchFieldResource, TestDynamicFieldCollectionResource, ReturnFieldsTest, HdfsChaosMonkeySafeLeaderTest, TestQuerySenderListener, TestManagedSchemaFieldResource, TestFuzzyAnalyzedSuggestions, SpellPossibilityIteratorTest, DistributedQueryElevationComponentTest, QueryElevationComponentTest, TestQuerySenderNoQuery, SpellingQueryConverterTest, TestOmitPositions, FastVectorHighlighterTest, TestComponentsName, ExternalFileFieldSortTest, SuggesterFSTTest, TestPhraseSuggestions, TestIBSimilarityFactory, TestFieldResource, TestSolrQueryParser, TestDynamicFieldResource, BasicHdfsTest, SpellCheckComponentTest, TestExtendedDismaxParser, ConvertedLegacyTest, TestLuceneMatchVersion, SpellCheckCollatorTest, SolrInfoMBeanTest, SchemaVersionSpecificBehaviorTest, DirectUpdateHandlerOptimizeTest, TestSchemaVersionResource, SynonymTokenizerTest, TestSchemaNameResource, LukeRequestHandlerTest, TestFieldCollectionResource, SoftAutoCommitTest, TermVectorComponentDistributedTest, TestFieldTypeCollectionResource, TestBadConfig, OverseerTest, ChaosMonkeyNothingIsSafeTest, TestSolrCoreProperties, TestJmxMonitoredMap, TestMergePolicyConfig, TestRecoveryHdfs]
[junit4:junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestRecoveryHdfs -Dtests.seed=30F6417CE1069825 -Dtests.slow=true -Dtests.locale=ru_RU -Dtests.timezone=America/Marigot -Dtests.file.encoding=Cp1252
[junit4:junit4] ERROR 0.00s | TestRecoveryHdfs (suite) <<<
[junit4:junit4] > Throwable #1: java.security.AccessControlException: access denied ("java.io.FilePermission" "C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test" "write")
[junit4:junit4] > at __randomizedtesting.SeedInfo.seed([30F6417CE1069825]:0)
[junit4:junit4] > at java.security.AccessControlContext.checkPermission(AccessControlContext.java:372)
[junit4:junit4] > at java.security.AccessController.checkPermission(AccessController.java:559)
[junit4:junit4] > at java.lang.SecurityManager.checkPermission(SecurityManager.java:549)
[junit4:junit4] > at java.lang.SecurityManager.checkWrite(SecurityManager.java:979)
[junit4:junit4] > at java.io.File.canWrite(File.java:750)
[junit4:junit4] > at org.apache.hadoop.hdfs.MiniDFSCluster.createPermissionsDiagnosisString(MiniDFSCluster.java:683)
[junit4:junit4] > at org.apache.hadoop.hdfs.MiniDFSCluster.initMiniDFSCluster(MiniDFSCluster.java:647)
[junit4:junit4] > at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:585)
[junit4:junit4] > at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:456)
[junit4:junit4] > at org.apache.solr.cloud.hdfs.HdfsTestUtil.setupClass(HdfsTestUtil.java:52)
[junit4:junit4] > at org.apache.solr.search.TestRecoveryHdfs.beforeClass(TestRecoveryHdfs.java:78)
[junit4:junit4] > at java.lang.Thread.run(Thread.java:724)
[junit4:junit4] Completed in 0.22s, 0 tests, 1 error <<< FAILURES!
[...truncated 29 lines...]
[junit4:junit4] Suite: org.apache.solr.cloud.hdfs.HdfsSyncSliceTest
[junit4:junit4] 2> 987774 T2454 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /m_fy/iv
[junit4:junit4] 2> 987890 T2454 oahmi.MetricsConfig.loadFirst WARN Cannot locate configuration: tried hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
[junit4:junit4] 2> 988000 T2454 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4:junit4] 1> Formatting using clusterid: testClusterID
[junit4:junit4] 2> NOTE: test params are: codec=Lucene42: {}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=false,coord=yes): {}, locale=es_EC, timezone=Asia/Tehran
[junit4:junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.7.0_25 (64-bit)/cpus=2,threads=1,free=79969520,total=286031872
[junit4:junit4] 2> NOTE: All tests run in this JVM: [UniqFieldsUpdateProcessorFactoryTest, TestElisionMultitermQuery, PrimUtilsTest, JsonLoaderTest, UpdateParamsTest, TestCoreContainer, SolrRequestParserTest, DirectSolrConnectionTest, DebugComponentTest, TestIndexSearcher, TestUpdate, LeaderElectionIntegrationTest, TestCharFilters, UUIDFieldTest, DisMaxRequestHandlerTest, TestConfig, TestRemoteStreaming, BasicDistributedZkTest, TestReversedWildcardFilterFactory, AutoCommitTest, OpenExchangeRatesOrgProviderTest, CircularListTest, SortByFunctionTest, ZkSolrClientTest, DocValuesTest, NotRequiredUniqueKeyTest, HdfsCollectionsAPIDistributedZkTest, NoCacheHeaderTest, TestValueSourceCache, PingRequestHandlerTest, BasicDistributedZk2Test, TestWriterPerf, OutputWriterTest, ClusterStateTest, QueryResultKeyTest, IndexBasedSpellCheckerTest, TestReloadAndDeleteDocs, TestSearchPerf, StandardRequestHandlerTest, CSVRequestHandlerTest, DocumentAnalysisRequestHandlerTest, TestPostingsSolrHighlighter, RequestHandlersTest, TestCSVLoader, SolrCoreCheckLockOnStartupTest, CoreContainerCoreInitFailuresTest, TestRecovery, ResponseLogComponentTest, DistanceFunctionTest, TestSchemaResource, TestUtils, TestCloudManagedSchema, TestAnalyzedSuggestions, TestRTGBase, MBeansHandlerTest, SignatureUpdateProcessorFactoryTest, TestTrie, TestSolrDeletionPolicy1, TestPerFieldSimilarity, TestFastWriter, SystemInfoHandlerTest, TestSurroundQueryParser, SuggesterTSTTest, BadIndexSchemaTest, TestSolrQueryParserDefaultOperatorResource, TestDefaultSearchFieldResource, TestDynamicFieldCollectionResource, ReturnFieldsTest, HdfsChaosMonkeySafeLeaderTest, TestQuerySenderListener, TestManagedSchemaFieldResource, TestFuzzyAnalyzedSuggestions, SpellPossibilityIteratorTest, DistributedQueryElevationComponentTest, QueryElevationComponentTest, TestQuerySenderNoQuery, SpellingQueryConverterTest, TestOmitPositions, FastVectorHighlighterTest, TestComponentsName, ExternalFileFieldSortTest, SuggesterFSTTest, TestPhraseSuggestions, TestIBSimilarityFactory, TestFieldResource, TestSolrQueryParser, TestDynamicFieldResource, BasicHdfsTest, SpellCheckComponentTest, TestExtendedDismaxParser, ConvertedLegacyTest, TestLuceneMatchVersion, SpellCheckCollatorTest, SolrInfoMBeanTest, SchemaVersionSpecificBehaviorTest, DirectUpdateHandlerOptimizeTest, TestSchemaVersionResource, SynonymTokenizerTest, TestSchemaNameResource, LukeRequestHandlerTest, TestFieldCollectionResource, SoftAutoCommitTest, TermVectorComponentDistributedTest, TestFieldTypeCollectionResource, TestBadConfig, OverseerTest, ChaosMonkeyNothingIsSafeTest, TestSolrCoreProperties, TestJmxMonitoredMap, TestMergePolicyConfig, TestRecoveryHdfs, CurrencyFieldXmlFileTest, TestRangeQuery, ResourceLoaderTest, LeaderElectionTest, TestRandomFaceting, TestSerializedLuceneMatchVersion, MultiTermTest, HdfsSyncSliceTest]
[junit4:junit4] 2> NOTE: reproduce with: ant test -Dtestcase=HdfsSyncSliceTest -Dtests.seed=30F6417CE1069825 -Dtests.slow=true -Dtests.locale=es_EC -Dtests.timezone=Asia/Tehran -Dtests.file.encoding=Cp1252
[junit4:junit4] ERROR 0.00s | HdfsSyncSliceTest (suite) <<<
[junit4:junit4] > Throwable #1: java.security.AccessControlException: access denied ("java.io.FilePermission" "C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test" "write")
[junit4:junit4] > at __randomizedtesting.SeedInfo.seed([30F6417CE1069825]:0)
[junit4:junit4] > at java.security.AccessControlContext.checkPermission(AccessControlContext.java:372)
[junit4:junit4] > at java.security.AccessController.checkPermission(AccessController.java:559)
[junit4:junit4] > at java.lang.SecurityManager.checkPermission(SecurityManager.java:549)
[junit4:junit4] > at java.lang.SecurityManager.checkWrite(SecurityManager.java:979)
[junit4:junit4] > at java.io.File.canWrite(File.java:750)
[junit4:junit4] > at org.apache.hadoop.hdfs.MiniDFSCluster.createPermissionsDiagnosisString(MiniDFSCluster.java:683)
[junit4:junit4] > at org.apache.hadoop.hdfs.MiniDFSCluster.initMiniDFSCluster(MiniDFSCluster.java:647)
[junit4:junit4] > at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:585)
[junit4:junit4] > at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:456)
[junit4:junit4] > at org.apache.solr.cloud.hdfs.HdfsTestUtil.setupClass(HdfsTestUtil.java:52)
[junit4:junit4] > at org.apache.solr.cloud.hdfs.HdfsSyncSliceTest.setupClass(HdfsSyncSliceTest.java:43)
[junit4:junit4] > at java.lang.Thread.run(Thread.java:724)
[junit4:junit4] Completed in 0.26s, 0 tests, 1 error <<< FAILURES!
[...truncated 22 lines...]
[junit4:junit4] Suite: org.apache.solr.cloud.SyncSliceTest
[junit4:junit4] 2> 1066428 T2695 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /
[junit4:junit4] 2> 1066432 T2695 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
[junit4:junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-SyncSliceTest-1372352519104
[junit4:junit4] 2> 1066435 T2695 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4:junit4] 2> 1066435 T2696 oasc.ZkTestServer$ZKServerMain.runFromConfig Starting server
[junit4:junit4] 2> 1066536 T2695 oasc.ZkTestServer.run start zk server on port:57954
[junit4:junit4] 2> 1066538 T2695 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4] 2> 1066551 T2702 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@77f8523 name:ZooKeeperConnection Watcher:127.0.0.1:57954 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4] 2> 1066551 T2695 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4] 2> 1066552 T2695 oascc.SolrZkClient.makePath makePath: /solr
[junit4:junit4] 2> 1066559 T2695 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4] 2> 1066562 T2704 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@67647056 name:ZooKeeperConnection Watcher:127.0.0.1:57954/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4] 2> 1066563 T2695 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4] 2> 1066563 T2695 oascc.SolrZkClient.makePath makePath: /collections/collection1
[junit4:junit4] 2> 1066570 T2695 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards
[junit4:junit4] 2> 1066575 T2695 oascc.SolrZkClient.makePath makePath: /collections/control_collection
[junit4:junit4] 2> 1066582 T2695 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards
[junit4:junit4] 2> 1066594 T2695 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\conf\solrconfig-tlog.xml to /configs/conf1/solrconfig.xml
[junit4:junit4] 2> 1066595 T2695 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4:junit4] 2> 1066603 T2695 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\conf\schema.xml to /configs/conf1/schema.xml
[junit4:junit4] 2> 1066604 T2695 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml
[junit4:junit4] 2> 1066610 T2695 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\conf\stopwords.txt to /configs/conf1/stopwords.txt
[junit4:junit4] 2> 1066610 T2695 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt
[junit4:junit4] 2> 1066616 T2695 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\conf\protwords.txt to /configs/conf1/protwords.txt
[junit4:junit4] 2> 1066617 T2695 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt
[junit4:junit4] 2> 1066621 T2695 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\conf\currency.xml to /configs/conf1/currency.xml
[junit4:junit4] 2> 1066622 T2695 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml
[junit4:junit4] 2> 1066628 T2695 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\conf\open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
[junit4:junit4] 2> 1066629 T2695 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json
[junit4:junit4] 2> 1066634 T2695 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\conf\mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4:junit4] 2> 1066634 T2695 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4:junit4] 2> 1066638 T2695 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\conf\old_synonyms.txt to /configs/conf1/old_synonyms.txt
[junit4:junit4] 2> 1066640 T2695 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt
[junit4:junit4] 2> 1066645 T2695 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\conf\synonyms.txt to /configs/conf1/synonyms.txt
[junit4:junit4] 2> 1066645 T2695 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt
[junit4:junit4] 2> 1066652 T2697 oazs.NIOServerCnxn.doIO WARN caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x13f86959bc90001, likely client has closed socket
[junit4:junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:220)
[junit4:junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4:junit4] 2> at java.lang.Thread.run(Thread.java:724)
[junit4:junit4] 2>
[junit4:junit4] 2> 1067096 T2695 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4:junit4] 2> 1067106 T2695 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:57961
[junit4:junit4] 2> 1067106 T2695 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4] 2> 1067107 T2695 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4] 2> 1067107 T2695 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-controljetty-1372352519322
[junit4:junit4] 2> 1067107 T2695 oasc.CoreContainer$Initializer.initialize looking for solr config file: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-controljetty-1372352519322\solr.xml
[junit4:junit4] 2> 1067108 T2695 oasc.CoreContainer.<init> New CoreContainer 1182821619
[junit4:junit4] 2> 1067108 T2695 oasc.CoreContainer.load Loading CoreContainer using Solr Home: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-controljetty-1372352519322\'
[junit4:junit4] 2> 1067109 T2695 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-controljetty-1372352519322\'
[junit4:junit4] 2> 1067236 T2695 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 120000
[junit4:junit4] 2> 1067236 T2695 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4] 2> 1067236 T2695 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4:junit4] 2> 1067236 T2695 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4] 2> 1067237 T2695 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4] 2> 1067237 T2695 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4] 2> 1067238 T2695 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4] 2> 1067238 T2695 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4] 2> 1067238 T2695 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4] 2> 1067239 T2695 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=120000&connTimeout=15000&retry=false
[junit4:junit4] 2> 1067247 T2695 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener
[junit4:junit4] 2> 1067248 T2695 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:57954/solr
[junit4:junit4] 2> 1067248 T2695 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4:junit4] 2> 1067250 T2695 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4] 2> 1067266 T2715 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@7d0ecedd name:ZooKeeperConnection Watcher:127.0.0.1:57954 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4] 2> 1067266 T2695 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4] 2> 1067270 T2697 oazs.NIOServerCnxn.doIO WARN caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x13f86959bc90002, likely client has closed socket
[junit4:junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:220)
[junit4:junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4:junit4] 2> at java.lang.Thread.run(Thread.java:724)
[junit4:junit4] 2>
[junit4:junit4] 2> 1067270 T2695 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=500&maxConnectionsPerHost=16&socketTimeout=120000&connTimeout=15000
[junit4:junit4] 2> 1067277 T2695 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4] 2> 1067281 T2717 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@6c677f55 name:ZooKeeperConnection Watcher:127.0.0.1:57954/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4] 2> 1067281 T2695 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4] 2> 1067284 T2695 oascc.SolrZkClient.makePath makePath: /overseer/queue
[junit4:junit4] 2> 1067292 T2695 oascc.SolrZkClient.makePath makePath: /overseer/collection-queue-work
[junit4:junit4] 2> 1067298 T2695 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4:junit4] 2> 1067302 T2695 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:57961_
[junit4:junit4] 2> 1067304 T2695 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:57961_
[junit4:junit4] 2> 1067317 T2695 oascc.SolrZkClient.makePath makePath: /overseer_elect/election
[junit4:junit4] 2> 1067329 T2695 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4:junit4] 2> 1067333 T2695 oasc.Overseer.start Overseer (id=89938494692589571-127.0.0.1:57961_-n_0000000000) starting
[junit4:junit4] 2> 1067341 T2695 oascc.SolrZkClient.makePath makePath: /overseer/queue-work
[junit4:junit4] 2> 1067350 T2719 oasc.OverseerCollectionProcessor.run Process current queue of collection creations
[junit4:junit4] 2> 1067351 T2695 oascc.SolrZkClient.makePath makePath: /clusterstate.json
[junit4:junit4] 2> 1067356 T2695 oascc.SolrZkClient.makePath makePath: /aliases.json
[junit4:junit4] 2> 1067360 T2695 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4:junit4] 2> 1067365 T2718 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4:junit4] 2> 1067370 T2720 oasc.ZkController.publish publishing core=collection1 state=down
[junit4:junit4] 2> 1067371 T2720 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4] 2> 1067374 T2720 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4:junit4] 2> 1068011 T1767 oasc.OverseerCollectionProcessor.run WARN Overseer cannot talk to ZK
[junit4:junit4] 2> 1068870 T2718 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 1068871 T2718 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={
[junit4:junit4] 2> "operation":"state",
[junit4:junit4] 2> "core_node_name":"core_node1",
[junit4:junit4] 2> "numShards":"1",
[junit4:junit4] 2> "shard":null,
[junit4:junit4] 2> "roles":null,
[junit4:junit4] 2> "state":"down",
[junit4:junit4] 2> "shard_state":"active",
[junit4:junit4] 2> "core":"collection1",
[junit4:junit4] 2> "collection":"control_collection",
[junit4:junit4] 2> "shard_range":null,
[junit4:junit4] 2> "node_name":"127.0.0.1:57961_",
[junit4:junit4] 2> "base_url":"http://127.0.0.1:57961"}
[junit4:junit4] 2> 1068871 T2718 oasc.Overseer$ClusterStateUpdater.createCollection Create collection control_collection with numShards 1
[junit4:junit4] 2> 1068871 T2718 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard1
[junit4:junit4] 2> 1068879 T2717 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4:junit4] 2> 1069375 T2720 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1
[junit4:junit4] 2> 1069375 T2720 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-controljetty-1372352519322\collection1
[junit4:junit4] 2> 1069375 T2720 oasc.ZkController.createCollectionZkNode Check for collection zkNode:control_collection
[junit4:junit4] 2> 1069376 T2720 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4] 2> 1069376 T2720 oasc.ZkController.readConfigName Load collection config from:/collections/control_collection
[junit4:junit4] 2> 1069379 T2720 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-controljetty-1372352519322\collection1\'
[junit4:junit4] 2> 1069382 T2720 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/org.apache.solr.cloud.SyncSliceTest-controljetty-1372352519322/collection1/lib/classes/' to classloader
[junit4:junit4] 2> 1069384 T2720 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/org.apache.solr.cloud.SyncSliceTest-controljetty-1372352519322/collection1/lib/README' to classloader
[junit4:junit4] 2> 1069442 T2720 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4] 2> 1069518 T2720 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4] 2> 1069521 T2720 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4:junit4] 2> 1069525 T2720 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4:junit4] 2> 1070196 T2720 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4] 2> 1070209 T2720 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4] 2> 1070214 T2720 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4] 2> 1070234 T2720 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4] 2> 1070239 T2720 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4] 2> 1070244 T2720 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4] 2> 1070246 T2720 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4:junit4] 2> 1070246 T2720 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4:junit4] 2> 1070246 T2720 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4] 2> 1070248 T2720 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4:junit4] 2> 1070248 T2720 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4:junit4] 2> 1070248 T2720 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4] 2> 1070248 T2720 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-controljetty-1372352519322\collection1\, dataDir=.\org.apache.solr.cloud.SyncSliceTest-1372352519102/control/data\
[junit4:junit4] 2> 1070248 T2720 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@4aee0373
[junit4:junit4] 2> 1070249 T2720 oasc.CachingDirectoryFactory.get return new directory for .\org.apache.solr.cloud.SyncSliceTest-1372352519102/control/data\
[junit4:junit4] 2> 1070249 T2720 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=.\org.apache.solr.cloud.SyncSliceTest-1372352519102/control/data\index/
[junit4:junit4] 2> 1070249 T2720 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '.\org.apache.solr.cloud.SyncSliceTest-1372352519102\control\data\index' doesn't exist. Creating new index...
[junit4:junit4] 2> 1070249 T2720 oasc.CachingDirectoryFactory.get return new directory for .\org.apache.solr.cloud.SyncSliceTest-1372352519102/control/data\index
[junit4:junit4] 2> 1070255 T2720 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@57fcead9 lockFactory=org.apache.lucene.store.NativeFSLockFactory@6c7d07d),segFN=segments_1,generation=1}
[junit4:junit4] 2> 1070255 T2720 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4:junit4] 2> 1070259 T2720 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4] 2> 1070259 T2720 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4] 2> 1070260 T2720 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4] 2> 1070260 T2720 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4] 2> 1070262 T2720 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4] 2> 1070262 T2720 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4] 2> 1070262 T2720 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4] 2> 1070262 T2720 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4] 2> 1070262 T2720 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4] 2> 1070272 T2720 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4] 2> 1070279 T2720 oass.SolrIndexSearcher.<init> Opening Searcher@10348dde main
[junit4:junit4] 2> 1070281 T2720 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4] 2> 1070281 T2720 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4] 2> 1070285 T2721 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@10348dde main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4] 2> 1070287 T2720 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4] 2> 1070288 T2720 oasc.ZkController.register Register replica - core:collection1 address:http://127.0.0.1:57961 collection:control_collection shard:shard1
[junit4:junit4] 2> 1070289 T2720 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leader_elect/shard1/election
[junit4:junit4] 2> 1070303 T2720 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard1
[junit4:junit4] 2> 1070312 T2720 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4:junit4] 2> 1070313 T2720 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4] 2> 1070313 T2720 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:57961/collection1/
[junit4:junit4] 2> 1070313 T2720 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4:junit4] 2> 1070313 T2720 oasc.SyncStrategy.syncToMe http://127.0.0.1:57961/collection1/ has no replicas
[junit4:junit4] 2> 1070313 T2720 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:57961/collection1/ shard1
[junit4:junit4] 2> 1070313 T2720 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leaders/shard1
[junit4:junit4] 2> 1070385 T2718 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 1070399 T2717 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4:junit4] 2> 1070426 T2720 oasc.ZkController.register We are http://127.0.0.1:57961/collection1/ and leader is http://127.0.0.1:57961/collection1/
[junit4:junit4] 2> 1070426 T2720 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:57961
[junit4:junit4] 2> 1070426 T2720 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4:junit4] 2> 1070426 T2720 oasc.ZkController.publish publishing core=collection1 state=active
[junit4:junit4] 2> 1070426 T2720 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4] 2> 1070430 T2720 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 1070432 T2695 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4:junit4] 2> 1070432 T2695 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4] 2> 1070432 T2695 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4] 2> 1070440 T2695 oascsi.HttpClientUtil.createClient Creating new http client, config:
[junit4:junit4] 2> 1070442 T2695 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4] 2> 1070446 T2724 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@11d47f6c name:ZooKeeperConnection Watcher:127.0.0.1:57954/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4] 2> 1070446 T2695 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4] 2> 1070448 T2695 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4:junit4] 2> 1070451 T2695 oasc.ChaosMonkey.monkeyLog monkey: init - expire sessions:true cause connection loss:true
[junit4:junit4] 2> 1070885 T2695 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4:junit4] 2> 1070888 T2695 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:57973
[junit4:junit4] 2> 1070890 T2695 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4] 2> 1070891 T2695 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4] 2> 1070891 T2695 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-jetty1-1372352523121
[junit4:junit4] 2> 1070891 T2695 oasc.CoreContainer$Initializer.initialize looking for solr config file: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-jetty1-1372352523121\solr.xml
[junit4:junit4] 2> 1070891 T2695 oasc.CoreContainer.<init> New CoreContainer 324614349
[junit4:junit4] 2> 1070892 T2695 oasc.CoreContainer.load Loading CoreContainer using Solr Home: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-jetty1-1372352523121\'
[junit4:junit4] 2> 1070892 T2695 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-jetty1-1372352523121\'
[junit4:junit4] 2> 1071023 T2695 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 120000
[junit4:junit4] 2> 1071023 T2695 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4] 2> 1071024 T2695 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4:junit4] 2> 1071024 T2695 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4] 2> 1071024 T2695 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4] 2> 1071025 T2695 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4] 2> 1071025 T2695 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4] 2> 1071025 T2695 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4] 2> 1071025 T2695 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4] 2> 1071026 T2695 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=120000&connTimeout=15000&retry=false
[junit4:junit4] 2> 1071034 T2695 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener
[junit4:junit4] 2> 1071035 T2695 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:57954/solr
[junit4:junit4] 2> 1071035 T2695 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4:junit4] 2> 1071037 T2695 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4] 2> 1071053 T2735 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@2765d112 name:ZooKeeperConnection Watcher:127.0.0.1:57954 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4] 2> 1071054 T2695 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4] 2> 1071058 T2695 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=500&maxConnectionsPerHost=16&socketTimeout=120000&connTimeout=15000
[junit4:junit4] 2> 1071067 T2695 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4] 2> 1071071 T2737 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@513ec130 name:ZooKeeperConnection Watcher:127.0.0.1:57954/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4] 2> 1071072 T2695 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4] 2> 1071080 T2695 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4:junit4] 2> 1071909 T2718 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 1071910 T2718 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={
[junit4:junit4] 2> "operation":"state",
[junit4:junit4] 2> "core_node_name":"core_node1",
[junit4:junit4] 2> "numShards":"1",
[junit4:junit4] 2> "shard":"shard1",
[junit4:junit4] 2> "roles":null,
[junit4:junit4] 2> "state":"active",
[junit4:junit4] 2> "shard_state":"active",
[junit4:junit4] 2> "core":"collection1",
[junit4:junit4] 2> "collection":"control_collection",
[junit4:junit4] 2> "shard_range":null,
[junit4:junit4] 2> "node_name":"127.0.0.1:57961_",
[junit4:junit4] 2> "base_url":"http://127.0.0.1:57961"}
[junit4:junit4] 2> 1071923 T2737 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4:junit4] 2> 1071924 T2717 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4:junit4] 2> 1071923 T2724 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4:junit4] 2> 1072084 T2695 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:57973_
[junit4:junit4] 2> 1072087 T2695 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:57973_
[junit4:junit4] 2> 1072091 T2724 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 1)
[junit4:junit4] 2> 1072091 T2717 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 1)
[junit4:junit4] 2> 1072091 T2737 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 1)
[junit4:junit4] 2> 1072096 T2724 oascc.ZkStateReader$3.process Updating live nodes... (2)
[junit4:junit4] 2> 1072097 T2717 oascc.ZkStateReader$3.process Updating live nodes... (2)
[junit4:junit4] 2> 1072097 T2737 oascc.ZkStateReader$3.process Updating live nodes... (2)
[junit4:junit4] 2> 1072104 T2738 oasc.ZkController.publish publishing core=collection1 state=down
[junit4:junit4] 2> 1072104 T2738 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4] 2> 1072106 T2738 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4:junit4] 2> 1072159 T1771 oasc.OverseerCollectionProcessor.run WARN Overseer cannot talk to ZK
[junit4:junit4] 2> 1073432 T2718 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 1073433 T2718 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={
[junit4:junit4] 2> "operation":"state",
[junit4:junit4] 2> "core_node_name":"core_node1",
[junit4:junit4] 2> "numShards":"1",
[junit4:junit4] 2> "shard":null,
[junit4:junit4] 2> "roles":null,
[junit4:junit4] 2> "state":"down",
[junit4:junit4] 2> "shard_state":"active",
[junit4:junit4] 2> "core":"collection1",
[junit4:junit4] 2> "collection":"collection1",
[junit4:junit4] 2> "shard_range":null,
[junit4:junit4] 2> "node_name":"127.0.0.1:57973_",
[junit4:junit4] 2> "base_url":"http://127.0.0.1:57973"}
[junit4:junit4] 2> 1073433 T2718 oasc.Overseer$ClusterStateUpdater.createCollection Create collection collection1 with numShards 1
[junit4:junit4] 2> 1073433 T2718 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard1
[junit4:junit4] 2> 1073446 T2717 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4:junit4] 2> 1073447 T2737 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4:junit4] 2> 1073446 T2724 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4:junit4] 2> 1074107 T2738 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1
[junit4:junit4] 2> 1074107 T2738 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-jetty1-1372352523121\collection1
[junit4:junit4] 2> 1074107 T2738 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4] 2> 1074109 T2738 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4] 2> 1074109 T2738 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4] 2> 1074112 T2738 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-jetty1-1372352523121\collection1\'
[junit4:junit4] 2> 1074115 T2738 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/org.apache.solr.cloud.SyncSliceTest-jetty1-1372352523121/collection1/lib/classes/' to classloader
[junit4:junit4] 2> 1074116 T2738 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/org.apache.solr.cloud.SyncSliceTest-jetty1-1372352523121/collection1/lib/README' to classloader
[junit4:junit4] 2> 1074170 T2738 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4] 2> 1074245 T2738 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4] 2> 1074247 T2738 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4:junit4] 2> 1074253 T2738 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4:junit4] 2> 1074917 T2738 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4] 2> 1074927 T2738 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4] 2> 1074930 T2738 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4] 2> 1074952 T2738 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4] 2> 1074961 T2738 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4] 2> 1074970 T2738 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4] 2> 1074974 T2738 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4:junit4] 2> 1074975 T2738 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4:junit4] 2> 1074975 T2738 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4] 2> 1074978 T2738 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4:junit4] 2> 1074978 T2738 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4:junit4] 2> 1074978 T2738 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4] 2> 1074979 T2738 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-jetty1-1372352523121\collection1\, dataDir=.\org.apache.solr.cloud.SyncSliceTest-1372352519102/jetty1\
[junit4:junit4] 2> 1074979 T2738 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@4aee0373
[junit4:junit4] 2> 1074980 T2738 oasc.CachingDirectoryFactory.get return new directory for .\org.apache.solr.cloud.SyncSliceTest-1372352519102/jetty1\
[junit4:junit4] 2> 1074980 T2738 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=.\org.apache.solr.cloud.SyncSliceTest-1372352519102/jetty1\index/
[junit4:junit4] 2> 1074980 T2738 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '.\org.apache.solr.cloud.SyncSliceTest-1372352519102\jetty1\index' doesn't exist. Creating new index...
[junit4:junit4] 2> 1074981 T2738 oasc.CachingDirectoryFactory.get return new directory for .\org.apache.solr.cloud.SyncSliceTest-1372352519102/jetty1\index
[junit4:junit4] 2> 1074986 T2738 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@1d613de7 lockFactory=org.apache.lucene.store.NativeFSLockFactory@3358c3ef),segFN=segments_1,generation=1}
[junit4:junit4] 2> 1074986 T2738 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4:junit4] 2> 1074991 T2738 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4] 2> 1074991 T2738 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4] 2> 1074992 T2738 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4] 2> 1074992 T2738 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4] 2> 1074993 T2738 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4] 2> 1074993 T2738 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4] 2> 1074993 T2738 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4] 2> 1074994 T2738 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4] 2> 1074994 T2738 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4] 2> 1075006 T2738 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4] 2> 1075012 T2738 oass.SolrIndexSearcher.<init> Opening Searcher@6ea7eb5f main
[junit4:junit4] 2> 1075014 T2738 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4] 2> 1075014 T2738 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4] 2> 1075020 T2739 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6ea7eb5f main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4] 2> 1075023 T2738 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4] 2> 1075024 T2738 oasc.ZkController.register Register replica - core:collection1 address:http://127.0.0.1:57973 collection:collection1 shard:shard1
[junit4:junit4] 2> 1075025 T2738 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard1/election
[junit4:junit4] 2> 1075044 T2738 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard1
[junit4:junit4] 2> 1075049 T2738 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4:junit4] 2> 1075050 T2738 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4] 2> 1075050 T2738 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:57973/collection1/
[junit4:junit4] 2> 1075050 T2738 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4:junit4] 2> 1075050 T2738 oasc.SyncStrategy.syncToMe http://127.0.0.1:57973/collection1/ has no replicas
[junit4:junit4] 2> 1075050 T2738 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:57973/collection1/ shard1
[junit4:junit4] 2> 1075050 T2738 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard1
[junit4:junit4] 2> 1076460 T2718 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 1076485 T2717 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4:junit4] 2> 1076486 T2737 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4:junit4] 2> 1076485 T2724 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4:junit4] 2> 1076541 T2738 oasc.ZkController.register We are http://127.0.0.1:57973/collection1/ and leader is http://127.0.0.1:57973/collection1/
[junit4:junit4] 2> 1076541 T2738 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:57973
[junit4:junit4] 2> 1076541 T2738 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4:junit4] 2> 1076541 T2738 oasc.ZkController.publish publishing core=collection1 state=active
[junit4:junit4] 2> 1076541 T2738 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4] 2> 1076545 T2738 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 1076547 T2695 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4:junit4] 2> 1076547 T2695 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4] 2> 1076549 T2695 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4] 2> 1076757 T1788 oasc.OverseerCollectionProcessor.run WARN Overseer cannot talk to ZK
[junit4:junit4] 2> 1077114 T2695 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4:junit4] 2> 1077119 T2695 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:57982
[junit4:junit4] 2> 1077120 T2695 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4] 2> 1077120 T2695 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4] 2> 1077121 T2695 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-jetty2-1372352529230
[junit4:junit4] 2> 1077122 T2695 oasc.CoreContainer$Initializer.initialize looking for solr config file: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-jetty2-1372352529230\solr.xml
[junit4:junit4] 2> 1077123 T2695 oasc.CoreContainer.<init> New CoreContainer 1772395625
[junit4:junit4] 2> 1077124 T2695 oasc.CoreContainer.load Loading CoreContainer using Solr Home: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-jetty2-1372352529230\'
[junit4:junit4] 2> 1077124 T2695 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-jetty2-1372352529230\'
[junit4:junit4] 2> 1077280 T2695 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 120000
[junit4:junit4] 2> 1077281 T2695 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4] 2> 1077282 T2695 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4:junit4] 2> 1077282 T2695 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4] 2> 1077283 T2695 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4] 2> 1077283 T2695 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4] 2> 1077283 T2695 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4] 2> 1077284 T2695 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4] 2> 1077284 T2695 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4] 2> 1077285 T2695 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=120000&connTimeout=15000&retry=false
[junit4:junit4] 2> 1077297 T2695 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener
[junit4:junit4] 2> 1077298 T2695 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:57954/solr
[junit4:junit4] 2> 1077299 T2695 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4:junit4] 2> 1077301 T2695 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4] 2> 1077337 T2751 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@60ed8736 name:ZooKeeperConnection Watcher:127.0.0.1:57954 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4] 2> 1077339 T2695 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4] 2> 1077344 T2695 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=500&maxConnectionsPerHost=16&socketTimeout=120000&connTimeout=15000
[junit4:junit4] 2> 1077351 T2695 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4] 2> 1077356 T2753 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@2f206233 name:ZooKeeperConnection Watcher:127.0.0.1:57954/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4] 2> 1077356 T2695 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4] 2> 1077366 T2695 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4:junit4] 2> 1077999 T2718 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 1078000 T2718 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={
[junit4:junit4] 2> "operation":"state",
[junit4:junit4] 2> "core_node_name":"core_node1",
[junit4:junit4] 2> "numShards":"1",
[junit4:junit4] 2> "shard":"shard1",
[junit4:junit4] 2> "roles":null,
[junit4:junit4] 2> "state":"active",
[junit4:junit4] 2> "shard_state":"active",
[junit4:junit4] 2> "core":"collection1",
[junit4:junit4] 2> "collection":"collection1",
[junit4:junit4] 2> "shard_range":null,
[junit4:junit4] 2> "node_name":"127.0.0.1:57973_",
[junit4:junit4] 2> "base_url":"http://127.0.0.1:57973"}
[junit4:junit4] 2> 1078011 T2737 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4:junit4] 2> 1078012 T2717 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4:junit4] 2> 1078012 T2753 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4:junit4] 2> 1078011 T2724 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4:junit4] 2> 1078371 T2695 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:57982_
[junit4:junit4] 2> 1078379 T2695 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:57982_
[junit4:junit4] 2> 1078398 T2724 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 2)
[junit4:junit4] 2> 1078403 T2717 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 2)
[junit4:junit4] 2> 1078403 T2737 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 2)
[junit4:junit4] 2> 1078406 T2753 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4:junit4] 2> 1078406 T2753 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 3)
[junit4:junit4] 2> 1078407 T2724 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4:junit4] 2> 1078408 T2717 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4:junit4] 2> 1078409 T2737 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4:junit4] 2> 1078421 T2754 oasc.ZkController.publish publishing core=collection1 state=down
[junit4:junit4] 2> 1078421 T2754 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4] 2> 1078424 T2754 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4:junit4] 2> 1079521 T2718 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 1079522 T2718 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={
[junit4:junit4] 2> "operation":"state",
[junit4:junit4] 2> "core_node_name":"core_node2",
[junit4:junit4] 2> "numShards":"1",
[junit4:junit4] 2> "shard":null,
[junit4:junit4] 2> "roles":null,
[junit4:junit4] 2> "state":"down",
[junit4:junit4] 2> "shard_state":"active",
[junit4:junit4] 2> "core":"collection1",
[junit4:junit4] 2> "collection":"collection1",
[junit4:junit4] 2> "shard_range":null,
[junit4:junit4] 2> "node_name":"127.0.0.1:57982_",
[junit4:junit4] 2> "base_url":"http://127.0.0.1:57982"}
[junit4:junit4] 2> 1079522 T2718 oasc.Overseer$ClusterStateUpdater.updateState Collection already exists with numShards=1
[junit4:junit4] 2> 1079522 T2718 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard1
[junit4:junit4] 2> 1079536 T2717 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4:junit4] 2> 1079537 T2724 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4:junit4] 2> 1079537 T2753 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4:junit4] 2> 1079537 T2737 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4:junit4] 2> 1079813 T1803 oasc.OverseerCollectionProcessor.run WARN Overseer cannot talk to ZK
[junit4:junit4] 2> 1080424 T2754 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1
[junit4:junit4] 2> 1080424 T2754 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-jetty2-1372352529230\collection1
[junit4:junit4] 2> 1080424 T2754 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4] 2> 1080425 T2754 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4] 2> 1080425 T2754 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4] 2> 1080427 T2754 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-jetty2-1372352529230\collection1\'
[junit4:junit4] 2> 1080430 T2754 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/org.apache.solr.cloud.SyncSliceTest-jetty2-1372352529230/collection1/lib/classes/' to classloader
[junit4:junit4] 2> 1080430 T2754 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/org.apache.solr.cloud.SyncSliceTest-jetty2-1372352529230/collection1/lib/README' to classloader
[junit4:junit4] 2> 1080484 T2754 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4] 2> 1080561 T2754 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4] 2> 1080563 T2754 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4:junit4] 2> 1080577 T2754 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4:junit4] 2> 1081274 T2754 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4] 2> 1081290 T2754 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4] 2> 1081296 T2754 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4] 2> 1081325 T2754 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4] 2> 1081333 T2754 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4] 2> 1081341 T2754 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4] 2> 1081344 T2754 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4:junit4] 2> 1081345 T2754 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4:junit4] 2> 1081345 T2754 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4] 2> 1081346 T2754 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4:junit4] 2> 1081346 T2754 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4:junit4] 2> 1081347 T2754 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4] 2> 1081348 T2754 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-jetty2-1372352529230\collection1\, dataDir=.\org.apache.solr.cloud.SyncSliceTest-1372352519102/jetty2\
[junit4:junit4] 2> 1081348 T2754 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@4aee0373
[junit4:junit4] 2> 1081349 T2754 oasc.CachingDirectoryFactory.get return new directory for .\org.apache.solr.cloud.SyncSliceTest-1372352519102/jetty2\
[junit4:junit4] 2> 1081349 T2754 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=.\org.apache.solr.cloud.SyncSliceTest-1372352519102/jetty2\index/
[junit4:junit4] 2> 1081349 T2754 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '.\org.apache.solr.cloud.SyncSliceTest-1372352519102\jetty2\index' doesn't exist. Creating new index...
[junit4:junit4] 2> 1081349 T2754 oasc.CachingDirectoryFactory.get return new directory for .\org.apache.solr.cloud.SyncSliceTest-1372352519102/jetty2\index
[junit4:junit4] 2> 1081357 T2754 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@27681a7a lockFactory=org.apache.lucene.store.NativeFSLockFactory@24050952),segFN=segments_1,generation=1}
[junit4:junit4] 2> 1081358 T2754 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4:junit4] 2> 1081366 T2754 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4] 2> 1081366 T2754 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4] 2> 1081367 T2754 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4] 2> 1081368 T2754 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4] 2> 1081369 T2754 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4] 2> 1081370 T2754 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4] 2> 1081370 T2754 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4] 2> 1081371 T2754 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4] 2> 1081371 T2754 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4] 2> 1081387 T2754 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4] 2> 1081394 T2754 oass.SolrIndexSearcher.<init> Opening Searcher@2003c9c0 main
[junit4:junit4] 2> 1081398 T2754 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4] 2> 1081398 T2754 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4] 2> 1081406 T2755 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2003c9c0 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4] 2> 1081412 T2754 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4] 2> 1081412 T2754 oasc.ZkController.register Register replica - core:collection1 address:http://127.0.0.1:57982 collection:collection1 shard:shard1
[junit4:junit4] 2> 1081424 T2754 oasc.ZkController.register We are http://127.0.0.1:57982/collection1/ and leader is http://127.0.0.1:57973/collection1/
[junit4:junit4] 2> 1081424 T2754 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:57982
[junit4:junit4] 2> 1081424 T2754 oasc.ZkController.checkRecovery Core needs to recover:collection1
[junit4:junit4] 2> 1081425 T2754 oasu.DefaultSolrCoreState.doRecovery Running recovery - first canceling any ongoing recovery
[junit4:junit4] 2> ASYNC NEW_CORE C1904 name=collection1 org.apache.solr.core.SolrCore@5f0d0346 url=http://127.0.0.1:57982/collection1 node=127.0.0.1:57982_ C1904_STATE=coll:collection1 core:collection1 props:{state=down, core=collection1, node_name=127.0.0.1:57982_, base_url=http://127.0.0.1:57982}
[junit4:junit4] 2> 1081426 T2756 C1904 P57982 oasc.RecoveryStrategy.run Starting recovery process. core=collection1 recoveringAfterStartup=true
[junit4:junit4] 2> 1081427 T2756 C1904 P57982 oasc.RecoveryStrategy.doRecovery ###### startupVersions=[]
[junit4:junit4] 2> 1081427 T2756 C1904 P57982 oasc.ZkController.publish publishing core=collection1 state=recovering
[junit4:junit4] 2> 1081427 T2756 C1904 P57982 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4] 2> 1081428 T2754 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 1081432 T2756 C1904 P57982 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4] 2> 1081436 T2695 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4:junit4] 2> 1081436 T2695 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4] 2> 1081436 T2695 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4] 2> 1081456 T2728 oasha.CoreAdminHandler.handleWaitForStateAction Going to wait for coreNodeName: core_node2, state: recovering, checkLive: true, onlyIfLeader: true
[junit4:junit4] 2> 1081946 T2695 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4:junit4] 2> 1081950 T2695 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:57992
[junit4:junit4] 2> 1081952 T2695 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4] 2> 1081953 T2695 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4] 2> 1081953 T2695 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-jetty3-1372352534118
[junit4:junit4] 2> 1081953 T2695 oasc.CoreContainer$Initializer.initialize looking for solr config file: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-jetty3-1372352534118\solr.xml
[junit4:junit4] 2> 1081954 T2695 oasc.CoreContainer.<init> New CoreContainer 919896297
[junit4:junit4] 2> 1081954 T2695 oasc.CoreContainer.load Loading CoreContainer using Solr Home: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-jetty3-1372352534118\'
[junit4:junit4] 2> 1081955 T2695 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-jetty3-1372352534118\'
[junit4:junit4] 2> 1082081 T2695 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 120000
[junit4:junit4] 2> 1082081 T2695 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4] 2> 1082081 T2695 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4:junit4] 2> 1082081 T2695 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4] 2> 1082082 T2695 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4] 2> 1082083 T2695 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4] 2> 1082083 T2695 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4] 2> 1082084 T2695 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4] 2> 1082084 T2695 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4] 2> 1082085 T2695 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=120000&connTimeout=15000&retry=false
[junit4:junit4] 2> 1082094 T2695 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener
[junit4:junit4] 2> 1082095 T2695 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:57954/solr
[junit4:junit4] 2> 1082095 T2695 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4:junit4] 2> 1082097 T2695 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4] 2> 1082112 T2768 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1c860b95 name:ZooKeeperConnection Watcher:127.0.0.1:57954 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4] 2> 1082115 T2695 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4] 2> 1082119 T2695 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=500&maxConnectionsPerHost=16&socketTimeout=120000&connTimeout=15000
[junit4:junit4] 2> 1082120 T2697 oazs.NIOServerCnxn.doIO WARN caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x13f86959bc90009, likely client has closed socket
[junit4:junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:220)
[junit4:junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4:junit4] 2> at java.lang.Thread.run(Thread.java:724)
[junit4:junit4] 2>
[junit4:junit4] 2> 1082125 T2695 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4] 2> 1082129 T2770 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@783591be name:ZooKeeperConnection Watcher:127.0.0.1:57954/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4] 2> 1082130 T2695 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4] 2> 1082137 T2695 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4:junit4] 2> 1082550 T2718 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 1082551 T2718 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={
[junit4:junit4] 2> "operation":"state",
[junit4:junit4] 2> "core_node_name":"core_node2",
[junit4:junit4] 2> "numShards":"1",
[junit4:junit4] 2> "shard":"shard1",
[junit4:junit4] 2> "roles":null,
[junit4:junit4] 2> "state":"recovering",
[junit4:junit4] 2> "shard_state":"active",
[junit4:junit4] 2> "core":"collection1",
[junit4:junit4] 2> "collection":"collection1",
[junit4:junit4] 2> "shard_range":null,
[junit4:junit4] 2> "node_name":"127.0.0.1:57982_",
[junit4:junit4] 2> "base_url":"http://127.0.0.1:57982"}
[junit4:junit4] 2> 1082563 T2724 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4:junit4] 2> 1082564 T2717 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4:junit4] 2> 1082564 T2770 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4:junit4] 2> 1082565 T2737 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4:junit4] 2> 1082565 T2753 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4:junit4] 2> 1083141 T2695 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:57992_
[junit4:junit4] 2> 1083144 T2695 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:57992_
[junit4:junit4] 2> 1083149 T2724 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 3)
[junit4:junit4] 2> 1083150 T2717 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 3)
[junit4:junit4] 2> 1083152 T2770 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4:junit4] 2> 1083152 T2770 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 4)
[junit4:junit4] 2> 1083150 T2737 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 3)
[junit4:junit4] 2> 1083152 T2753 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4:junit4] 2> 1083154 T2753 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 4)
[junit4:junit4] 2> 1083156 T2724 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4:junit4] 2> 1083159 T2717 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4:junit4] 2> 1083161 T2737 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4:junit4] 2> 1083168 T2771 oasc.ZkController.publish publishing core=collection1 state=down
[junit4:junit4] 2> 1083168 T2771 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4] 2> 1083171 T2771 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4:junit4] 2> 1083457 T2728 oasha.CoreAdminHandler.handleWaitForStateAction Waited coreNodeName: core_node2, state: recovering, checkLive: true, onlyIfLeader: true for: 2 seconds.
[junit4:junit4] 2> 1083457 T2728 oass.SolrDispatchFilter.handleAdminRequest [admin] webapp=null path=/admin/cores params={coreNodeName=core_node2&state=recovering&nodeName=127.0.0.1:57982_&action=PREPRECOVERY&checkLive=true&core=collection1&wt=javabin&onlyIfLeader=true&version=2} status=0 QTime=2001
[junit4:junit4] 2> 1084073 T2718 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 1084074 T2718 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={
[junit4:junit4] 2> "operation":"state",
[junit4:junit4] 2> "core_node_name":"core_node3",
[junit4:junit4] 2> "numShards":"1",
[junit4:junit4] 2> "shard":null,
[junit4:junit4] 2> "roles":null,
[junit4:junit4] 2> "state":"down",
[junit4:junit4] 2> "shard_state":"active",
[junit4:junit4] 2> "core":"collection1",
[junit4:junit4] 2> "collection":"collection1",
[junit4:junit4] 2> "shard_range":null,
[junit4:junit4] 2> "node_name":"127.0.0.1:57992_",
[junit4:junit4] 2> "base_url":"http://127.0.0.1:57992"}
[junit4:junit4] 2> 1084074 T2718 oasc.Overseer$ClusterStateUpdater.updateState Collection already exists with numShards=1
[junit4:junit4] 2> 1084074 T2718 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard1
[junit4:junit4] 2> 1084084 T2724 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 4)
[junit4:junit4] 2> 1084084 T2753 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 4)
[junit4:junit4] 2> 1084084 T2770 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 4)
[junit4:junit4] 2> 1084084 T2737 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 4)
[junit4:junit4] 2> 1084084 T2717 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 4)
[junit4:junit4] 2> 1084171 T2771 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1
[junit4:junit4] 2> 1084171 T2771 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-jetty3-1372352534118\collection1
[junit4:junit4] 2> 1084171 T2771 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4] 2> 1084172 T2771 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4] 2> 1084172 T2771 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4] 2> 1084174 T2771 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-jetty3-1372352534118\collection1\'
[junit4:junit4] 2> 1084176 T2771 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/org.apache.solr.cloud.SyncSliceTest-jetty3-1372352534118/collection1/lib/classes/' to classloader
[junit4:junit4] 2> 1084177 T2771 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/org.apache.solr.cloud.SyncSliceTest-jetty3-1372352534118/collection1/lib/README' to classloader
[junit4:junit4] 2> 1084231 T2771 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4] 2> 1084308 T2771 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4] 2> 1084323 T2771 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4:junit4] 2> 1084328 T2771 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4:junit4] 2> 1085066 T2771 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4] 2> 1085077 T2771 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4] 2> 1085080 T2771 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4] 2> 1085109 T2771 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4] 2> 1085117 T2771 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4] 2> 1085125 T2771 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4] 2> 1085127 T2771 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4:junit4] 2> 1085128 T2771 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4:junit4] 2> 1085128 T2771 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4] 2> 1085130 T2771 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4:junit4] 2> 1085130 T2771 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4:junit4] 2> 1085132 T2771 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4] 2> 1085132 T2771 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-jetty3-1372352534118\collection1\, dataDir=.\org.apache.solr.cloud.SyncSliceTest-1372352519102/jetty3\
[junit4:junit4] 2> 1085132 T2771 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@4aee0373
[junit4:junit4] 2> 1085133 T2771 oasc.CachingDirectoryFactory.get return new directory for .\org.apache.solr.cloud.SyncSliceTest-1372352519102/jetty3\
[junit4:junit4] 2> 1085133 T2771 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=.\org.apache.solr.cloud.SyncSliceTest-1372352519102/jetty3\index/
[junit4:junit4] 2> 1085133 T2771 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '.\org.apache.solr.cloud.SyncSliceTest-1372352519102\jetty3\index' doesn't exist. Creating new index...
[junit4:junit4] 2> 1085134 T2771 oasc.CachingDirectoryFactory.get return new directory for .\org.apache.solr.cloud.SyncSliceTest-1372352519102/jetty3\index
[junit4:junit4] 2> 1085141 T2771 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@5658441b lockFactory=org.apache.lucene.store.NativeFSLockFactory@f1ef8c2),segFN=segments_1,generation=1}
[junit4:junit4] 2> 1085141 T2771 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4:junit4] 2> 1085147 T2771 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4] 2> 1085148 T2771 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4] 2> 1085149 T2771 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4] 2> 1085150 T2771 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4] 2> 1085151 T2771 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4] 2> 1085151 T2771 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4] 2> 1085155 T2771 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4] 2> 1085155 T2771 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4] 2> 1085156 T2771 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4] 2> 1085178 T2771 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4] 2> 1085187 T2771 oass.SolrIndexSearcher.<init> Opening Searcher@25218b80 main
[junit4:junit4] 2> 1085189 T2771 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4] 2> 1085189 T2771 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4] 2> 1085194 T2772 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@25218b80 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4] 2> 1085197 T2771 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4] 2> 1085198 T2771 oasc.ZkController.register Register replica - core:collection1 address:http://127.0.0.1:57992 collection:collection1 shard:shard1
[junit4:junit4] 2> 1085210 T2771 oasc.ZkController.register We are http://127.0.0.1:57992/collection1/ and leader is http://127.0.0.1:57973/collection1/
[junit4:junit4] 2> 1085210 T2771 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:57992
[junit4:junit4] 2> 1085210 T2771 oasc.ZkController.checkRecovery Core needs to recover:collection1
[junit4:junit4] 2> 1085211 T2771 oasu.DefaultSolrCoreState.doRecovery Running recovery - first canceling any ongoing recovery
[junit4:junit4] 2> ASYNC NEW_CORE C1905 name=collection1 org.apache.solr.core.SolrCore@722b53b4 url=http://127.0.0.1:57992/collection1 node=127.0.0.1:57992_ C1905_STATE=coll:collection1 core:collection1 props:{state=down, core=collection1, node_name=127.0.0.1:57992_, base_url=http://127.0.0.1:57992}
[junit4:junit4] 2> 1085211 T2773 C1905 P57992 oasc.RecoveryStrategy.run Starting recovery process. core=collection1 recoveringAfterStartup=true
[junit4:junit4] 2> 1085212 T2773 C1905 P57992 oasc.RecoveryStrategy.doRecovery ###### startupVersions=[]
[junit4:junit4] 2> 1085212 T2773 C1905 P57992 oasc.ZkController.publish publishing core=collection1 state=recovering
[junit4:junit4] 2> 1085213 T2773 C1905 P57992 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4] 2> 1085213 T2771 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 1085215 T2773 C1905 P57992 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4] 2> 1085217 T2695 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4:junit4] 2> 1085217 T2695 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4] 2> 1085218 T2695 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4] 2> 1085230 T2732 oasha.CoreAdminHandler.handleWaitForStateAction Going to wait for coreNodeName: core_node3, state: recovering, checkLive: true, onlyIfLeader: true
[junit4:junit4] 2> ASYNC NEW_CORE C1906 name=collection1 org.apache.solr.core.SolrCore@5f0d0346 url=http://127.0.0.1:57982/collection1 node=127.0.0.1:57982_ C1906_STATE=coll:collection1 core:collection1 props:{state=recovering, core=collection1, node_name=127.0.0.1:57982_, base_url=http://127.0.0.1:57982}
[junit4:junit4] 2> 1085458 T2756 C1906 P57982 oasc.RecoveryStrategy.doRecovery Attempting to PeerSync from http://127.0.0.1:57973/collection1/ core=collection1 - recoveringAfterStartup=true
[junit4:junit4] 2> 1085458 T2756 C1906 P57982 oasu.PeerSync.sync PeerSync: core=collection1 url=http://127.0.0.1:57982 START replicas=[http://127.0.0.1:57973/collection1/] nUpdates=100
[junit4:junit4] 2> 1085459 T2756 C1906 P57982 oasu.PeerSync.sync WARN no frame of reference to tell of we've missed updates
[junit4:junit4] 2> 1085459 T2756 C1906 P57982 oasc.RecoveryStrategy.doRecovery PeerSync Recovery was not successful - trying replication. core=collection1
[junit4:junit4] 2> 1085459 T2756 C1906 P57982 oasc.RecoveryStrategy.doRecovery Starting Replication Recovery. core=collection1
[junit4:junit4] 2> 1085459 T2756 C1906 P57982 oasc.RecoveryStrategy.doRecovery Begin buffering updates. core=collection1
[junit4:junit4] 2> 1085460 T2756 C1906 P57982 oasu.UpdateLog.bufferUpdates Starting to buffer updates. FSUpdateLog{state=ACTIVE, tlog=null}
[junit4:junit4] 2> 1085460 T2756 C1906 P57982 oasc.RecoveryStrategy.replicate Attempting to replicate from http://127.0.0.1:57973/collection1/. core=collection1
[junit4:junit4] 2> 1085460 T2756 C1906 P57982 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4] 2> ASYNC NEW_CORE C1907 name=collection1 org.apache.solr.core.SolrCore@371726b6 url=http://127.0.0.1:57973/collection1 node=127.0.0.1:57973_ C1907_STATE=coll:collection1 core:collection1 props:{state=active, core=collection1, node_name=127.0.0.1:57973_, base_url=http://127.0.0.1:57973, leader=true}
[junit4:junit4] 2> 1085493 T2728 C1907 P57973 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 1085504 T2728 C1907 P57973 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@1d613de7 lockFactory=org.apache.lucene.store.NativeFSLockFactory@3358c3ef),segFN=segments_1,generation=1}
[junit4:junit4] 2> 1085505 T2729 C1907 P57973 oasc.SolrCore.execute [collection1] webapp= path=/get params={getVersions=100&distrib=false&wt=javabin&qt=/get&version=2} status=0 QTime=0
[junit4:junit4] 2> 1085506 T2728 C1907 P57973 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4:junit4] 2> 1085508 T2728 C1907 P57973 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
[junit4:junit4] 2> 1085509 T2728 C1907 P57973 oass.SolrIndexSearcher.<init> Opening Searcher@b1efe14 realtime
[junit4:junit4] 2> 1085509 T2728 C1907 P57973 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 1085510 T2728 C1907 P57973 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={waitSearcher=true&openSearcher=false&commit=true&wt=javabin&commit_end_point=true&version=2&softCommit=false} {commit=} 0 18
[junit4:junit4] 2> 1085511 T2756 C1906 P57982 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4:junit4] 2> 1085511 T2756 C1906 P57982 oash.SnapPuller.<init> No value set for 'pollInterval'. Timer Task not started.
[junit4:junit4] 2> 1085519 T2730 C1907 P57973 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4:junit4] 2> 1085520 T2730 C1907 P57973 oasc.SolrCore.execute [collection1] webapp= path=/replication params={command=indexversion&qt=/replication&wt=javabin&version=2} status=0 QTime=3
[junit4:junit4] 2> 1085520 T2756 C1906 P57982 oasc.RecoveryStrategy.replay No replay needed. core=collection1
[junit4:junit4] 2> 1085521 T2756 C1906 P57982 oasc.RecoveryStrategy.doRecovery Replication Recovery was successful - registering as Active. core=collection1
[junit4:junit4] 2> 1085521 T2756 C1906 P57982 oasc.ZkController.publish publishing core=collection1 state=active
[junit4:junit4] 2> 1085521 T2756 C1906 P57982 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4] 2> 1085533 T2756 C1906 P57982 oasc.RecoveryStrategy.doRecovery Finished recovery process. core=collection1
[junit4:junit4] 2> 1085644 T2718 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 1085646 T2718 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={
[junit4:junit4] 2> "operation":"state",
[junit4:junit4] 2> "core_node_name":"core_node3",
[junit4:junit4] 2> "numShards":"1",
[junit4:junit4] 2> "shard":"shard1",
[junit4:junit4] 2> "roles":null,
[junit4:junit4] 2> "state":"recovering",
[junit4:junit4] 2> "shard_state":"active",
[junit4:junit4] 2> "core":"collection1",
[junit4:junit4] 2> "collection":"collection1",
[junit4:junit4] 2> "shard_range":null,
[junit4:junit4] 2> "node_name":"127.0.0.1:57992_",
[junit4:junit4] 2> "base_url":"http://127.0.0.1:57992"}
[junit4:junit4] 2> 1085821 T2695 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4:junit4] 2> 1085825 T2718 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={
[junit4:junit4] 2> "operation":"state",
[junit4:junit4] 2> "core_node_name":"core_node2",
[junit4:junit4] 2> "numShards":"1",
[junit4:junit4] 2> "shard":"shard1",
[junit4:junit4] 2> "roles":null,
[junit4:junit4] 2> "state":"active",
[junit4:junit4] 2> "shard_state":"active",
[junit4:junit4] 2> "core":"collection1",
[junit4:junit4] 2> "collection":"collection1",
[junit4:junit4] 2> "shard_range":null,
[junit4:junit4] 2> "node_name":"127.0.0.1:57982_",
[junit4:junit4] 2> "base_url":"http://127.0.0.1:57982"}
[junit4:junit4] 2> 1085831 T2695 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:58005
[junit4:junit4] 2> 1085832 T2695 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4] 2> 1085833 T2695 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4] 2> 1085834 T2695 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-jetty4-1372352537897
[junit4:junit4] 2> 1085834 T2695 oasc.CoreContainer$Initializer.initialize looking for solr config file: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-jetty4-1372352537897\solr.xml
[junit4:junit4] 2> 1085834 T2695 oasc.CoreContainer.<init> New CoreContainer 1104955073
[junit4:junit4] 2> 1085835 T2695 oasc.CoreContainer.load Loading CoreContainer using Solr Home: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-jetty4-1372352537897\'
[junit4:junit4] 2> 1085836 T2695 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-jetty4-1372352537897\'
[junit4:junit4] 2> 1085890 T2724 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 4)
[junit4:junit4] 2> 1085890 T2770 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 4)
[junit4:junit4] 2> 1085891 T2717 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 4)
[junit4:junit4] 2> 1085891 T2737 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 4)
[junit4:junit4] 2> 1085892 T2753 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 4)
[junit4:junit4] 2> 1086004 T2695 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 120000
[junit4:junit4] 2> 1086004 T2695 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4] 2> 1086005 T2695 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4:junit4] 2> 1086005 T2695 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4] 2> 1086006 T2695 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4] 2> 1086007 T2695 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4] 2> 1086007 T2695 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4] 2> 1086007 T2695 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4] 2> 1086008 T2695 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4] 2> 1086008 T2695 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=120000&connTimeout=15000&retry=false
[junit4:junit4] 2> 1086019 T2695 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener
[junit4:junit4] 2> 1086020 T2695 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:57954/solr
[junit4:junit4] 2> 1086020 T2695 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4:junit4] 2> 1086023 T2695 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4] 2> 1086027 T2786 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@4a4c615b name:ZooKeeperConnection Watcher:127.0.0.1:57954 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4] 2> 1086029 T2695 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4] 2> 1086035 T2695 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=500&maxConnectionsPerHost=16&socketTimeout=120000&connTimeout=15000
[junit4:junit4] 2> 1086044 T2695 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4] 2> 1086048 T2788 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@5c783100 name:ZooKeeperConnection Watcher:127.0.0.1:57954/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4] 2> 1086049 T2695 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4] 2> 1086057 T2695 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4:junit4] 2> 1086234 T2732 oasha.CoreAdminHandler.handleWaitForStateAction Waited coreNodeName: core_node3, state: recovering, checkLive: true, onlyIfLeader: true for: 1 seconds.
[junit4:junit4] 2> 1086234 T2732 oass.SolrDispatchFilter.handleAdminRequest [admin] webapp=null path=/admin/cores params={coreNodeName=core_node3&state=recovering&nodeName=127.0.0.1:57992_&action=PREPRECOVERY&checkLive=true&core=collection1&wt=javabin&onlyIfLeader=true&version=2} status=0 QTime=1004
[junit4:junit4] 2> 1087061 T2695 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:58005_
[junit4:junit4] 2> 1087068 T2695 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:58005_
[junit4:junit4] 2> 1087072 T2724 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 4)
[junit4:junit4] 2> 1087073 T2737 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 4)
[junit4:junit4] 2> 1087073 T2717 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 4)
[junit4:junit4] 2> 1087074 T2770 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4] 2> 1087075 T2770 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 5)
[junit4:junit4] 2> 1087075 T2788 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4] 2> 1087074 T2753 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4] 2> 1087075 T2753 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 5)
[junit4:junit4] 2> 1087079 T2724 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4] 2> 1087080 T2737 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4] 2> 1087080 T2717 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4] 2> 1087087 T2789 oasc.ZkController.publish publishing core=collection1 state=down
[junit4:junit4] 2> 1087087 T2789 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4] 2> 1087090 T2789 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4:junit4] 2> 1087414 T2718 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 1087416 T2718 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={
[junit4:junit4] 2> "operation":"state",
[junit4:junit4] 2> "core_node_name":"core_node4",
[junit4:junit4] 2> "numShards":"1",
[junit4:junit4] 2> "shard":null,
[junit4:junit4] 2> "roles":null,
[junit4:junit4] 2> "state":"down",
[junit4:junit4] 2> "shard_state":"active",
[junit4:junit4] 2> "core":"collection1",
[junit4:junit4] 2> "collection":"collection1",
[junit4:junit4] 2> "shard_range":null,
[junit4:junit4] 2> "node_name":"127.0.0.1:58005_",
[junit4:junit4] 2> "base_url":"http://127.0.0.1:58005"}
[junit4:junit4] 2> 1087416 T2718 oasc.Overseer$ClusterStateUpdater.updateState Collection already exists with numShards=1
[junit4:junit4] 2> 1087417 T2718 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard1
[junit4:junit4] 2> 1087430 T2724 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4:junit4] 2> 1087431 T2788 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4:junit4] 2> 1087431 T2770 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4:junit4] 2> 1087431 T2717 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4:junit4] 2> 1087431 T2753 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4:junit4] 2> 1087431 T2737 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4:junit4] 2> 1088090 T2789 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1
[junit4:junit4] 2> 1088090 T2789 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-jetty4-1372352537897\collection1
[junit4:junit4] 2> 1088090 T2789 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4] 2> 1088091 T2789 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4] 2> 1088091 T2789 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4] 2> 1088093 T2789 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-jetty4-1372352537897\collection1\'
[junit4:junit4] 2> 1088095 T2789 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/org.apache.solr.cloud.SyncSliceTest-jetty4-1372352537897/collection1/lib/classes/' to classloader
[junit4:junit4] 2> 1088095 T2789 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/org.apache.solr.cloud.SyncSliceTest-jetty4-1372352537897/collection1/lib/README' to classloader
[junit4:junit4] 2> 1088159 T2789 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4] 2> ASYNC NEW_CORE C1908 name=collection1 org.apache.solr.core.SolrCore@722b53b4 url=http://127.0.0.1:57992/collection1 node=127.0.0.1:57992_ C1908_STATE=coll:collection1 core:collection1 props:{state=recovering, core=collection1, node_name=127.0.0.1:57992_, base_url=http://127.0.0.1:57992}
[junit4:junit4] 2> 1088235 T2773 C1908 P57992 oasc.RecoveryStrategy.doRecovery Attempting to PeerSync from http://127.0.0.1:57973/collection1/ core=collection1 - recoveringAfterStartup=true
[junit4:junit4] 2> 1088235 T2773 C1908 P57992 oasu.PeerSync.sync PeerSync: core=collection1 url=http://127.0.0.1:57992 START replicas=[http://127.0.0.1:57973/collection1/] nUpdates=100
[junit4:junit4] 2> 1088236 T2773 C1908 P57992 oasu.PeerSync.sync WARN no frame of reference to tell of we've missed updates
[junit4:junit4] 2> 1088236 T2773 C1908 P57992 oasc.RecoveryStrategy.doRecovery PeerSync Recovery was not successful - trying replication. core=collection1
[junit4:junit4] 2> 1088237 T2773 C1908 P57992 oasc.RecoveryStrategy.doRecovery Starting Replication Recovery. core=collection1
[junit4:junit4] 2> 1088237 T2773 C1908 P57992 oasc.RecoveryStrategy.doRecovery Begin buffering updates. core=collection1
[junit4:junit4] 2> 1088237 T2773 C1908 P57992 oasu.UpdateLog.bufferUpdates Starting to buffer updates. FSUpdateLog{state=ACTIVE, tlog=null}
[junit4:junit4] 2> 1088237 T2773 C1908 P57992 oasc.RecoveryStrategy.replicate Attempting to replicate from http://127.0.0.1:57973/collection1/. core=collection1
[junit4:junit4] 2> 1088238 T2773 C1908 P57992 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4] 2> 1088244 T2789 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4] 2> ASYNC NEW_CORE C1909 name=collection1 org.apache.solr.core.SolrCore@371726b6 url=http://127.0.0.1:57973/collection1 node=127.0.0.1:57973_ C1909_STATE=coll:collection1 core:collection1 props:{state=active, core=collection1, node_name=127.0.0.1:57973_, base_url=http://127.0.0.1:57973, leader=true}
[junit4:junit4] 2> 1088245 T2731 C1909 P57973 oasc.SolrCore.execute [collection1] webapp= path=/get params={getVersions=100&distrib=false&wt=javabin&qt=/get&version=2} status=0 QTime=1
[junit4:junit4] 2> 1088246 T2733 C1909 P57973 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 1088247 T2733 C1909 P57973 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
[junit4:junit4] 2> 1088247 T2733 C1909 P57973 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 1088248 T2733 C1909 P57973 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={waitSearcher=true&openSearcher=false&commit=true&wt=javabin&commit_end_point=true&version=2&softCommit=false} {commit=} 0 2
[junit4:junit4] 2> 1088249 T2773 C1908 P57992 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4:junit4] 2> 1088249 T2789 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4:junit4] 2> 1088249 T2773 C1908 P57992 oash.SnapPuller.<init> No value set for 'pollInterval'. Timer Task not started.
[junit4:junit4] 2> 1088254 T2728 C1909 P57973 oasc.SolrCore.execute [collection1] webapp= path=/replication params={command=indexversion&qt=/replication&wt=javabin&version=2} status=0 QTime=0
[junit4:junit4] 2> 1088255 T2773 C1908 P57992 oasc.RecoveryStrategy.replay No replay needed. core=collection1
[junit4:junit4] 2> 1088255 T2773 C1908 P57992 oasc.RecoveryStrategy.doRecovery Replication Recovery was successful - registering as Active. core=collection1
[junit4:junit4] 2> 1088255 T2773 C1908 P57992 oasc.ZkController.publish publishing core=collection1 state=active
[junit4:junit4] 2> 1088256 T2773 C1908 P57992 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4] 2> 1088260 T2789 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4:junit4] 2> 1088260 T2773 C1908 P57992 oasc.RecoveryStrategy.doRecovery Finished recovery process. core=collection1
[junit4:junit4] 2> 1088939 T2718 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 1088940 T2718 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={
[junit4:junit4] 2> "operation":"state",
[junit4:junit4] 2> "core_node_name":"core_node3",
[junit4:junit4] 2> "numShards":"1",
[junit4:junit4] 2> "shard":"shard1",
[junit4:junit4] 2> "roles":null,
[junit4:junit4] 2> "state":"active",
[junit4:junit4] 2> "shard_state":"active",
[junit4:junit4] 2> "core":"collection1",
[junit4:junit4] 2> "collection":"collection1",
[junit4:junit4] 2> "shard_range":null,
[junit4:junit4] 2> "node_name":"127.0.0.1:57992_",
[junit4:junit4] 2> "base_url":"http://127.0.0.1:57992"}
[junit4:junit4] 2> 1088954 T2724 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4:junit4] 2> 1088955 T2788 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4:junit4] 2> 1088955 T2770 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4:junit4] 2> 1088956 T2717 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4:junit4] 2> 1088956 T2737 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4:junit4] 2> 1088957 T2753 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4:junit4] 2> 1089088 T2789 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4] 2> 1089102 T2789 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4] 2> 1089107 T2789 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4] 2> 1089130 T2789 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4] 2> 1089136 T2789 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4] 2> 1089139 T2789 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4] 2> 1089142 T2789 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4:junit4] 2> 1089143 T2789 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4:junit4] 2> 1089143 T2789 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4] 2> 1089145 T2789 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4:junit4] 2> 1089145 T2789 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4:junit4] 2> 1089145 T2789 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4] 2> 1089145 T2789 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.SyncSliceTest-jetty4-1372352537897\collection1\, dataDir=.\org.apache.solr.cloud.SyncSliceTest-1372352519102/jetty4\
[junit4:junit4] 2> 1089145 T2789 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@4aee0373
[junit4:junit4] 2> 1089146 T2789 oasc.CachingDirectoryFactory.get return new directory for .\org.apache.solr.cloud.SyncSliceTest-1372352519102/jetty4\
[junit4:junit4] 2> 1089146 T2789 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=.\org.apache.solr.cloud.SyncSliceTest-1372352519102/jetty4\index/
[junit4:junit4] 2> 1089146 T2789 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '.\org.apache.solr.cloud.SyncSliceTest-1372352519102\jetty4\index' doesn't exist. Creating new index...
[junit4:junit4] 2> 1089146 T2789 oasc.CachingDirectoryFactory.get return new directory for .\org.apache.solr.cloud.SyncSliceTest-1372352519102/jetty4\index
[junit4:junit4] 2> 1089151 T2789 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@1e8788b1 lockFactory=org.apache.lucene.store.NativeFSLockFactory@1e523f8d),segFN=segments_1,generation=1}
[junit4:junit4] 2> 1089151 T2789 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4:junit4] 2> 1089156 T2789 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4] 2> 1089156 T2789 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4] 2> 1089157 T2789 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4] 2> 1089157 T2789 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4] 2> 1089158 T2789 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4] 2> 1089158 T2789 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4] 2> 1089160 T2789 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4] 2> 1089161 T2789 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4] 2> 1089161 T2789 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4] 2> 1089177 T2789 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4] 2> 1089185 T2789 oass.SolrIndexSearcher.<init> Opening Searcher@74a0c6b3 main
[junit4:junit4] 2> 1089188 T2789 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4] 2> 1089189 T2789 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4] 2> 1089196 T2791 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@74a0c6b3 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4] 2> 1089200 T2789 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4] 2> 1089201 T2789 oasc.ZkController.register Register replica - core:collection1 address:http://127.0.0.1:58005 collection:collection1 shard:shard1
[junit4:junit4] 2> 1089207 T2789 oasc.ZkController.register We are http://127.0.0.1:58005/collection1/ and leader is http://127.0.0.1:57973/collection1/
[junit4:junit4] 2> 1089207 T2789 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:58005
[junit4:junit4] 2> 1089208 T2789 oasc.ZkController.checkRecovery Core needs to recover:collection1
[junit4:junit4] 2> 1089208 T2789 oasu.DefaultSolrCoreState.doRecovery Running recovery - first canceling any ongoing recovery
[junit4:junit4] 2> ASYNC NEW_CORE C1910 name=collection1 org.apache.solr.core.SolrCore@6371d39b url=http://127.0.0.1:58005/collection1 node=127.0.0.1:58005_ C1910_STATE=coll:collection1 core:collection1 props:{state=down, core=collection1, node_name=127.0.0.1:58005_, base_url=http://127.0.0.1:58005}
[junit4:junit4] 2> 1089209 T2792 C1910 P58005 oasc.RecoveryStrategy.run Starting recovery process. core=collection1 recoveringAfterStartup=true
[junit4:junit4] 2> 1089210 T2792 C1910 P58005 oasc.RecoveryStrategy.doRecovery ###### startupVersions=[]
[junit4:junit4] 2> 1089210 T2792 C1910 P58005 oasc.ZkController.publish publishing core=collection1 state=recovering
[junit4:junit4] 2> 1089210 T2792 C1910 P58005 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4] 2> 1089211 T2789 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 1089213 T2792 C1910 P58005 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4] 2> 1089215 T2695 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4:junit4] 2> 1089215 T2695 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4] 2> 1089215 T2695 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4] 2> 1089224 T2695 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 1089226 T2732 oasha.CoreAdminHandler.handleWaitForStateAction Going to wait for coreNodeName: core_node4, state: recovering, checkLive: true, onlyIfLeader: true
[junit4:junit4] 2> 1089227 T2695 oasc.AbstractFullDistribZkTestBase.waitForThingsToLevelOut Wait for recoveries to finish - wait 30 for each attempt
[junit4:junit4] 2> 1089227 T2695 oasc.AbstractDistribZkTestBase.waitForRecoveriesToFinish Wait for recoveries to finish - collection: collection1 failOnTimeout:true timeout (sec):30
[junit4:junit4] 2> 1089230 T2695 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 1090231 T2695 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 1090470 T2718 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 1090470 T2718 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={
[junit4:junit4] 2> "operation":"state",
[junit4:junit4] 2> "core_node_name":"core_node4",
[junit4:junit4] 2> "numShards":"1",
[junit4:junit4] 2> "shard":"shard1",
[junit4:junit4] 2> "roles":null,
[junit4:junit4] 2> "state":"recovering",
[junit4:junit4] 2> "shard_state":"active",
[junit4:junit4] 2> "core":"collection1",
[junit4:junit4] 2> "collection":"collection1",
[junit4:junit4] 2> "shard_range":null,
[junit4:junit4] 2> "node_name":"127.0.0.1:58005_",
[junit4:junit4] 2> "base_url":"http://127.0.0.1:58005"}
[junit4:junit4] 2> 1090483 T2724 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4:junit4] 2> 1090483 T2717 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4:junit4] 2> 1090484 T2753 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4:junit4] 2> 1090484 T2737 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4:junit4] 2> 1090483 T2770 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4:junit4] 2> 1090483 T2788 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json
[...truncated too long message...]
ration 1.7.0_25 (64-bit)/cpus=2,threads=1,free=226119432,total=519438336
[junit4:junit4] 2> NOTE: All tests run in this JVM: [UniqFieldsUpdateProcessorFactoryTest, TestElisionMultitermQuery, PrimUtilsTest, JsonLoaderTest, UpdateParamsTest, TestCoreContainer, SolrRequestParserTest, DirectSolrConnectionTest, DebugComponentTest, TestIndexSearcher, TestUpdate, LeaderElectionIntegrationTest, TestCharFilters, UUIDFieldTest, DisMaxRequestHandlerTest, TestConfig, TestRemoteStreaming, BasicDistributedZkTest, TestReversedWildcardFilterFactory, AutoCommitTest, OpenExchangeRatesOrgProviderTest, CircularListTest, SortByFunctionTest, ZkSolrClientTest, DocValuesTest, NotRequiredUniqueKeyTest, HdfsCollectionsAPIDistributedZkTest, NoCacheHeaderTest, TestValueSourceCache, PingRequestHandlerTest, BasicDistributedZk2Test, TestWriterPerf, OutputWriterTest, ClusterStateTest, QueryResultKeyTest, IndexBasedSpellCheckerTest, TestReloadAndDeleteDocs, TestSearchPerf, StandardRequestHandlerTest, CSVRequestHandlerTest, DocumentAnalysisRequestHandlerTest, TestPostingsSolrHighlighter, RequestHandlersTest, TestCSVLoader, SolrCoreCheckLockOnStartupTest, CoreContainerCoreInitFailuresTest, TestRecovery, ResponseLogComponentTest, DistanceFunctionTest, TestSchemaResource, TestUtils, TestCloudManagedSchema, TestAnalyzedSuggestions, TestRTGBase, MBeansHandlerTest, SignatureUpdateProcessorFactoryTest, TestTrie, TestSolrDeletionPolicy1, TestPerFieldSimilarity, TestFastWriter, SystemInfoHandlerTest, TestSurroundQueryParser, SuggesterTSTTest, BadIndexSchemaTest, TestSolrQueryParserDefaultOperatorResource, TestDefaultSearchFieldResource, TestDynamicFieldCollectionResource, ReturnFieldsTest, HdfsChaosMonkeySafeLeaderTest, TestQuerySenderListener, TestManagedSchemaFieldResource, TestFuzzyAnalyzedSuggestions, SpellPossibilityIteratorTest, DistributedQueryElevationComponentTest, QueryElevationComponentTest, TestQuerySenderNoQuery, SpellingQueryConverterTest, TestOmitPositions, FastVectorHighlighterTest, TestComponentsName, ExternalFileFieldSortTest, SuggesterFSTTest, TestPhraseSuggestions, TestIBSimilarityFactory, TestFieldResource, TestSolrQueryParser, TestDynamicFieldResource, BasicHdfsTest, SpellCheckComponentTest, TestExtendedDismaxParser, ConvertedLegacyTest, TestLuceneMatchVersion, SpellCheckCollatorTest, SolrInfoMBeanTest, SchemaVersionSpecificBehaviorTest, DirectUpdateHandlerOptimizeTest, TestSchemaVersionResource, SynonymTokenizerTest, TestSchemaNameResource, LukeRequestHandlerTest, TestFieldCollectionResource, SoftAutoCommitTest, TermVectorComponentDistributedTest, TestFieldTypeCollectionResource, TestBadConfig, OverseerTest, ChaosMonkeyNothingIsSafeTest, TestSolrCoreProperties, TestJmxMonitoredMap, TestMergePolicyConfig, TestRecoveryHdfs, CurrencyFieldXmlFileTest, TestRangeQuery, ResourceLoaderTest, LeaderElectionTest, TestRandomFaceting, TestSerializedLuceneMatchVersion, MultiTermTest, HdfsSyncSliceTest, TestMultiCoreConfBootstrap, TestLFUCache, IndexSchemaTest, BadCopyFieldTest, TestSolrXml, TestCloudManagedSchemaAddField, SyncSliceTest, XsltUpdateRequestHandlerTest, TestSolrDeletionPolicy2, TestDocSet, DistributedTermsComponentTest, TestShardHandlerFactory, TestCollationField, JSONWriterTest, TestNumberUtils, TestSolrQueryParserResource, LoggingHandlerTest, QueryEqualityTest, TestSolrXmlPersistence, TestStressReorder, TestHashPartitioner, TestPHPSerializedResponseWriter, XmlUpdateRequestHandlerTest, TestFieldTypeResource, TestWordDelimiterFilterFactory, SolrCoreTest, TestDFRSimilarityFactory, DefaultValueUpdateProcessorTest, ChaosMonkeySafeLeaderTest, UnloadDistributedZkTest, CollectionsAPIDistributedZkTest, OpenCloseCoreStressTest, ShardRoutingTest, BasicZkTest, RecoveryZkTest, FullSolrCloudDistribCmdsTest, TestReplicationHandler, ClusterStateUpdateTest, TestZkChroot, TestRandomDVFaceting, ZkCLITest, ShardRoutingCustomTest, SliceStateUpdateTest, TestDistributedSearch, TestDistributedGrouping, TestFaceting, DistributedSpellCheckComponentTest, ZkControllerTest, TestRealTimeGet, TestJoin, TestReload, TestStressVersions, HardAutoCommitTest, SimpleFacetsTest, TestSolr4Spatial, StatsComponentTest, TestGroupingSearch, SolrCmdDistributorTest, PeerSyncTest, TestSort, TestFiltering, TestFunctionQuery, BasicFunctionalityTest, TestLazyCores, DirectUpdateHandlerTest, OverseerCollectionProcessorTest, HighlighterTest, ShowFileRequestHandlerTest, CurrencyFieldOpenExchangeTest, SolrIndexSplitterTest, SimplePostToolTest, TestCoreDiscovery, AnalysisAfterCoreReloadTest, CoreAdminHandlerTest, TestFoldingMultitermQuery, SuggesterTest, TestStressLucene, SpatialFilterTest, SuggesterWFSTTest, PolyFieldTest, WordBreakSolrSpellCheckerTest, TestPseudoReturnFields, FieldMutatingUpdateProcessorTest, TestAtomicUpdateErrorCases, StatelessScriptUpdateProcessorFactoryTest, DocValuesMultiTest, CacheHeaderTest, TestQueryUtils, DirectSolrSpellCheckerTest, TestQueryTypes, PrimitiveFieldTypeTest, FileBasedSpellCheckerTest, TermsComponentTest, DocumentBuilderTest, PathHierarchyTokenizerFactoryTest, TermVectorComponentTest, TestIndexingPerformance, MoreLikeThisHandlerTest, RequiredFieldsTest, FieldAnalysisRequestHandlerTest, TestArbitraryIndexDir, IndexSchemaRuntimeFieldTest, RegexBoostProcessorTest, SolrPluginUtilsTest, TestJmxIntegration, UpdateRequestProcessorFactoryTest, TestCSVResponseWriter, QueryParsingTest, BinaryUpdateRequestHandlerTest, TestPartialUpdateDeduplication, SearchHandlerTest, TestBinaryResponseWriter, HighlighterConfigTest, SOLR749Test, TestPropInject, TestPropInjectDefaults, IndexReaderFactoryTest, AlternateDirectoryTest, TestSolrIndexConfig, CopyFieldTest, SolrIndexConfigTest, BadComponentTest, TestStressRecovery, SampleTest, TestBinaryField, NumericFieldsTest, MinimalSchemaTest, TestCodecSupport, TestXIncludeConfig, EchoParamsTest, TestSweetSpotSimilarityFactory, TestLMDirichletSimilarityFactory, TestLMJelinekMercerSimilarityFactory, TestBM25SimilarityFactory, TestDefaultSimilarityFactory, LegacyHTMLStripCharFilterTest, TestPluginEnable, TimeZoneUtilsTest, TestFastOutputStream, ScriptEngineTest, URLClassifyProcessorTest, PluginInfoTest, TestFastLRUCache, DateMathParserTest, TestSolrXMLSerializer, PreAnalyzedFieldTest, TestSystemIdResolver, TestSuggestSpellingConverter, DateFieldTest, DOMUtilTest, RAMDirectoryFactoryTest, TestSolrJ, TestLRUCache, TestDocumentBuilder, ZkNodePropsTest, SliceStateTest, FileUtilsTest, SolrTestCaseJ4Test, AliasIntegrationTest, AssignTest, ShardSplitTest, HdfsBasicDistributedZk2Test, HdfsBasicDistributedZkTest, HdfsRecoveryZkTest, HdfsUnloadDistributedZkTest, CachingDirectoryFactoryTest, TestClassNameShortening, TestCopyFieldCollectionResource, TestSchemaSimilarityResource, TestUniqueKeyFieldResource, TestManagedSchema, TestAddFieldRealTimeGet, TestMaxScoreQueryParser, BlockCacheTest, BlockDirectoryTest, HdfsDirectoryTest, HdfsLockFactoryTest]
[junit4:junit4] 2> NOTE: reproduce with: ant test -Dtestcase=HdfsLockFactoryTest -Dtests.seed=30F6417CE1069825 -Dtests.slow=true -Dtests.locale=th_TH -Dtests.timezone=Pacific/Port_Moresby -Dtests.file.encoding=Cp1252
[junit4:junit4] ERROR 0.00s | HdfsLockFactoryTest (suite) <<<
[junit4:junit4] > Throwable #1: java.security.AccessControlException: access denied ("java.io.FilePermission" "C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test" "write")
[junit4:junit4] > at __randomizedtesting.SeedInfo.seed([30F6417CE1069825]:0)
[junit4:junit4] > at java.security.AccessControlContext.checkPermission(AccessControlContext.java:372)
[junit4:junit4] > at java.security.AccessController.checkPermission(AccessController.java:559)
[junit4:junit4] > at java.lang.SecurityManager.checkPermission(SecurityManager.java:549)
[junit4:junit4] > at java.lang.SecurityManager.checkWrite(SecurityManager.java:979)
[junit4:junit4] > at java.io.File.canWrite(File.java:750)
[junit4:junit4] > at org.apache.hadoop.hdfs.MiniDFSCluster.createPermissionsDiagnosisString(MiniDFSCluster.java:683)
[junit4:junit4] > at org.apache.hadoop.hdfs.MiniDFSCluster.initMiniDFSCluster(MiniDFSCluster.java:647)
[junit4:junit4] > at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:585)
[junit4:junit4] > at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:456)
[junit4:junit4] > at org.apache.solr.cloud.hdfs.HdfsTestUtil.setupClass(HdfsTestUtil.java:52)
[junit4:junit4] > at org.apache.solr.store.hdfs.HdfsLockFactoryTest.beforeClass(HdfsLockFactoryTest.java:47)
[junit4:junit4] > at java.lang.Thread.run(Thread.java:724)
[junit4:junit4] Completed in 0.20s, 0 tests, 1 error <<< FAILURES!
[...truncated 24 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:386: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:366: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:39: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:190: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:443: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1243: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:887: There were test failures: 312 suites, 1293 tests, 11 suite-level errors, 1 error, 1 failure, 18 ignored (12 assumptions)
Total time: 68 minutes 30 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 64bit/jdk1.7.0_25 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure