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/11/30 00:12:09 UTC
[JENKINS] Lucene-Solr-4.x-Linux (32bit/jdk1.7.0_45) - Build # 8414
- Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Linux/8414/
Java: 32bit/jdk1.7.0_45 -server -XX:+UseSerialGC
1 tests failed.
REGRESSION: org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest.testDistribSearch
Error Message:
shard1 is not consistent. Got 779 from http://127.0.0.1:57124/lwq/collection1lastClient and got 778 from http://127.0.0.1:37147/lwq/collection1
Stack Trace:
java.lang.AssertionError: shard1 is not consistent. Got 779 from http://127.0.0.1:57124/lwq/collection1lastClient and got 778 from http://127.0.0.1:37147/lwq/collection1
at __randomizedtesting.SeedInfo.seed([7DF16766ED860479:FC17E97E9AD96445]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.apache.solr.cloud.AbstractFullDistribZkTestBase.checkShardConsistency(AbstractFullDistribZkTestBase.java:1153)
at org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest.doTest(ChaosMonkeyNothingIsSafeTest.java:197)
at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:843)
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:744)
Build Log:
[...truncated 10300 lines...]
[junit4] Suite: org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest
[junit4] 2> 174680 T494 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /lwq/
[junit4] 2> 174685 T494 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
[junit4] 2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-ChaosMonkeyNothingIsSafeTest-1385765241192
[junit4] 2> 174685 T494 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 2> 174686 T495 oasc.ZkTestServer$ZKServerMain.runFromConfig Starting server
[junit4] 2> 174786 T494 oasc.ZkTestServer.run start zk server on port:33810
[junit4] 2> 174787 T494 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 174947 T501 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@c1343b name:ZooKeeperConnection Watcher:127.0.0.1:33810 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 174948 T494 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 174948 T494 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 174955 T494 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 174957 T503 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@181c435 name:ZooKeeperConnection Watcher:127.0.0.1:33810/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 174957 T494 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 174958 T494 oascc.SolrZkClient.makePath makePath: /collections/collection1
[junit4] 2> 174962 T494 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards
[junit4] 2> 174965 T494 oascc.SolrZkClient.makePath makePath: /collections/control_collection
[junit4] 2> 174967 T494 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards
[junit4] 2> 174970 T494 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml
[junit4] 2> 174970 T494 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4] 2> 174975 T494 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml
[junit4] 2> 174976 T494 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml
[junit4] 2> 174979 T494 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 174979 T494 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 174982 T494 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
[junit4] 2> 174983 T494 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt
[junit4] 2> 174986 T494 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
[junit4] 2> 174986 T494 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt
[junit4] 2> 174989 T494 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
[junit4] 2> 174989 T494 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml
[junit4] 2> 174992 T494 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml
[junit4] 2> 174992 T494 oascc.SolrZkClient.makePath makePath: /configs/conf1/enumsConfig.xml
[junit4] 2> 174995 T494 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
[junit4] 2> 174995 T494 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json
[junit4] 2> 175000 T494 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 175001 T494 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 175004 T494 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
[junit4] 2> 175005 T494 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt
[junit4] 2> 175010 T494 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
[junit4] 2> 175010 T494 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt
[junit4] 2> 175080 T494 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 175084 T494 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:59754
[junit4] 2> 175084 T494 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 175085 T494 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 175085 T494 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-controljetty-1385765241521
[junit4] 2> 175085 T494 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-controljetty-1385765241521/'
[junit4] 2> 175095 T494 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-controljetty-1385765241521/solr.xml
[junit4] 2> 175134 T494 oasc.CoreContainer.<init> New CoreContainer 6521521
[junit4] 2> 175135 T494 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-controljetty-1385765241521/]
[junit4] 2> 175136 T494 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 175136 T494 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 175136 T494 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 175137 T494 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 175137 T494 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 175137 T494 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 175137 T494 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 175138 T494 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 175138 T494 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 175142 T494 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 175142 T494 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 175142 T494 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 175143 T494 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:33810/solr
[junit4] 2> 175143 T494 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 175144 T494 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 175146 T514 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1a9fba8 name:ZooKeeperConnection Watcher:127.0.0.1:33810 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 175146 T494 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 175150 T494 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 175151 T516 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1ff3e96 name:ZooKeeperConnection Watcher:127.0.0.1:33810/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 175151 T494 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 175153 T494 oascc.SolrZkClient.makePath makePath: /overseer/queue
[junit4] 2> 175160 T494 oascc.SolrZkClient.makePath makePath: /overseer/collection-queue-work
[junit4] 2> 175163 T494 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4] 2> 175165 T494 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:59754_lwq
[junit4] 2> 175166 T494 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:59754_lwq
[junit4] 2> 175169 T494 oascc.SolrZkClient.makePath makePath: /overseer_elect/election
[junit4] 2> 175531 T494 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4] 2> 175543 T494 oasc.Overseer.start Overseer (id=90817510846955523-127.0.0.1:59754_lwq-n_0000000000) starting
[junit4] 2> 175547 T494 oascc.SolrZkClient.makePath makePath: /overseer/queue-work
[junit4] 2> 175552 T518 oasc.OverseerCollectionProcessor.run Process current queue of collection creations
[junit4] 2> 175553 T494 oascc.SolrZkClient.makePath makePath: /clusterstate.json
[junit4] 2> 175556 T494 oascc.SolrZkClient.makePath makePath: /aliases.json
[junit4] 2> 175558 T494 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 175561 T517 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4] 2> 175565 T519 oasc.ZkController.publish publishing core=collection1 state=down
[junit4] 2> 175565 T519 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4] 2> 175567 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 175567 T519 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 175568 T517 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 175569 T517 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:59754/lwq",
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:59754_lwq",
[junit4] 2> "shard":null,
[junit4] 2> "shard_range":null,
[junit4] 2> "shard_state":"active",
[junit4] 2> "shard_parent":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "numShards":"1",
[junit4] 2> "core_node_name":null}
[junit4] 2> 175569 T517 oasc.Overseer$ClusterStateUpdater.createCollection Create collection control_collection with shards [shard1]
[junit4] 2> 175569 T517 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard1
[junit4] 2> 175572 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 175573 T516 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 176567 T519 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1
[junit4] 2> 176567 T519 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-controljetty-1385765241521/collection1
[junit4] 2> 176567 T519 oasc.ZkController.createCollectionZkNode Check for collection zkNode:control_collection
[junit4] 2> 176568 T519 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 176568 T519 oascc.ZkStateReader.readConfigName Load collection config from:/collections/control_collection
[junit4] 2> 176570 T519 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-controljetty-1385765241521/collection1/'
[junit4] 2> 176570 T519 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-controljetty-1385765241521/collection1/lib/classes/' to classloader
[junit4] 2> 176570 T519 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-controljetty-1385765241521/collection1/lib/README' to classloader
[junit4] 2> 176600 T519 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 176629 T519 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 176630 T519 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 176637 T519 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 176959 T519 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 176960 T519 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 176960 T519 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 176966 T519 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 176968 T519 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 176986 T519 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 176989 T519 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 176992 T519 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 176993 T519 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 176993 T519 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 176993 T519 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 176994 T519 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 176994 T519 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 176995 T519 oasc.SolrCore.initDirectoryFactory solr.StandardDirectoryFactory
[junit4] 2> 177000 T519 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-controljetty-1385765241521/collection1/, dataDir=./org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-1385765241192/control/data/
[junit4] 2> 177000 T519 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1e426ac
[junit4] 2> 177001 T519 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-1385765241192/control/data
[junit4] 2> 177001 T519 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-1385765241192/control/data/index/
[junit4] 2> 177001 T519 oasc.SolrCore.initIndex WARN [collection1] Solr index directory './org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-1385765241192/control/data/index' doesn't exist. Creating new index...
[junit4] 2> 177002 T519 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-1385765241192/control/data/index
[junit4] 2> 177002 T519 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=42, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4899526501379169]
[junit4] 2> 177086 T519 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-1385765241192/control/data/index,segFN=segments_1,generation=1}
[junit4] 2> 177087 T519 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 177089 T519 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib"
[junit4] 2> 177090 T519 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 177090 T519 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 177090 T519 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 177090 T519 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 177090 T519 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 177091 T519 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 177091 T519 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 177091 T519 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 177092 T519 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 177092 T519 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 177092 T519 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 177092 T519 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 177093 T519 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 177093 T519 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 177094 T519 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 177098 T519 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 177108 T519 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 177108 T519 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 177108 T519 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=48, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.15587410933049428]
[junit4] 2> 177109 T519 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-1385765241192/control/data/index,segFN=segments_1,generation=1}
[junit4] 2> 177109 T519 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 177110 T519 oass.SolrIndexSearcher.<init> Opening Searcher@49bf5 main
[junit4] 2> 177112 T520 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@49bf5 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 177113 T519 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 177113 T519 oasc.ZkController.register Register replica - core:collection1 address:http://127.0.0.1:59754/lwq collection:control_collection shard:shard1
[junit4] 2> 177114 T519 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leader_elect/shard1/election
[junit4] 2> 177122 T519 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard1
[junit4] 2> 177124 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 177124 T519 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4] 2> 177125 T519 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4] 2> ASYNC NEW_CORE C2332 name=collection1 org.apache.solr.core.SolrCore@10cd7ee url=http://127.0.0.1:59754/lwq/collection1 node=127.0.0.1:59754_lwq C2332_STATE=coll:control_collection core:collection1 props:{state=down, base_url=http://127.0.0.1:59754/lwq, core=collection1, node_name=127.0.0.1:59754_lwq}
[junit4] 2> 177125 T519 C2332 P59754 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:59754/lwq/collection1/
[junit4] 2> 177125 T517 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 177125 T519 C2332 P59754 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4] 2> 177126 T519 C2332 P59754 oasc.SyncStrategy.syncToMe http://127.0.0.1:59754/lwq/collection1/ has no replicas
[junit4] 2> 177126 T519 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:59754/lwq/collection1/ shard1
[junit4] 2> 177126 T519 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leaders/shard1
[junit4] 2> 177128 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 177135 T516 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 177152 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 177154 T517 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 177203 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 177306 T516 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 177353 T519 oasc.ZkController.register We are http://127.0.0.1:59754/lwq/collection1/ and leader is http://127.0.0.1:59754/lwq/collection1/
[junit4] 2> 177354 T519 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:59754/lwq
[junit4] 2> 177354 T519 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4] 2> 177354 T519 oasc.ZkController.publish publishing core=collection1 state=active
[junit4] 2> 177354 T519 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4] 2> 177356 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 177356 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 177356 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 177356 T519 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 177358 T494 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1
[junit4] 2> 177358 T494 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 177358 T517 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 177360 T517 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"active",
[junit4] 2> "base_url":"http://127.0.0.1:59754/lwq",
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:59754_lwq",
[junit4] 2> "shard":"shard1",
[junit4] 2> "shard_range":null,
[junit4] 2> "shard_state":"active",
[junit4] 2> "shard_parent":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "numShards":"1",
[junit4] 2> "core_node_name":"core_node1"}
[junit4] 2> 177361 T494 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 177362 T523 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@13893b8 name:ZooKeeperConnection Watcher:127.0.0.1:33810/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 177363 T494 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 177364 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 177365 T494 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 177367 T494 oasc.ChaosMonkey.monkeyLog monkey: init - expire sessions:false cause connection loss:false
[junit4] 2> 177440 T494 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 177443 T494 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:58418
[junit4] 2> 177443 T494 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 177444 T494 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 177444 T494 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-jetty1-1385765243875
[junit4] 2> 177444 T494 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-jetty1-1385765243875/'
[junit4] 2> 177454 T494 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-jetty1-1385765243875/solr.xml
[junit4] 2> 177466 T523 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 177466 T516 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 177488 T494 oasc.CoreContainer.<init> New CoreContainer 2504129
[junit4] 2> 177488 T494 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-jetty1-1385765243875/]
[junit4] 2> 177489 T494 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 177490 T494 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 177490 T494 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 177490 T494 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 177490 T494 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 177491 T494 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 177491 T494 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 177491 T494 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 177491 T494 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 177495 T494 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 177495 T494 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 177496 T494 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 177496 T494 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:33810/solr
[junit4] 2> 177496 T494 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 177497 T494 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 177498 T534 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@3e479c name:ZooKeeperConnection Watcher:127.0.0.1:33810 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 177499 T494 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 177501 T494 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 177502 T536 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@17637b5 name:ZooKeeperConnection Watcher:127.0.0.1:33810/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 177503 T494 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 177507 T494 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 178510 T494 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:58418_lwq
[junit4] 2> 178512 T494 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:58418_lwq
[junit4] 2> 178515 T523 oascc.ZkStateReader$3.process Updating live nodes... (2)
[junit4] 2> 178515 T516 oascc.ZkStateReader$3.process Updating live nodes... (2)
[junit4] 2> 178515 T536 oascc.ZkStateReader$3.process Updating live nodes... (2)
[junit4] 2> 178559 T537 oasc.ZkController.publish publishing core=collection1 state=down
[junit4] 2> 178559 T537 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4] 2> 178561 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 178561 T537 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 178561 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 178562 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 178564 T517 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 178564 T517 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:58418/lwq",
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:58418_lwq",
[junit4] 2> "shard":null,
[junit4] 2> "shard_range":null,
[junit4] 2> "shard_state":"active",
[junit4] 2> "shard_parent":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "core_node_name":null}
[junit4] 2> 178565 T517 oasc.Overseer$ClusterStateUpdater.createCollection Create collection collection1 with shards [shard1, shard2]
[junit4] 2> 178565 T517 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard2
[junit4] 2> 178567 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 178670 T523 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 178671 T536 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 178671 T516 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 179562 T537 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1
[junit4] 2> 179562 T537 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-jetty1-1385765243875/collection1
[junit4] 2> 179562 T537 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4] 2> 179563 T537 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 179563 T537 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1
[junit4] 2> 179565 T537 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-jetty1-1385765243875/collection1/'
[junit4] 2> 179565 T537 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-jetty1-1385765243875/collection1/lib/classes/' to classloader
[junit4] 2> 179566 T537 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-jetty1-1385765243875/collection1/lib/README' to classloader
[junit4] 2> 179601 T537 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 179640 T537 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 179642 T537 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 179648 T537 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 180079 T537 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 180080 T537 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 180081 T537 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 180088 T537 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 180090 T537 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 180110 T537 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 180114 T537 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 180119 T537 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 180120 T537 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 180121 T537 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 180121 T537 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 180122 T537 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 180122 T537 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 180123 T537 oasc.SolrCore.initDirectoryFactory solr.StandardDirectoryFactory
[junit4] 2> 180123 T537 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-jetty1-1385765243875/collection1/, dataDir=./org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-1385765241192/jetty1/
[junit4] 2> 180123 T537 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1e426ac
[junit4] 2> 180124 T537 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-1385765241192/jetty1
[junit4] 2> 180124 T537 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-1385765241192/jetty1/index/
[junit4] 2> 180125 T537 oasc.SolrCore.initIndex WARN [collection1] Solr index directory './org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-1385765241192/jetty1/index' doesn't exist. Creating new index...
[junit4] 2> 180125 T537 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-1385765241192/jetty1/index
[junit4] 2> 180125 T537 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=42, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4899526501379169]
[junit4] 2> 180167 T537 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-1385765241192/jetty1/index,segFN=segments_1,generation=1}
[junit4] 2> 180168 T537 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 180171 T537 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib"
[junit4] 2> 180171 T537 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 180171 T537 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 180172 T537 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 180172 T537 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 180172 T537 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 180172 T537 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 180173 T537 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 180173 T537 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 180174 T537 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 180174 T537 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 180174 T537 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 180175 T537 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 180175 T537 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 180176 T537 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 180177 T537 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 180179 T537 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 180181 T537 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 180181 T537 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 180183 T537 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=48, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.15587410933049428]
[junit4] 2> 180183 T537 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-1385765241192/jetty1/index,segFN=segments_1,generation=1}
[junit4] 2> 180183 T537 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 180184 T537 oass.SolrIndexSearcher.<init> Opening Searcher@c0ddb7 main
[junit4] 2> 180188 T538 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@c0ddb7 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 180190 T537 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 180190 T537 oasc.ZkController.register Register replica - core:collection1 address:http://127.0.0.1:58418/lwq collection:collection1 shard:shard2
[junit4] 2> 180191 T537 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard2/election
[junit4] 2> 180199 T537 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard2
[junit4] 2> 180201 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 180201 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 180201 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 180201 T537 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4] 2> 180202 T537 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4] 2> ASYNC NEW_CORE C2333 name=collection1 org.apache.solr.core.SolrCore@cb2ea url=http://127.0.0.1:58418/lwq/collection1 node=127.0.0.1:58418_lwq C2333_STATE=coll:collection1 core:collection1 props:{state=down, base_url=http://127.0.0.1:58418/lwq, core=collection1, node_name=127.0.0.1:58418_lwq}
[junit4] 2> 180202 T537 C2333 P58418 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:58418/lwq/collection1/
[junit4] 2> 180202 T537 C2333 P58418 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4] 2> 180203 T537 C2333 P58418 oasc.SyncStrategy.syncToMe http://127.0.0.1:58418/lwq/collection1/ has no replicas
[junit4] 2> 180203 T517 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 180203 T537 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:58418/lwq/collection1/ shard2
[junit4] 2> 180203 T537 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard2
[junit4] 2> 180206 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 180207 T516 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 180207 T523 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 180207 T536 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 180211 T517 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 180213 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 180316 T523 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 180316 T536 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 180316 T516 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 180360 T537 oasc.ZkController.register We are http://127.0.0.1:58418/lwq/collection1/ and leader is http://127.0.0.1:58418/lwq/collection1/
[junit4] 2> 180361 T537 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:58418/lwq
[junit4] 2> 180361 T537 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4] 2> 180361 T537 oasc.ZkController.publish publishing core=collection1 state=active
[junit4] 2> 180361 T537 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4] 2> 180363 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 180363 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 180363 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 180364 T537 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 180365 T494 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1
[junit4] 2> 180365 T494 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 180365 T517 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 180366 T517 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"active",
[junit4] 2> "base_url":"http://127.0.0.1:58418/lwq",
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:58418_lwq",
[junit4] 2> "shard":"shard2",
[junit4] 2> "shard_range":null,
[junit4] 2> "shard_state":"active",
[junit4] 2> "shard_parent":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "core_node_name":"core_node1"}
[junit4] 2> 180370 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 180436 T494 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 180438 T494 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:54896
[junit4] 2> 180439 T494 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 180439 T494 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 180439 T494 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-jetty2-1385765246873
[junit4] 2> 180440 T494 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-jetty2-1385765246873/'
[junit4] 2> 180450 T494 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-jetty2-1385765246873/solr.xml
[junit4] 2> 180473 T536 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 180473 T516 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 180473 T523 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 180484 T494 oasc.CoreContainer.<init> New CoreContainer 25921392
[junit4] 2> 180485 T494 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-jetty2-1385765246873/]
[junit4] 2> 180486 T494 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 180486 T494 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 180486 T494 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 180487 T494 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 180487 T494 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 180487 T494 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 180487 T494 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 180488 T494 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 180488 T494 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 180491 T494 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 180492 T494 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 180492 T494 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 180492 T494 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:33810/solr
[junit4] 2> 180493 T494 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 180493 T494 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 180495 T550 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@f24c5a name:ZooKeeperConnection Watcher:127.0.0.1:33810 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 180496 T494 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 180498 T494 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 180499 T552 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@8a2d1 name:ZooKeeperConnection Watcher:127.0.0.1:33810/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 180500 T494 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 180503 T494 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 181507 T494 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:54896_lwq
[junit4] 2> 181508 T494 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:54896_lwq
[junit4] 2> 181514 T523 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4] 2> 181515 T516 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4] 2> 181515 T552 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4] 2> 181514 T536 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4] 2> 181525 T553 oasc.ZkController.publish publishing core=collection1 state=down
[junit4] 2> 181525 T553 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4] 2> 181527 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 181527 T553 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 181527 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 181527 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 181530 T517 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 181532 T517 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:54896/lwq",
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:54896_lwq",
[junit4] 2> "shard":null,
[junit4] 2> "shard_range":null,
[junit4] 2> "shard_state":"active",
[junit4] 2> "shard_parent":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "core_node_name":null}
[junit4] 2> 181532 T517 oasc.Overseer$ClusterStateUpdater.updateState Collection already exists with numShards=2
[junit4] 2> 181532 T517 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard1
[junit4] 2> 181536 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 181640 T516 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 181640 T536 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 181640 T523 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 181640 T552 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 182527 T553 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1
[junit4] 2> 182528 T553 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-jetty2-1385765246873/collection1
[junit4] 2> 182528 T553 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4] 2> 182529 T553 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 182529 T553 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1
[junit4] 2> 182530 T553 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-jetty2-1385765246873/collection1/'
[junit4] 2> 182530 T553 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-jetty2-1385765246873/collection1/lib/classes/' to classloader
[junit4] 2> 182531 T553 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-jetty2-1385765246873/collection1/lib/README' to classloader
[junit4] 2> 182574 T553 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 182607 T553 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 182609 T553 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 182616 T553 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 182960 T553 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 182960 T553 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 182961 T553 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 182967 T553 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 182970 T553 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 182986 T553 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 182989 T553 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 182992 T553 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 182993 T553 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 182993 T553 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 182994 T553 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 182995 T553 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 182995 T553 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 182995 T553 oasc.SolrCore.initDirectoryFactory solr.StandardDirectoryFactory
[junit4] 2> 182995 T553 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-jetty2-1385765246873/collection1/, dataDir=./org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-1385765241192/jetty2/
[junit4] 2> 182995 T553 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1e426ac
[junit4] 2> 182996 T553 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-1385765241192/jetty2
[junit4] 2> 182996 T553 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-1385765241192/jetty2/index/
[junit4] 2> 182996 T553 oasc.SolrCore.initIndex WARN [collection1] Solr index directory './org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-1385765241192/jetty2/index' doesn't exist. Creating new index...
[junit4] 2> 182997 T553 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-1385765241192/jetty2/index
[junit4] 2> 182997 T553 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=42, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4899526501379169]
[junit4] 2> 183000 T553 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-1385765241192/jetty2/index,segFN=segments_1,generation=1}
[junit4] 2> 183000 T553 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 183003 T553 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib"
[junit4] 2> 183003 T553 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 183003 T553 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 183003 T553 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 183004 T553 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 183004 T553 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 183004 T553 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 183004 T553 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 183005 T553 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 183005 T553 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 183005 T553 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 183006 T553 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 183006 T553 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 183006 T553 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 183007 T553 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 183007 T553 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 183009 T553 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 183011 T553 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 183011 T553 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 183012 T553 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=48, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.15587410933049428]
[junit4] 2> 183013 T553 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-1385765241192/jetty2/index,segFN=segments_1,generation=1}
[junit4] 2> 183013 T553 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 183013 T553 oass.SolrIndexSearcher.<init> Opening Searcher@1902f40 main
[junit4] 2> 183016 T554 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1902f40 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 183018 T553 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 183018 T553 oasc.ZkController.register Register replica - core:collection1 address:http://127.0.0.1:54896/lwq collection:collection1 shard:shard1
[junit4] 2> 183019 T553 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard1/election
[junit4] 2> 183025 T553 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard1
[junit4] 2> 183027 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 183027 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 183027 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 183027 T553 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4] 2> 183027 T553 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4] 2> ASYNC NEW_CORE C2334 name=collection1 org.apache.solr.core.SolrCore@dd84fc url=http://127.0.0.1:54896/lwq/collection1 node=127.0.0.1:54896_lwq C2334_STATE=coll:collection1 core:collection1 props:{state=down, base_url=http://127.0.0.1:54896/lwq, core=collection1, node_name=127.0.0.1:54896_lwq}
[junit4] 2> 183028 T553 C2334 P54896 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:54896/lwq/collection1/
[junit4] 2> 183028 T553 C2334 P54896 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4] 2> 183028 T553 C2334 P54896 oasc.SyncStrategy.syncToMe http://127.0.0.1:54896/lwq/collection1/ has no replicas
[junit4] 2> 183028 T517 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 183028 T553 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:54896/lwq/collection1/ shard1
[junit4] 2> 183029 T553 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard1
[junit4] 2> 183032 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 183034 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 183037 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 183139 T516 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 183140 T552 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 183139 T523 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 183139 T536 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 183185 T553 oasc.ZkController.register We are http://127.0.0.1:54896/lwq/collection1/ and leader is http://127.0.0.1:54896/lwq/collection1/
[junit4] 2> 183185 T553 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:54896/lwq
[junit4] 2> 183185 T553 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4] 2> 183185 T553 oasc.ZkController.publish publishing core=collection1 state=active
[junit4] 2> 183186 T553 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4] 2> 183188 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 183188 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 183188 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 183188 T553 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 183189 T494 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1
[junit4] 2> 183190 T494 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 183190 T517 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 183191 T517 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"active",
[junit4] 2> "base_url":"http://127.0.0.1:54896/lwq",
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:54896_lwq",
[junit4] 2> "shard":"shard1",
[junit4] 2> "shard_range":null,
[junit4] 2> "shard_state":"active",
[junit4] 2> "shard_parent":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "core_node_name":"core_node2"}
[junit4] 2> 183194 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 183258 T494 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 183261 T494 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:48329
[junit4] 2> 183262 T494 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 183262 T494 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 183263 T494 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-jetty3-1385765249698
[junit4] 2> 183263 T494 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-jetty3-1385765249698/'
[junit4] 2> 183277 T494 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-jetty3-1385765249698/solr.xml
[junit4] 2> 183303 T516 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 183303 T536 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 183303 T523 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 183303 T552 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 183330 T494 oasc.CoreContainer.<init> New CoreContainer 14047276
[junit4] 2> 183331 T494 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-jetty3-1385765249698/]
[junit4] 2> 183332 T494 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 183332 T494 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 183332 T494 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 183332 T494 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 183333 T494 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 183333 T494 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 183333 T494 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 183333 T494 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 183334 T494 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 183337 T494 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 183337 T494 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 183338 T494 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 183338 T494 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:33810/solr
[junit4] 2> 183338 T494 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 183339 T494 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 183342 T566 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@ba1373 name:ZooKeeperConnection Watcher:127.0.0.1:33810 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 183342 T494 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 183345 T494 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 183347 T568 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@17600c2 name:ZooKeeperConnection Watcher:127.0.0.1:33810/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 183347 T494 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 183354 T494 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 184360 T494 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:48329_lwq
[junit4] 2> 184361 T494 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:48329_lwq
[junit4] 2> 184368 T568 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4] 2> 184368 T516 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4] 2> 184368 T552 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4] 2> 184368 T536 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4] 2> 184368 T523 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4] 2> 184378 T569 oasc.ZkController.publish publishing core=collection1 state=down
[junit4] 2> 184378 T569 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4] 2> 184380 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 184380 T569 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 184380 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 184381 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 184385 T517 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 184386 T517 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:48329/lwq",
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:48329_lwq",
[junit4] 2> "shard":null,
[junit4] 2> "shard_range":null,
[junit4] 2> "shard_state":"active",
[junit4] 2> "shard_parent":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "core_node_name":null}
[junit4] 2> 184387 T517 oasc.Overseer$ClusterStateUpdater.updateState Collection already exists with numShards=2
[junit4] 2> 184387 T517 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard2
[junit4] 2> 184392 T516 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 184496 T568 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 4)
[junit4] 2> 184496 T523 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 4)
[junit4] 2> 184496 T516 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 4)
[junit4] 2> 184496 T536 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 4)
[junit4] 2> 184496 T552 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 4)
[junit4] 2> 185381 T569 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1
[junit4] 2> 185381 T569 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-jetty3-1385765249698/collection1
[junit4] 2> 185381 T569 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4] 2> 185383 T569 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 185383 T569 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1
[junit4] 2> 185385 T569 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-jetty3-1385765249698/collection1/'
[junit4] 2> 185387 T569 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-jetty3-1385765249698/collection1/lib/classes/' to classloader
[junit4] 2> 185387 T569 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.c
[...truncated too long message...]
IamLeaderProcess(LeaderElector.java:165)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:109)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.access$000(LeaderElector.java:55)
[junit4] 2> at org.apache.solr.cloud.LeaderElector$1.process(LeaderElector.java:138)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:519)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:495)
[junit4] 2>
[junit4] 2> 452492 T910 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=22,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=2}
[junit4] 2> 452493 T910 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 452493 T910 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 452493 T910 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 452494 T910 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 452495 T910 oasc.CachingDirectoryFactory.close Closing StandardDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 452495 T910 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-1385765241192/jetty7 [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-1385765241192/jetty7;done=false>>]
[junit4] 2> 452495 T910 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-1385765241192/jetty7
[junit4] 2> 452495 T910 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-1385765241192/jetty7/index.20131129235103110 [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-1385765241192/jetty7/index.20131129235103110;done=false>>]
[junit4] 2> 452495 T910 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest-1385765241192/jetty7/index.20131129235103110
[junit4] 2> 452496 T910 oasc.LeaderElector$1.process WARN org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /collections/collection1/leader_elect/shard2/election
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at org.apache.zookeeper.ZooKeeper.getChildren(ZooKeeper.java:1468)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:252)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:249)
[junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:65)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.getChildren(SolrZkClient.java:249)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:93)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.joinElection(LeaderElector.java:277)
[junit4] 2> at org.apache.solr.cloud.ShardLeaderElectionContext.rejoinLeaderElection(ElectionContext.java:388)
[junit4] 2> at org.apache.solr.cloud.ShardLeaderElectionContext.runLeaderProcess(ElectionContext.java:178)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.runIamLeaderProcess(LeaderElector.java:165)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:109)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.joinElection(LeaderElector.java:277)
[junit4] 2> at org.apache.solr.cloud.ShardLeaderElectionContext.rejoinLeaderElection(ElectionContext.java:388)
[junit4] 2> at org.apache.solr.cloud.ShardLeaderElectionContext.runLeaderProcess(ElectionContext.java:178)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.runIamLeaderProcess(LeaderElector.java:165)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:109)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.joinElection(LeaderElector.java:277)
[junit4] 2> at org.apache.solr.cloud.ShardLeaderElectionContext.rejoinLeaderElection(ElectionContext.java:388)
[junit4] 2> at org.apache.solr.cloud.ShardLeaderElectionContext.runLeaderProcess(ElectionContext.java:178)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.runIamLeaderProcess(LeaderElector.java:165)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:109)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.access$000(LeaderElector.java:55)
[junit4] 2> at org.apache.solr.cloud.LeaderElector$1.process(LeaderElector.java:138)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:519)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:495)
[junit4] 2>
[junit4] 2> 452496 T910 oascc.ZkStateReader$3.process WARN ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 2> 452496 T910 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 452496 T910 oascc.ZkStateReader$2.process WARN ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 2> 452497 T910 oasc.LeaderElector$1.process WARN org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /overseer_elect/election
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at org.apache.zookeeper.ZooKeeper.getChildren(ZooKeeper.java:1468)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:252)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:249)
[junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:65)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.getChildren(SolrZkClient.java:249)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:93)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.access$000(LeaderElector.java:55)
[junit4] 2> at org.apache.solr.cloud.LeaderElector$1.process(LeaderElector.java:138)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:519)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:495)
[junit4] 2>
[junit4] 2> NOTE: test params are: codec=Lucene40, sim=DefaultSimilarity, locale=es_BO, timezone=Europe/Oslo
[junit4] 2> NOTE: Linux 3.8.0-33-generic i386/Oracle Corporation 1.7.0_45 (32-bit)/cpus=8,threads=1,free=62461880,total=250806272
[junit4] 2> NOTE: All tests run in this JVM: [TestQuerySenderListener, DeleteInactiveReplicaTest, TestDocBasedVersionConstraints, TestStressRecovery, TestCSVLoader, TestFieldTypeCollectionResource, TestWordDelimiterFilterFactory, TestCSVResponseWriter, AddSchemaFieldsUpdateProcessorFactoryTest, DocValuesMissingTest, SpellingQueryConverterTest, TestSolrJ, TestSweetSpotSimilarityFactory, OutputWriterTest, TestRandomMergePolicy, TestCloudManagedSchema, BlockDirectoryTest, TestOmitPositions, CoreContainerCoreInitFailuresTest, StandardRequestHandlerTest, DistributedQueryComponentCustomSortTest, TestHashPartitioner, TestSimpleQParserPlugin, TestDFRSimilarityFactory, TestUtils, ChaosMonkeyNothingIsSafeTest]
[junit4] Completed on J1 in 278.68s, 1 test, 1 failure <<< FAILURES!
[...truncated 834 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:426: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:406: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:39: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/extra-targets.xml:37: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build.xml:189: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/common-build.xml:491: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:1279: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:912: There were test failures: 349 suites, 1516 tests, 1 failure, 34 ignored (6 assumptions)
Total time: 49 minutes 22 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 32bit/jdk1.7.0_45 -server -XX:+UseSerialGC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure
[JENKINS] Lucene-Solr-4.x-Linux (32bit/ibm-j9-jdk6) - Build # 8415
- Still Failing!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Linux/8415/
Java: 32bit/ibm-j9-jdk6 -Xjit:exclude={org/apache/lucene/util/fst/FST.pack(IIF)Lorg/apache/lucene/util/fst/FST;}
4 tests failed.
REGRESSION: org.apache.solr.handler.component.DistributedQueryElevationComponentTest.testDistribSearch
Error Message:
.responseHeader.params.fl!=version (unordered or missing)
Stack Trace:
junit.framework.AssertionFailedError: .responseHeader.params.fl!=version (unordered or missing)
at __randomizedtesting.SeedInfo.seed([ADF623EBC61C67E6:2C10ADF3B14307DA]:0)
at junit.framework.Assert.fail(Assert.java:50)
at org.apache.solr.BaseDistributedSearchTestCase.compareSolrResponses(BaseDistributedSearchTestCase.java:816)
at org.apache.solr.BaseDistributedSearchTestCase.compareResponses(BaseDistributedSearchTestCase.java:835)
at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:538)
at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:515)
at org.apache.solr.handler.component.DistributedQueryElevationComponentTest.doTest(DistributedQueryElevationComponentTest.java:81)
at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:843)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:60)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:37)
at java.lang.reflect.Method.invoke(Method.java:611)
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:738)
REGRESSION: org.apache.solr.handler.component.TermVectorComponentDistributedTest.testDistribSearch
Error Message:
.termVectors.0.test_basictv!=test_offtv (unordered or missing)
Stack Trace:
junit.framework.AssertionFailedError: .termVectors.0.test_basictv!=test_offtv (unordered or missing)
at __randomizedtesting.SeedInfo.seed([ADF623EBC61C67E6:2C10ADF3B14307DA]:0)
at junit.framework.Assert.fail(Assert.java:50)
at org.apache.solr.BaseDistributedSearchTestCase.compareSolrResponses(BaseDistributedSearchTestCase.java:816)
at org.apache.solr.BaseDistributedSearchTestCase.compareResponses(BaseDistributedSearchTestCase.java:835)
at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:538)
at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:515)
at org.apache.solr.handler.component.TermVectorComponentDistributedTest.doTest(TermVectorComponentDistributedTest.java:127)
at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:849)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:60)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:37)
at java.lang.reflect.Method.invoke(Method.java:611)
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:738)
REGRESSION: org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest.testMultiThreaded
Error Message:
expected:<1> but was:<2>
Stack Trace:
java.lang.AssertionError: expected:<1> but was:<2>
at __randomizedtesting.SeedInfo.seed([ADF623EBC61C67E6:CC63F90B2ECD6D10]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest.checkNumDocs(SignatureUpdateProcessorFactoryTest.java:71)
at org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest.testMultiThreaded(SignatureUpdateProcessorFactoryTest.java:222)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:60)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:37)
at java.lang.reflect.Method.invoke(Method.java:611)
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:738)
REGRESSION: org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest.testDupeDetection
Error Message:
expected:<1> but was:<3>
Stack Trace:
java.lang.AssertionError: expected:<1> but was:<3>
at __randomizedtesting.SeedInfo.seed([ADF623EBC61C67E6:F6C6D823C55BC49A]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest.checkNumDocs(SignatureUpdateProcessorFactoryTest.java:71)
at org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest.testDupeDetection(SignatureUpdateProcessorFactoryTest.java:119)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:60)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:37)
at java.lang.reflect.Method.invoke(Method.java:611)
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:738)
Build Log:
[...truncated 9375 lines...]
[junit4] Suite: org.apache.solr.handler.component.DistributedQueryElevationComponentTest
[junit4] 2> 41600 T170 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /g/l
[junit4] 2> 41604 T170 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
[junit4] 2> 41606 T170 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 41610 T170 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:54519
[junit4] 2> 41612 T170 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 41613 T170 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 41614 T170 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr
[junit4] 2> 41615 T170 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4] 2> 41631 T170 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/solr.xml
[junit4] 2> 41685 T170 oasc.CoreContainer.<init> New CoreContainer 2119532117
[junit4] 2> 41686 T170 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/]
[junit4] 2> 41687 T170 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 41688 T170 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 41689 T170 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 41690 T170 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 41690 T170 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 41691 T170 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 41692 T170 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 41692 T170 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 41693 T170 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 41700 T170 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 41701 T170 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 41701 T170 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 41707 T180 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4] 2> 41707 T180 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4] 2> 41709 T180 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 41709 T180 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 41759 T180 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 41798 T180 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-elevate.xml
[junit4] 2> 41799 T180 oass.IndexSchema.readSchema Reading Solr Schema from schema11.xml
[junit4] 2> 41805 T180 oass.IndexSchema.readSchema [collection1] Schema name=example
[junit4] 2> 41973 T180 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 41975 T180 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 41984 T180 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 41984 T180 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=./org.apache.solr.handler.component.DistributedQueryElevationComponentTest-1385771797574/control/data/
[junit4] 2> 41985 T180 oasc.JmxMonitoredMap.<init> No JMX servers found, not exposing Solr information with JMX.
[junit4] 2> 41986 T180 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.handler.component.DistributedQueryElevationComponentTest-1385771797574/control/data
[junit4] 2> 41987 T180 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.handler.component.DistributedQueryElevationComponentTest-1385771797574/control/data/index/
[junit4] 2> 41987 T180 oasc.SolrCore.initIndex WARN [collection1] Solr index directory './org.apache.solr.handler.component.DistributedQueryElevationComponentTest-1385771797574/control/data/index' doesn't exist. Creating new index...
[junit4] 2> 41988 T180 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.handler.component.DistributedQueryElevationComponentTest-1385771797574/control/data/index
[junit4] 2> 41988 T180 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=23, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 41990 T180 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@4d0a4d0a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6d5f6d5f),segFN=segments_1,generation=1}
[junit4] 2> 41990 T180 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 41994 T180 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 41994 T180 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 41995 T180 oasc.RequestHandlers.initHandlersFromConfig created /elevate: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 41995 T180 oasc.RequestHandlers.initHandlersFromConfig created /dataElevate: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 41997 T180 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 41997 T180 oasc.RequestHandlers.initHandlersFromConfig WARN no default request handler is registered (either '/select' or 'standard')
[junit4] 2> 41999 T180 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 42001 T180 oasc.SolrCore.initDeprecatedSupport WARN adding ShowFileRequestHandler with hidden files: [SCHEMA-REST-LUCENE-MATCH-VERSION.XML, BAD-SOLRCONFIG-UNEXPECTED-SCHEMA-ATTRIBUTE.XML, KEEP-1.TXT, SCHEMA-XINCLUDE.XML, SCHEMA-SPATIAL.XML, ENUMSCONFIG.XML, SCHEMA-SNIPPET-TYPES.INCL, BAD-SCHEMA-CURRENCY-DYNAMIC-MULTIVALUED.XML, BAD-SCHEMA-NONTEXT-ANALYZER.XML, SOLRCONFIG-SNIPPET-PROCESSOR.XML, BAD-SCHEMA-ANALYZER-CLASS-AND-NESTED.XML, BAD-SOLRCONFIG-WARMER-NO-REOPEN.XML, SCHEMA-EFF.XML, SCHEMA-IB.XML, BAD-SOLRCONFIG-MULTIPLE-CFS.XML, FUZZYSUGGEST.TXT, SCHEMA11.XML, SCHEMA-REPLICATION1.XML, SCHEMA-COLLATE.XML, CONDITIONAL.UPDATEPROCESSOR.JS, SCHEMA-TINY.XML, SOLRCONFIG-RESPONSE-LOG-COMPONENT.XML, BAD-SCHEMA-MULTIPLE-ASTERISK-COPYFIELD-SOURCE-SHOULD-FAIL-TEST.XML, SCHEMA-COPYFIELD-TEST.XML, BAD-SCHEMA-CURRENCY-MULTIVALUED.XML, SOLRCONFIG-DELPOLICY1.XML, DA_COMPOUNDDICTIONARY.TXT, BAD-SCHEMA-CODEC-GLOBAL-VS-FT-MISMATCH.XML, HYPHENATION.DTD, SOLRCONFIG-CACHING.XML, SOLRCONFIG-EXTERNALVERSIONCONSTRAINT.XML, STOPWITHBOM.TXT, BAD-SCHEMA-NOT-INDEXED-BUT-POS.XML, HUNSPELL-TEST.AFF, SCHEMA-NUMERIC.XML, ANALYZINGINFIXSUGGEST.TXT, TRIVIAL.UPDATEPROCESSOR1.JS, SOLRCONFIG-SLAVE.XML, OPEN-EXCHANGE-RATES.JSON, BAD-SCHEMA-BOGUS-FIELD-PARAMETERS.XML, SCHEMA-BM25.XML, SOLRCONFIG-TIEREDMERGEPOLICY.XML, SCHEMASURROUND.XML, SCHEMA-SYNONYM-TOKENIZER.XML, SOLRCONFIG-DELPOLICY2.XML, SCHEMA-CHARFILTERS.XML, BAD-SCHEMA-SWEETSPOT-PARTIAL-HYPERBOLIC.XML, BAD-SCHEMA-DUP-DYNAMICFIELD.XML, SOLRCONFIG-SPELLCHECKER.XML, SCHEMA-LUCENEMATCHVERSION.XML, BAD-SOLRCONFIG-BOGUS-SCRIPTENGINE-NAME.XML, SCHEMA-REVERSED.XML, WDFTYPES.TXT, SCHEMA-DOCVALUESFACETING.XML, SOLRCONFIG-TLOG.XML, SOLRCONFIG-WARMER.XML, SOLRCONFIG-SPELLCHECKCOMPONENT.XML, SCHEMA-FOLDING.XML, JASUGGEST.TXT, SOLRCONFIG-PHRASESUGGEST.XML, BAD-SOLRCONFIG-INVALID-SCRIPTFILE.XML, SOLRCONFIG-SCRIPT-UPDATEPROCESSOR.XML, SOLRCONFIG-MASTER1.XML, SOLRCONFIG-FUNCTIONQUERY.XML, SOLRCONFIG-REQHANDLER.INCL, BAD_SOLRCONFIG.XML, SCHEMA-COLLATEFILTER.XML, SOLRCONFIG-MINIMAL.XML, SCHEMA-ONE-FIELD-NO-DYNAMIC-FIELD.XML, SOLRCONFIG-LOGMERGEPOLICY.XML, BAD-SOLRCONFIG-MULTIPLE-DIRFACTORY.XML, SOLRCONFIG_CODEC.XML, SCHEMA-MINIMAL.XML, BAD-SOLRCONFIG-MISSING-SCRIPTFILE.XML, SOLRCONFIG.SNIPPET.RANDOMINDEXCONFIG.XML, BAD-SCHEMA-NOT-INDEXED-BUT-NORMS.XML, BAD-SOLRCONFIG-MULTIPLE-INDEXCONFIGS.XML, BAD-SCHEMA-UNIQUEKEY-USES-DEFAULT.XML, MISSLEADING.EXTENSION.UPDATEPROCESSOR.JS.TXT, SOLRCONFIG-NOOPREGEN.XML, REGEX-BOOST-PROCESSOR-TEST.TXT, STOP-SNOWBALL.TXT, SOLRCONFIG-MASTER1-KEEPONEBACKUP.XML, BAD-SCHEMA-CURRENCY-FT-BOGUS-DEFAULT-CODE.XML, STOP-2.TXT, SOLRCONFIG-POSTINGSHIGHLIGHT.XML, BAD-SCHEMA-MISPLACED-ASTERISK-COPYFIELD-SOURCE-SHOULD-FAIL-TEST.XML, BAD-SCHEMA-DYNAMICFIELD-DEFAULT-VAL.XML, SCHEMA-DOCVALUESMISSING.XML, SCHEMA-SNIPPET-FIELD.XML, SOLRCONFIG-QUERYSENDER.XML, SOLRCONFIG-INDEXCONFIG.XML, SCHEMA-REQUIRED-FIELDS.XML, BAD-SCHEMA-DUP-FIELD.XML, SOLRCONFIG-HIGHLIGHT.XML, BAD-SCHEMA-NOT-INDEXED-BUT-TF.XML, MAPPING-ISOLATIN1ACCENT.TXT, PHRASESUGGEST.TXT, SOLRCONFIG-ALTDIRECTORY.XML, SCHEMA15.XML, BAD-SCHEMA-DUP-FIELDTYPE.XML, SOLRCONFIG-BASIC.XML, BAD-SCHEMA-UNIQUEKEY-MULTIVALUED.XML, SCHEMA_CODEC.XML, SCHEMA-POSTINGSHIGHLIGHT.XML, BAD-SCHEMA-NON-GLOB-COPYFIELD-SOURCE-MATCHING-NOTHING-SHOULD-FAIL-TEST.XML, SCHEMA-STOP-KEEP.XML, SCHEMA-TFIDF.XML, SOLRCONFIG-PARSING-UPDATE-PROCESSOR-CHAINS.XML, SOLRCONFIG-MASTER3.XML, BAD-SCHEMA-DYNAMICFIELD-REQUIRED.XML, SCHEMA-BEHAVIOR.XML, SOLRCONFIG-MASTER.XML, SOLRCONFIG-TRANSFORMERS.XML, BAD-SCHEMA-SWEETSPOT-BOTH-TF.XML, SOLRCONFIG-ELEVATE.XML, MISSING.FUNCTIONS.UPDATEPROCESSOR.JS, KEEP-2.TXT, SCHEMA-DFR.XML, XSLT, SCHEMA-LMDIRICHLET.XML, ELEVATE.XML, SOLRCONFIG-BASIC-LUCENEVERSION31.XML, SCHEMA-LMJELINEKMERCER.XML, SOLRCONFIG-NOCACHE.XML, SOLRCONFIG-DEFAULTS.XML, SCHEMA-TRIE.XML, SCHEMA-CLASS-NAME-SHORTENING-ON-SERIALIZATION.XML, SOLRCONFIG-MANAGED-SCHEMA.XML, BAD-SCHEMA-SWEETSPOT-PARTIAL-NORMS.XML, SCHEMA-ONE-FIELD-NO-DYNAMIC-FIELD-UNIQUE-KEY.XML, PROTWORDS.TXT, SOLRCONFIG-LAZYWRITER.XML, SOLRCONFIG-MASTER2.XML, BAD-SCHEMA-CURRENCY-FT-MULTIVALUED.XML, SOLRCONFIG-ADD-SCHEMA-FIELDS-UPDATE-PROCESSOR-CHAINS.XML, SOLRCONFIG-XINCLUDE.XML, BAD-SCHEMA-UNSUPPORTED-DOCVALUES.XML, SOLRCONFIG-INFOSTREAM-LOGGING.XML, STOPWORDSWRONGENCODING.TXT, BAD-MP-SOLRCONFIG.XML, SCHEMA-NOT-REQUIRED-UNIQUE-KEY.XML, STOP-1.TXT, SCHEMA-SIM.XML, SCHEMA-ADD-SCHEMA-FIELDS-UPDATE-PROCESSOR.XML, SOLRCONFIG-MERGEPOLICY-DEFAULTS.XML, SOLRCONFIG-MERGEPOLICY-LEGACY.XML, SCHEMA-PHRASESUGGEST.XML, SOLRCONFIG-COMPONENTS-NAME.XML, SOLRCONFIG-SOLCOREPROPERTIES.XML, SOLRCONFIG_PERF.XML, FRENCHARTICLES.TXT, SCHEMA-COLLATE-DV.XML, SCHEMA-BINARYFIELD.XML, BAD-SCHEMA-EXTERNAL-FILEFIELD.XML, ADDFIELDS.UPDATEPROCESSOR.JS, BAD-SOLRCONFIG-MANAGED-SCHEMA-NAMED-SCHEMA.XML.XML, BAD-SCHEMA-SWEETSPOT-PARTIAL-BASELINE.XML, SCHEMA-CUSTOM-FIELD.XML, SCHEMA-ENUMS.XML, SCHEMA-SPELLCHECKER.XML, BAD-SCHEMA-SIM-GLOBAL-VS-FT-MISMATCH.XML, HUNSPELL-TEST.DIC, BAD-SOLRCONFIG-SCHEMA-MUTABLE-BUT-NOT-MANAGED.XML, SCHEMA-DOCVALUES.XML, SCHEMA-SNIPPET-TYPE.XML, SOLRCONFIG-TERMINDEX.XML, SOLRCONFIG-IMPLICITPROPERTIES.XML, CURRENCY.XML, SOLRCONFIG-REPEATER.XML, BAD-SCHEMA-CURRENCY-FT-OER-NORATES.XML, SOLRCONFIG-SOLR-749.XML, SOLRCONFIG-SUGGESTERCOMPONENT.XML, SCHEMA-REPLICATION2.XML, BAD-CURRENCY.XML, SOLRCONFIG-QUERYSENDER-NOQUERY.XML, OLD_SYNONYMS.TXT, STEMDICT.TXT, STOPTYPES-1.TXT, SCHEMA-REST.XML, SCHEMA-DOCVALUESMULTI.XML, BAD-SCHEMA-BOGUS-ANALYSIS-PARAMETERS.XML, BAD-SCHEMA-UNIQUEKEY-IS-COPYFIELD-DEST.XML, SCHEMA12.XML, SCHEMA-DISTRIBUTED-MISSING-SORT.XML, SCHEMA-SWEETSPOT.XML, SYNONYMS.TXT, TRIVIAL.UPDATEPROCESSOR0.JS, BAD-SCHEMA-CURRENCY-FT-BOGUS-CODE-IN-XML.XML, DA_UTF8.XML, BAD-SCHEMA-MISPLACED-ASTERISK-COPYFIELD-DEST-SHOULD-FAIL-TEST.XML, SOLRCONFIG-UPDATE-PROCESSOR-CHAINS.XML, THROW.ERROR.ON.ADD.UPDATEPROCESSOR.JS, BAD-SCHEMA-MULTIPLE-ASTERISK-COPYFIELD-DEST-SHOULD-FAIL-TEST.XML, COMPOUNDDICTIONARY.TXT, BAD-SCHEMA-OMIT-TF-BUT-NOT-POS.XML, STOPTYPES-2.TXT, SCHEMA-SIMPLEQPPLUGIN.XML, SOLRCONFIG-COLLAPSEQPARSER.XML, SCHEMA-ID-AND-VERSION-FIELDS-ONLY.XML, SOLRCONFIG-SLAVE1.XML, STOPWORDS.TXT, SOLRCONFIG-TEST-MISC.XML]
[junit4] 2> 42003 T180 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 42003 T180 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 42004 T180 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=14, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7680765748513475]
[junit4] 2> 42005 T180 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@4d0a4d0a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6d5f6d5f),segFN=segments_1,generation=1}
[junit4] 2> 42005 T180 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 42006 T180 oass.SolrIndexSearcher.<init> Opening Searcher@6be96be9 main
[junit4] 2> 42013 T180 oashc.QueryElevationComponent.inform Loading QueryElevation from: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/elevate.xml
[junit4] 2> 42025 T180 oashc.QueryElevationComponent.inform Loading QueryElevation from: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/elevate.xml
[junit4] 2> 42035 T181 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6be96be9 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 42035 T180 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 42037 T170 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0
[junit4] 2> 42038 T170 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 42041 T170 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 42044 T170 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:47878
[junit4] 2> 42045 T170 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 42046 T170 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 42046 T170 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr
[junit4] 2> 42047 T170 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4] 2> 42059 T170 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/solr.xml
[junit4] 2> 42104 T170 oasc.CoreContainer.<init> New CoreContainer 834089399
[junit4] 2> 42105 T170 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/]
[junit4] 2> 42106 T170 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 42107 T170 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 42107 T170 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 42108 T170 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 42109 T170 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 42109 T170 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 42110 T170 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 42111 T170 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 42112 T170 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 42118 T170 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 42119 T170 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 42120 T170 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 42125 T192 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4] 2> 42125 T192 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4] 2> 42127 T192 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 42127 T192 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 42177 T192 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 42220 T192 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-elevate.xml
[junit4] 2> 42221 T192 oass.IndexSchema.readSchema Reading Solr Schema from schema11.xml
[junit4] 2> 42227 T192 oass.IndexSchema.readSchema [collection1] Schema name=example
[junit4] 2> 42393 T192 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 42402 T192 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 42412 T192 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 42412 T192 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=./org.apache.solr.handler.component.DistributedQueryElevationComponentTest-1385771797574/shard0/data/
[junit4] 2> 42413 T192 oasc.JmxMonitoredMap.<init> No JMX servers found, not exposing Solr information with JMX.
[junit4] 2> 42414 T192 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.handler.component.DistributedQueryElevationComponentTest-1385771797574/shard0/data
[junit4] 2> 42414 T192 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.handler.component.DistributedQueryElevationComponentTest-1385771797574/shard0/data/index/
[junit4] 2> 42415 T192 oasc.SolrCore.initIndex WARN [collection1] Solr index directory './org.apache.solr.handler.component.DistributedQueryElevationComponentTest-1385771797574/shard0/data/index' doesn't exist. Creating new index...
[junit4] 2> 42416 T192 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.handler.component.DistributedQueryElevationComponentTest-1385771797574/shard0/data/index
[junit4] 2> 42416 T192 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=23, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 42418 T192 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@71ec71ec lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b200b2),segFN=segments_1,generation=1}
[junit4] 2> 42418 T192 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 42419 T192 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 42420 T192 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 42420 T192 oasc.RequestHandlers.initHandlersFromConfig created /elevate: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 42421 T192 oasc.RequestHandlers.initHandlersFromConfig created /dataElevate: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 42423 T192 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 42423 T192 oasc.RequestHandlers.initHandlersFromConfig WARN no default request handler is registered (either '/select' or 'standard')
[junit4] 2> 42425 T192 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 42427 T192 oasc.SolrCore.initDeprecatedSupport WARN adding ShowFileRequestHandler with hidden files: [BAD-SCHEMA-UNIQUEKEY-IS-COPYFIELD-DEST.XML, SCHEMA12.XML, SCHEMA-DISTRIBUTED-MISSING-SORT.XML, SCHEMA-SWEETSPOT.XML, SYNONYMS.TXT, TRIVIAL.UPDATEPROCESSOR0.JS, BAD-CURRENCY.XML, SOLRCONFIG-QUERYSENDER-NOQUERY.XML, OLD_SYNONYMS.TXT, STEMDICT.TXT, STOPTYPES-1.TXT, SCHEMA-REST.XML, SCHEMA-DOCVALUESMULTI.XML, BAD-SCHEMA-BOGUS-ANALYSIS-PARAMETERS.XML, SCHEMA-SIMPLEQPPLUGIN.XML, SOLRCONFIG-COLLAPSEQPARSER.XML, SCHEMA-ID-AND-VERSION-FIELDS-ONLY.XML, SOLRCONFIG-SLAVE1.XML, STOPWORDS.TXT, SOLRCONFIG-TEST-MISC.XML, BAD-SCHEMA-CURRENCY-FT-BOGUS-CODE-IN-XML.XML, DA_UTF8.XML, BAD-SCHEMA-MISPLACED-ASTERISK-COPYFIELD-DEST-SHOULD-FAIL-TEST.XML, SOLRCONFIG-UPDATE-PROCESSOR-CHAINS.XML, THROW.ERROR.ON.ADD.UPDATEPROCESSOR.JS, BAD-SCHEMA-MULTIPLE-ASTERISK-COPYFIELD-DEST-SHOULD-FAIL-TEST.XML, COMPOUNDDICTIONARY.TXT, BAD-SCHEMA-OMIT-TF-BUT-NOT-POS.XML, STOPTYPES-2.TXT, FRENCHARTICLES.TXT, SCHEMA-COLLATE-DV.XML, SCHEMA-BINARYFIELD.XML, BAD-SCHEMA-EXTERNAL-FILEFIELD.XML, ADDFIELDS.UPDATEPROCESSOR.JS, BAD-SOLRCONFIG-MANAGED-SCHEMA-NAMED-SCHEMA.XML.XML, SCHEMA-ADD-SCHEMA-FIELDS-UPDATE-PROCESSOR.XML, SOLRCONFIG-MERGEPOLICY-DEFAULTS.XML, SOLRCONFIG-MERGEPOLICY-LEGACY.XML, SCHEMA-PHRASESUGGEST.XML, SOLRCONFIG-COMPONENTS-NAME.XML, SOLRCONFIG-SOLCOREPROPERTIES.XML, SOLRCONFIG_PERF.XML, SCHEMA-SNIPPET-TYPE.XML, SOLRCONFIG-TERMINDEX.XML, SOLRCONFIG-IMPLICITPROPERTIES.XML, CURRENCY.XML, SOLRCONFIG-REPEATER.XML, BAD-SCHEMA-CURRENCY-FT-OER-NORATES.XML, SOLRCONFIG-SOLR-749.XML, SOLRCONFIG-SUGGESTERCOMPONENT.XML, SCHEMA-REPLICATION2.XML, BAD-SCHEMA-SWEETSPOT-PARTIAL-BASELINE.XML, SCHEMA-CUSTOM-FIELD.XML, SCHEMA-ENUMS.XML, SCHEMA-SPELLCHECKER.XML, BAD-SCHEMA-SIM-GLOBAL-VS-FT-MISMATCH.XML, HUNSPELL-TEST.DIC, BAD-SOLRCONFIG-SCHEMA-MUTABLE-BUT-NOT-MANAGED.XML, SCHEMA-DOCVALUES.XML, ELEVATE.XML, SOLRCONFIG-BASIC-LUCENEVERSION31.XML, SCHEMA-LMJELINEKMERCER.XML, SOLRCONFIG-PARSING-UPDATE-PROCESSOR-CHAINS.XML, SOLRCONFIG-MASTER3.XML, BAD-SCHEMA-DYNAMICFIELD-REQUIRED.XML, SCHEMA-BEHAVIOR.XML, SOLRCONFIG-MASTER.XML, SOLRCONFIG-TRANSFORMERS.XML, BAD-SCHEMA-SWEETSPOT-BOTH-TF.XML, SOLRCONFIG-ELEVATE.XML, MISSING.FUNCTIONS.UPDATEPROCESSOR.JS, KEEP-2.TXT, SCHEMA-DFR.XML, XSLT, SCHEMA-LMDIRICHLET.XML, BAD-SCHEMA-CURRENCY-FT-MULTIVALUED.XML, SOLRCONFIG-ADD-SCHEMA-FIELDS-UPDATE-PROCESSOR-CHAINS.XML, SOLRCONFIG-XINCLUDE.XML, BAD-SCHEMA-UNSUPPORTED-DOCVALUES.XML, SOLRCONFIG-INFOSTREAM-LOGGING.XML, STOPWORDSWRONGENCODING.TXT, BAD-MP-SOLRCONFIG.XML, SCHEMA-NOT-REQUIRED-UNIQUE-KEY.XML, STOP-1.TXT, SCHEMA-SIM.XML, SOLRCONFIG-NOCACHE.XML, SOLRCONFIG-DEFAULTS.XML, SCHEMA-TRIE.XML, SCHEMA-CLASS-NAME-SHORTENING-ON-SERIALIZATION.XML, SOLRCONFIG-MANAGED-SCHEMA.XML, BAD-SCHEMA-SWEETSPOT-PARTIAL-NORMS.XML, SCHEMA-ONE-FIELD-NO-DYNAMIC-FIELD-UNIQUE-KEY.XML, PROTWORDS.TXT, SOLRCONFIG-LAZYWRITER.XML, SOLRCONFIG-MASTER2.XML, MAPPING-ISOLATIN1ACCENT.TXT, PHRASESUGGEST.TXT, SOLRCONFIG-ALTDIRECTORY.XML, SCHEMA15.XML, SCHEMA-SNIPPET-FIELD.XML, SOLRCONFIG-QUERYSENDER.XML, SOLRCONFIG-INDEXCONFIG.XML, SCHEMA-REQUIRED-FIELDS.XML, BAD-SCHEMA-DUP-FIELD.XML, SOLRCONFIG-HIGHLIGHT.XML, BAD-SCHEMA-NOT-INDEXED-BUT-TF.XML, SCHEMA-POSTINGSHIGHLIGHT.XML, BAD-SCHEMA-NON-GLOB-COPYFIELD-SOURCE-MATCHING-NOTHING-SHOULD-FAIL-TEST.XML, SCHEMA-STOP-KEEP.XML, SCHEMA-TFIDF.XML, BAD-SCHEMA-DUP-FIELDTYPE.XML, SOLRCONFIG-BASIC.XML, BAD-SCHEMA-UNIQUEKEY-MULTIVALUED.XML, SCHEMA_CODEC.XML, SCHEMA-MINIMAL.XML, BAD-SOLRCONFIG-MISSING-SCRIPTFILE.XML, SCHEMA-ONE-FIELD-NO-DYNAMIC-FIELD.XML, SOLRCONFIG-LOGMERGEPOLICY.XML, BAD-SOLRCONFIG-MULTIPLE-DIRFACTORY.XML, SOLRCONFIG_CODEC.XML, MISSLEADING.EXTENSION.UPDATEPROCESSOR.JS.TXT, SOLRCONFIG-NOOPREGEN.XML, REGEX-BOOST-PROCESSOR-TEST.TXT, STOP-SNOWBALL.TXT, SOLRCONFIG-MASTER1-KEEPONEBACKUP.XML, BAD-SCHEMA-CURRENCY-FT-BOGUS-DEFAULT-CODE.XML, STOP-2.TXT, SOLRCONFIG-POSTINGSHIGHLIGHT.XML, BAD-SCHEMA-MISPLACED-ASTERISK-COPYFIELD-SOURCE-SHOULD-FAIL-TEST.XML, BAD-SCHEMA-DYNAMICFIELD-DEFAULT-VAL.XML, SCHEMA-DOCVALUESMISSING.XML, SOLRCONFIG.SNIPPET.RANDOMINDEXCONFIG.XML, BAD-SCHEMA-NOT-INDEXED-BUT-NORMS.XML, BAD-SOLRCONFIG-MULTIPLE-INDEXCONFIGS.XML, BAD-SCHEMA-UNIQUEKEY-USES-DEFAULT.XML, SOLRCONFIG-WARMER.XML, SOLRCONFIG-SPELLCHECKCOMPONENT.XML, SCHEMA-FOLDING.XML, SCHEMA-REVERSED.XML, WDFTYPES.TXT, SCHEMA-DOCVALUESFACETING.XML, SOLRCONFIG-TLOG.XML, BAD_SOLRCONFIG.XML, SCHEMA-COLLATEFILTER.XML, SOLRCONFIG-MINIMAL.XML, JASUGGEST.TXT, SOLRCONFIG-PHRASESUGGEST.XML, BAD-SOLRCONFIG-INVALID-SCRIPTFILE.XML, SOLRCONFIG-SCRIPT-UPDATEPROCESSOR.XML, SOLRCONFIG-MASTER1.XML, SOLRCONFIG-FUNCTIONQUERY.XML, SOLRCONFIG-REQHANDLER.INCL, STOPWITHBOM.TXT, BAD-SCHEMA-NOT-INDEXED-BUT-POS.XML, HUNSPELL-TEST.AFF, SCHEMA-NUMERIC.XML, ANALYZINGINFIXSUGGEST.TXT, TRIVIAL.UPDATEPROCESSOR1.JS, SOLRCONFIG-RESPONSE-LOG-COMPONENT.XML, BAD-SCHEMA-MULTIPLE-ASTERISK-COPYFIELD-SOURCE-SHOULD-FAIL-TEST.XML, SCHEMA-COPYFIELD-TEST.XML, BAD-SCHEMA-CURRENCY-MULTIVALUED.XML, SOLRCONFIG-DELPOLICY1.XML, DA_COMPOUNDDICTIONARY.TXT, BAD-SCHEMA-CODEC-GLOBAL-VS-FT-MISMATCH.XML, HYPHENATION.DTD, SOLRCONFIG-CACHING.XML, SOLRCONFIG-EXTERNALVERSIONCONSTRAINT.XML, SCHEMA-SYNONYM-TOKENIZER.XML, SOLRCONFIG-DELPOLICY2.XML, SCHEMA-CHARFILTERS.XML, BAD-SCHEMA-SWEETSPOT-PARTIAL-HYPERBOLIC.XML, BAD-SCHEMA-DUP-DYNAMICFIELD.XML, SOLRCONFIG-SPELLCHECKER.XML, SCHEMA-LUCENEMATCHVERSION.XML, BAD-SOLRCONFIG-BOGUS-SCRIPTENGINE-NAME.XML, SOLRCONFIG-SLAVE.XML, OPEN-EXCHANGE-RATES.JSON, BAD-SCHEMA-BOGUS-FIELD-PARAMETERS.XML, SCHEMA-BM25.XML, SOLRCONFIG-TIEREDMERGEPOLICY.XML, SCHEMASURROUND.XML, BAD-SCHEMA-CURRENCY-DYNAMIC-MULTIVALUED.XML, BAD-SCHEMA-NONTEXT-ANALYZER.XML, SOLRCONFIG-SNIPPET-PROCESSOR.XML, BAD-SCHEMA-ANALYZER-CLASS-AND-NESTED.XML, SCHEMA-REST-LUCENE-MATCH-VERSION.XML, BAD-SOLRCONFIG-UNEXPECTED-SCHEMA-ATTRIBUTE.XML, KEEP-1.TXT, SCHEMA-XINCLUDE.XML, SCHEMA-SPATIAL.XML, ENUMSCONFIG.XML, SCHEMA-SNIPPET-TYPES.INCL, FUZZYSUGGEST.TXT, SCHEMA11.XML, SCHEMA-REPLICATION1.XML, SCHEMA-COLLATE.XML, CONDITIONAL.UPDATEPROCESSOR.JS, SCHEMA-TINY.XML, BAD-SOLRCONFIG-WARMER-NO-REOPEN.XML, SCHEMA-EFF.XML, SCHEMA-IB.XML, BAD-SOLRCONFIG-MULTIPLE-CFS.XML]
[junit4] 2> 42429 T192 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 42429 T192 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 42430 T192 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=14, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7680765748513475]
[junit4] 2> 42431 T192 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@71ec71ec lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b200b2),segFN=segments_1,generation=1}
[junit4] 2> 42432 T192 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 42432 T192 oass.SolrIndexSearcher.<init> Opening Searcher@59f659f6 main
[junit4] 2> 42433 T192 oashc.QueryElevationComponent.inform Loading QueryElevation from: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/elevate.xml
[junit4] 2> 42445 T192 oashc.QueryElevationComponent.inform Loading QueryElevation from: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/elevate.xml
[junit4] 2> 42456 T192 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 42456 T193 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@59f659f6 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 42457 T170 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0
[junit4] 2> 42458 T170 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 42461 T170 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 42463 T170 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:41701
[junit4] 2> 42465 T170 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 42475 T170 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 42476 T170 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr
[junit4] 2> 42476 T170 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4] 2> 42488 T170 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/solr.xml
[junit4] 2> 42532 T170 oasc.CoreContainer.<init> New CoreContainer 1854566026
[junit4] 2> 42533 T170 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/]
[junit4] 2> 42534 T170 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 42535 T170 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 42536 T170 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 42537 T170 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 42537 T170 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 42538 T170 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 42539 T170 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 42540 T170 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 42540 T170 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 42547 T170 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 42548 T170 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 42548 T170 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 42554 T204 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4] 2> 42555 T204 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4] 2> 42556 T204 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 42557 T204 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 42606 T204 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 42645 T204 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-elevate.xml
[junit4] 2> 42653 T204 oass.IndexSchema.readSchema Reading Solr Schema from schema11.xml
[junit4] 2> 42659 T204 oass.IndexSchema.readSchema [collection1] Schema name=example
[junit4] 2> 42829 T204 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 42831 T204 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 42840 T204 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 42841 T204 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=./org.apache.solr.handler.component.DistributedQueryElevationComponentTest-1385771797574/shard1/data/
[junit4] 2> 42842 T204 oasc.JmxMonitoredMap.<init> No JMX servers found, not exposing Solr information with JMX.
[junit4] 2> 42843 T204 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.handler.component.DistributedQueryElevationComponentTest-1385771797574/shard1/data
[junit4] 2> 42843 T204 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.handler.component.DistributedQueryElevationComponentTest-1385771797574/shard1/data/index/
[junit4] 2> 42844 T204 oasc.SolrCore.initIndex WARN [collection1] Solr index directory './org.apache.solr.handler.component.DistributedQueryElevationComponentTest-1385771797574/shard1/data/index' doesn't exist. Creating new index...
[junit4] 2> 42844 T204 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.handler.component.DistributedQueryElevationComponentTest-1385771797574/shard1/data/index
[junit4] 2> 42845 T204 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=23, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 42846 T204 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@4a4a4a4a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6bff6bff),segFN=segments_1,generation=1}
[junit4] 2> 42847 T204 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 42848 T204 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 42849 T204 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 42850 T204 oasc.RequestHandlers.initHandlersFromConfig created /elevate: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 42850 T204 oasc.RequestHandlers.initHandlersFromConfig created /dataElevate: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 42852 T204 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 42853 T204 oasc.RequestHandlers.initHandlersFromConfig WARN no default request handler is registered (either '/select' or 'standard')
[junit4] 2> 42854 T204 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 42856 T204 oasc.SolrCore.initDeprecatedSupport WARN adding ShowFileRequestHandler with hidden files: [BAD-SCHEMA-CURRENCY-FT-MULTIVALUED.XML, SOLRCONFIG-ADD-SCHEMA-FIELDS-UPDATE-PROCESSOR-CHAINS.XML, SOLRCONFIG-XINCLUDE.XML, BAD-SCHEMA-UNSUPPORTED-DOCVALUES.XML, STOPWORDSWRONGENCODING.TXT, SOLRCONFIG-INFOSTREAM-LOGGING.XML, BAD-MP-SOLRCONFIG.XML, SCHEMA-NOT-REQUIRED-UNIQUE-KEY.XML, SCHEMA-SIM.XML, STOP-1.TXT, SOLRCONFIG-NOCACHE.XML, SCHEMA-TRIE.XML, SCHEMA-CLASS-NAME-SHORTENING-ON-SERIALIZATION.XML, SOLRCONFIG-DEFAULTS.XML, SOLRCONFIG-MANAGED-SCHEMA.XML, BAD-SCHEMA-SWEETSPOT-PARTIAL-NORMS.XML, SCHEMA-ONE-FIELD-NO-DYNAMIC-FIELD-UNIQUE-KEY.XML, SOLRCONFIG-LAZYWRITER.XML, PROTWORDS.TXT, SOLRCONFIG-MASTER2.XML, ELEVATE.XML, SOLRCONFIG-BASIC-LUCENEVERSION31.XML, SCHEMA-LMJELINEKMERCER.XML, BAD-SCHEMA-DYNAMICFIELD-REQUIRED.XML, SOLRCONFIG-PARSING-UPDATE-PROCESSOR-CHAINS.XML, SOLRCONFIG-MASTER3.XML, SCHEMA-BEHAVIOR.XML, SOLRCONFIG-MASTER.XML, SOLRCONFIG-TRANSFORMERS.XML, BAD-SCHEMA-SWEETSPOT-BOTH-TF.XML, SOLRCONFIG-ELEVATE.XML, MISSING.FUNCTIONS.UPDATEPROCESSOR.JS, KEEP-2.TXT, SCHEMA-DFR.XML, SCHEMA-LMDIRICHLET.XML, XSLT, BAD-SCHEMA-NON-GLOB-COPYFIELD-SOURCE-MATCHING-NOTHING-SHOULD-FAIL-TEST.XML, SCHEMA-STOP-KEEP.XML, SCHEMA-POSTINGSHIGHLIGHT.XML, SCHEMA-TFIDF.XML, BAD-SCHEMA-DUP-FIELDTYPE.XML, SOLRCONFIG-BASIC.XML, BAD-SCHEMA-UNIQUEKEY-MULTIVALUED.XML, SCHEMA_CODEC.XML, MAPPING-ISOLATIN1ACCENT.TXT, PHRASESUGGEST.TXT, SOLRCONFIG-ALTDIRECTORY.XML, SCHEMA15.XML, SOLRCONFIG-QUERYSENDER.XML, SCHEMA-SNIPPET-FIELD.XML, SOLRCONFIG-INDEXCONFIG.XML, SCHEMA-REQUIRED-FIELDS.XML, BAD-SCHEMA-DUP-FIELD.XML, SOLRCONFIG-HIGHLIGHT.XML, BAD-SCHEMA-NOT-INDEXED-BUT-TF.XML, SOLRCONFIG-COLLAPSEQPARSER.XML, SCHEMA-SIMPLEQPPLUGIN.XML, SCHEMA-ID-AND-VERSION-FIELDS-ONLY.XML, STOPWORDS.TXT, SOLRCONFIG-SLAVE1.XML, SOLRCONFIG-TEST-MISC.XML, DA_UTF8.XML, BAD-SCHEMA-CURRENCY-FT-BOGUS-CODE-IN-XML.XML, BAD-SCHEMA-MISPLACED-ASTERISK-COPYFIELD-DEST-SHOULD-FAIL-TEST.XML, THROW.ERROR.ON.ADD.UPDATEPROCESSOR.JS, BAD-SCHEMA-MULTIPLE-ASTERISK-COPYFIELD-DEST-SHOULD-FAIL-TEST.XML, SOLRCONFIG-UPDATE-PROCESSOR-CHAINS.XML, COMPOUNDDICTIONARY.TXT, BAD-SCHEMA-OMIT-TF-BUT-NOT-POS.XML, STOPTYPES-2.TXT, BAD-SCHEMA-UNIQUEKEY-IS-COPYFIELD-DEST.XML, SCHEMA12.XML, SCHEMA-SWEETSPOT.XML, SCHEMA-DISTRIBUTED-MISSING-SORT.XML, SYNONYMS.TXT, TRIVIAL.UPDATEPROCESSOR0.JS, BAD-CURRENCY.XML, SOLRCONFIG-QUERYSENDER-NOQUERY.XML, OLD_SYNONYMS.TXT, STEMDICT.TXT, STOPTYPES-1.TXT, SCHEMA-REST.XML, BAD-SCHEMA-BOGUS-ANALYSIS-PARAMETERS.XML, SCHEMA-DOCVALUESMULTI.XML, SCHEMA-SNIPPET-TYPE.XML, SOLRCONFIG-TERMINDEX.XML, SOLRCONFIG-IMPLICITPROPERTIES.XML, CURRENCY.XML, SOLRCONFIG-REPEATER.XML, BAD-SCHEMA-CURRENCY-FT-OER-NORATES.XML, SOLRCONFIG-SUGGESTERCOMPONENT.XML, SCHEMA-REPLICATION2.XML, SOLRCONFIG-SOLR-749.XML, BAD-SCHEMA-SWEETSPOT-PARTIAL-BASELINE.XML, SCHEMA-CUSTOM-FIELD.XML, SCHEMA-ENUMS.XML, BAD-SCHEMA-SIM-GLOBAL-VS-FT-MISMATCH.XML, HUNSPELL-TEST.DIC, SCHEMA-SPELLCHECKER.XML, BAD-SOLRCONFIG-SCHEMA-MUTABLE-BUT-NOT-MANAGED.XML, SCHEMA-DOCVALUES.XML, FRENCHARTICLES.TXT, SCHEMA-COLLATE-DV.XML, SCHEMA-BINARYFIELD.XML, BAD-SCHEMA-EXTERNAL-FILEFIELD.XML, ADDFIELDS.UPDATEPROCESSOR.JS, BAD-SOLRCONFIG-MANAGED-SCHEMA-NAMED-SCHEMA.XML.XML, SOLRCONFIG-MERGEPOLICY-DEFAULTS.XML, SOLRCONFIG-MERGEPOLICY-LEGACY.XML, SCHEMA-ADD-SCHEMA-FIELDS-UPDATE-PROCESSOR.XML, SCHEMA-PHRASESUGGEST.XML, SOLRCONFIG-COMPONENTS-NAME.XML, SOLRCONFIG-SOLCOREPROPERTIES.XML, SOLRCONFIG_PERF.XML, BAD-SCHEMA-SWEETSPOT-PARTIAL-HYPERBOLIC.XML, SCHEMA-SYNONYM-TOKENIZER.XML, SOLRCONFIG-DELPOLICY2.XML, SCHEMA-CHARFILTERS.XML, BAD-SCHEMA-DUP-DYNAMICFIELD.XML, SOLRCONFIG-SPELLCHECKER.XML, SCHEMA-LUCENEMATCHVERSION.XML, BAD-SOLRCONFIG-BOGUS-SCRIPTENGINE-NAME.XML, SOLRCONFIG-SLAVE.XML, OPEN-EXCHANGE-RATES.JSON, BAD-SCHEMA-BOGUS-FIELD-PARAMETERS.XML, SCHEMA-BM25.XML, SOLRCONFIG-TIEREDMERGEPOLICY.XML, SCHEMASURROUND.XML, STOPWITHBOM.TXT, BAD-SCHEMA-NOT-INDEXED-BUT-POS.XML, HUNSPELL-TEST.AFF, SCHEMA-NUMERIC.XML, ANALYZINGINFIXSUGGEST.TXT, TRIVIAL.UPDATEPROCESSOR1.JS, SOLRCONFIG-RESPONSE-LOG-COMPONENT.XML, SCHEMA-COPYFIELD-TEST.XML, BAD-SCHEMA-MULTIPLE-ASTERISK-COPYFIELD-SOURCE-SHOULD-FAIL-TEST.XML, SOLRCONFIG-DELPOLICY1.XML, BAD-SCHEMA-CURRENCY-MULTIVALUED.XML, HYPHENATION.DTD, DA_COMPOUNDDICTIONARY.TXT, BAD-SCHEMA-CODEC-GLOBAL-VS-FT-MISMATCH.XML, SOLRCONFIG-EXTERNALVERSIONCONSTRAINT.XML, SOLRCONFIG-CACHING.XML, FUZZYSUGGEST.TXT, SCHEMA11.XML, SCHEMA-REPLICATION1.XML, SCHEMA-COLLATE.XML, CONDITIONAL.UPDATEPROCESSOR.JS, SCHEMA-TINY.XML, BAD-SOLRCONFIG-WARMER-NO-REOPEN.XML, SCHEMA-EFF.XML, SCHEMA-IB.XML, BAD-SOLRCONFIG-MULTIPLE-CFS.XML, BAD-SCHEMA-NONTEXT-ANALYZER.XML, BAD-SCHEMA-CURRENCY-DYNAMIC-MULTIVALUED.XML, SOLRCONFIG-SNIPPET-PROCESSOR.XML, BAD-SCHEMA-ANALYZER-CLASS-AND-NESTED.XML, SCHEMA-REST-LUCENE-MATCH-VERSION.XML, BAD-SOLRCONFIG-UNEXPECTED-SCHEMA-ATTRIBUTE.XML, KEEP-1.TXT, SCHEMA-SPATIAL.XML, SCHEMA-XINCLUDE.XML, ENUMSCONFIG.XML, SCHEMA-SNIPPET-TYPES.INCL, MISSLEADING.EXTENSION.UPDATEPROCESSOR.JS.TXT, SOLRCONFIG-NOOPREGEN.XML, STOP-SNOWBALL.TXT, REGEX-BOOST-PROCESSOR-TEST.TXT, SOLRCONFIG-MASTER1-KEEPONEBACKUP.XML, STOP-2.TXT, SOLRCONFIG-POSTINGSHIGHLIGHT.XML, BAD-SCHEMA-CURRENCY-FT-BOGUS-DEFAULT-CODE.XML, BAD-SCHEMA-MISPLACED-ASTERISK-COPYFIELD-SOURCE-SHOULD-FAIL-TEST.XML, BAD-SCHEMA-DYNAMICFIELD-DEFAULT-VAL.XML, SCHEMA-DOCVALUESMISSING.XML, SOLRCONFIG.SNIPPET.RANDOMINDEXCONFIG.XML, BAD-SCHEMA-NOT-INDEXED-BUT-NORMS.XML, BAD-SOLRCONFIG-MULTIPLE-INDEXCONFIGS.XML, BAD-SCHEMA-UNIQUEKEY-USES-DEFAULT.XML, SCHEMA-MINIMAL.XML, BAD-SOLRCONFIG-MISSING-SCRIPTFILE.XML, SCHEMA-ONE-FIELD-NO-DYNAMIC-FIELD.XML, SOLRCONFIG-LOGMERGEPOLICY.XML, BAD-SOLRCONFIG-MULTIPLE-DIRFACTORY.XML, SOLRCONFIG_CODEC.XML, BAD_SOLRCONFIG.XML, SCHEMA-COLLATEFILTER.XML, SOLRCONFIG-MINIMAL.XML, SOLRCONFIG-PHRASESUGGEST.XML, JASUGGEST.TXT, BAD-SOLRCONFIG-INVALID-SCRIPTFILE.XML, SOLRCONFIG-SCRIPT-UPDATEPROCESSOR.XML, SOLRCONFIG-MASTER1.XML, SOLRCONFIG-FUNCTIONQUERY.XML, SOLRCONFIG-REQHANDLER.INCL, SCHEMA-FOLDING.XML, SOLRCONFIG-WARMER.XML, SOLRCONFIG-SPELLCHECKCOMPONENT.XML, SCHEMA-REVERSED.XML, SOLRCONFIG-TLOG.XML, WDFTYPES.TXT, SCHEMA-DOCVALUESFACETING.XML]
[junit4] 2> 42859 T204 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 42860 T204 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 42860 T204 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=14, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7680765748513475]
[junit4] 2> 42861 T204 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@4a4a4a4a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6bff6bff),segFN=segments_1,generation=1}
[junit4] 2> 42862 T204 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 42863 T204 oass.SolrIndexSearcher.<init> Opening Searcher@63036303 main
[junit4] 2> 42864 T204 oashc.QueryElevationComponent.inform Loading QueryElevation from: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/elevate.xml
[junit4] 2> 42874 T204 oashc.QueryElevationComponent.inform Loading QueryElevation from: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/elevate.xml
[junit4] 2> 42889 T204 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 42889 T205 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@63036303 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 42891 T170 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0
[junit4] 2> 42892 T170 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 42897 T170 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 42901 T170 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:34924
[junit4] 2> 42903 T170 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 42903 T170 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 42904 T170 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr
[junit4] 2> 42911 T170 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4] 2> 42924 T170 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/solr.xml
[junit4] 2> 42964 T170 oasc.CoreContainer.<init> New CoreContainer 1216497794
[junit4] 2> 42965 T170 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/]
[junit4] 2> 42966 T170 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 42967 T170 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 42968 T170 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 42968 T170 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 42969 T170 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 42970 T170 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 42970 T170 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 42971 T170 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 42972 T170 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 42978 T170 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 42979 T170 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 42980 T170 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 42992 T216 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4] 2> 42992 T216 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4] 2> 42994 T216 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 42994 T216 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 43036 T216 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 43081 T216 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-elevate.xml
[junit4] 2> 43082 T216 oass.IndexSchema.readSchema Reading Solr Schema from schema11.xml
[junit4] 2> 43087 T216 oass.IndexSchema.readSchema [collection1] Schema name=example
[junit4] 2> 43247 T216 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 43249 T216 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 43258 T216 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 43259 T216 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=./org.apache.solr.handler.component.DistributedQueryElevationComponentTest-1385771797574/shard2/data/
[junit4] 2> 43259 T216 oasc.JmxMonitoredMap.<init> No JMX servers found, not exposing Solr information with JMX.
[junit4] 2> 43260 T216 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.handler.component.DistributedQueryElevationComponentTest-1385771797574/shard2/data
[junit4] 2> 43261 T216 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.handler.component.DistributedQueryElevationComponentTest-1385771797574/shard2/data/index/
[junit4] 2> 43261 T216 oasc.SolrCore.initIndex WARN [collection1] Solr index directory './org.apache.solr.handler.component.DistributedQueryElevationComponentTest-1385771797574/shard2/data/index' doesn't exist. Creating new index...
[junit4] 2> 43262 T216 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.handler.component.DistributedQueryElevationComponentTest-1385771797574/shard2/data/index
[junit4] 2> 43262 T216 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=23, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 43264 T216 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@38ac38ac lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@23302330),segFN=segments_1,generation=1}
[junit4] 2> 43264 T216 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 43265 T216 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 43266 T216 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 43267 T216 oasc.RequestHandlers.initHandlersFromConfig created /elevate: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 43267 T216 oasc.RequestHandlers.initHandlersFromConfig created /dataElevate: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 43269 T216 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 43269 T216 oasc.RequestHandlers.initHandlersFromConfig WARN no default request handler is registered (either '/select' or 'standard')
[junit4] 2> 43277 T216 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 43279 T216 oasc.SolrCore.initDeprecatedSupport WARN adding ShowFileRequestHandler with hidden files: [FUZZYSUGGEST.TXT, SCHEMA11.XML, SCHEMA-REPLICATION1.XML, SCHEMA-COLLATE.XML, CONDITIONAL.UPDATEPROCESSOR.JS, SCHEMA-TINY.XML, BAD-SOLRCONFIG-WARMER-NO-REOPEN.XML, SCHEMA-EFF.XML, SCHEMA-IB.XML, BAD-SOLRCONFIG-MULTIPLE-CFS.XML, BAD-SCHEMA-NONTEXT-ANALYZER.XML, BAD-SCHEMA-CURRENCY-DYNAMIC-MULTIVALUED.XML, SOLRCONFIG-SNIPPET-PROCESSOR.XML, BAD-SCHEMA-ANALYZER-CLASS-AND-NESTED.XML, SCHEMA-REST-LUCENE-MATCH-VERSION.XML, BAD-SOLRCONFIG-UNEXPECTED-SCHEMA-ATTRIBUTE.XML, KEEP-1.TXT, SCHEMA-SPATIAL.XML, SCHEMA-XINCLUDE.XML, ENUMSCONFIG.XML, SCHEMA-SNIPPET-TYPES.INCL, BAD-SCHEMA-SWEETSPOT-PARTIAL-HYPERBOLIC.XML, SCHEMA-SYNONYM-TOKENIZER.XML, SOLRCONFIG-DELPOLICY2.XML, SCHEMA-CHARFILTERS.XML, BAD-SCHEMA-DUP-DYNAMICFIELD.XML, SOLRCONFIG-SPELLCHECKER.XML, SCHEMA-LUCENEMATCHVERSION.XML, BAD-SOLRCONFIG-BOGUS-SCRIPTENGINE-NAME.XML, SOLRCONFIG-SLAVE.XML, OPEN-EXCHANGE-RATES.JSON, BAD-SCHEMA-BOGUS-FIELD-PARAMETERS.XML, SCHEMA-BM25.XML, SOLRCONFIG-TIEREDMERGEPOLICY.XML, SCHEMASURROUND.XML, STOPWITHBOM.TXT, BAD-SCHEMA-NOT-INDEXED-BUT-POS.XML, HUNSPELL-TEST.AFF, SCHEMA-NUMERIC.XML, ANALYZINGINFIXSUGGEST.TXT, TRIVIAL.UPDATEPROCESSOR1.JS, SOLRCONFIG-RESPONSE-LOG-COMPONENT.XML, SCHEMA-COPYFIELD-TEST.XML, BAD-SCHEMA-MULTIPLE-ASTERISK-COPYFIELD-SOURCE-SHOULD-FAIL-TEST.XML, SOLRCONFIG-DELPOLICY1.XML, BAD-SCHEMA-CURRENCY-MULTIVALUED.XML, HYPHENATION.DTD, DA_COMPOUNDDICTIONARY.TXT, BAD-SCHEMA-CODEC-GLOBAL-VS-FT-MISMATCH.XML, SOLRCONFIG-EXTERNALVERSIONCONSTRAINT.XML, SOLRCONFIG-CACHING.XML, BAD_SOLRCONFIG.XML, SCHEMA-COLLATEFILTER.XML, SOLRCONFIG-MINIMAL.XML, SOLRCONFIG-PHRASESUGGEST.XML, JASUGGEST.TXT, BAD-SOLRCONFIG-INVALID-SCRIPTFILE.XML, SOLRCONFIG-SCRIPT-UPDATEPROCESSOR.XML, SOLRCONFIG-MASTER1.XML, SOLRCONFIG-FUNCTIONQUERY.XML, SOLRCONFIG-REQHANDLER.INCL, SCHEMA-FOLDING.XML, SOLRCONFIG-WARMER.XML, SOLRCONFIG-SPELLCHECKCOMPONENT.XML, SCHEMA-REVERSED.XML, SOLRCONFIG-TLOG.XML, WDFTYPES.TXT, SCHEMA-DOCVALUESFACETING.XML, MISSLEADING.EXTENSION.UPDATEPROCESSOR.JS.TXT, SOLRCONFIG-NOOPREGEN.XML, STOP-SNOWBALL.TXT, REGEX-BOOST-PROCESSOR-TEST.TXT, SOLRCONFIG-MASTER1-KEEPONEBACKUP.XML, STOP-2.TXT, SOLRCONFIG-POSTINGSHIGHLIGHT.XML, BAD-SCHEMA-CURRENCY-FT-BOGUS-DEFAULT-CODE.XML, BAD-SCHEMA-MISPLACED-ASTERISK-COPYFIELD-SOURCE-SHOULD-FAIL-TEST.XML, BAD-SCHEMA-DYNAMICFIELD-DEFAULT-VAL.XML, SCHEMA-DOCVALUESMISSING.XML, SOLRCONFIG.SNIPPET.RANDOMINDEXCONFIG.XML, BAD-SCHEMA-NOT-INDEXED-BUT-NORMS.XML, BAD-SOLRCONFIG-MULTIPLE-INDEXCONFIGS.XML, BAD-SCHEMA-UNIQUEKEY-USES-DEFAULT.XML, SCHEMA-MINIMAL.XML, BAD-SOLRCONFIG-MISSING-SCRIPTFILE.XML, SCHEMA-ONE-FIELD-NO-DYNAMIC-FIELD.XML, SOLRCONFIG-LOGMERGEPOLICY.XML, BAD-SOLRCONFIG-MULTIPLE-DIRFACTORY.XML, SOLRCONFIG_CODEC.XML, BAD-SCHEMA-NON-GLOB-COPYFIELD-SOURCE-MATCHING-NOTHING-SHOULD-FAIL-TEST.XML, SCHEMA-STOP-KEEP.XML, SCHEMA-POSTINGSHIGHLIGHT.XML, SCHEMA-TFIDF.XML, BAD-SCHEMA-DUP-FIELDTYPE.XML, SOLRCONFIG-BASIC.XML, BAD-SCHEMA-UNIQUEKEY-MULTIVALUED.XML, SCHEMA_CODEC.XML, MAPPING-ISOLATIN1ACCENT.TXT, PHRASESUGGEST.TXT, SOLRCONFIG-ALTDIRECTORY.XML, SCHEMA15.XML, SOLRCONFIG-QUERYSENDER.XML, SCHEMA-SNIPPET-FIELD.XML, SOLRCONFIG-INDEXCONFIG.XML, SCHEMA-REQUIRED-FIELDS.XML, BAD-SCHEMA-DUP-FIELD.XML, SOLRCONFIG-HIGHLIGHT.XML, BAD-SCHEMA-NOT-INDEXED-BUT-TF.XML, BAD-SCHEMA-CURRENCY-FT-MULTIVALUED.XML, SOLRCONFIG-ADD-SCHEMA-FIELDS-UPDATE-PROCESSOR-CHAINS.XML, SOLRCONFIG-XINCLUDE.XML, BAD-SCHEMA-UNSUPPORTED-DOCVALUES.XML, STOPWORDSWRONGENCODING.TXT, SOLRCONFIG-INFOSTREAM-LOGGING.XML, BAD-MP-SOLRCONFIG.XML, SCHEMA-NOT-REQUIRED-UNIQUE-KEY.XML, SCHEMA-SIM.XML, STOP-1.TXT, SOLRCONFIG-NOCACHE.XML, SCHEMA-TRIE.XML, SCHEMA-CLASS-NAME-SHORTENING-ON-SERIALIZATION.XML, SOLRCONFIG-DEFAULTS.XML, SOLRCONFIG-MANAGED-SCHEMA.XML, BAD-SCHEMA-SWEETSPOT-PARTIAL-NORMS.XML, SCHEMA-ONE-FIELD-NO-DYNAMIC-FIELD-UNIQUE-KEY.XML, SOLRCONFIG-LAZYWRITER.XML, PROTWORDS.TXT, SOLRCONFIG-MASTER2.XML, ELEVATE.XML, SOLRCONFIG-BASIC-LUCENEVERSION31.XML, SCHEMA-LMJELINEKMERCER.XML, BAD-SCHEMA-DYNAMICFIELD-REQUIRED.XML, SOLRCONFIG-PARSING-UPDATE-PROCESSOR-CHAINS.XML, SOLRCONFIG-MASTER3.XML, SCHEMA-BEHAVIOR.XML, SOLRCONFIG-MASTER.XML, SOLRCONFIG-TRANSFORMERS.XML, BAD-SCHEMA-SWEETSPOT-BOTH-TF.XML, SOLRCONFIG-ELEVATE.XML, MISSING.FUNCTIONS.UPDATEPROCESSOR.JS, KEEP-2.TXT, SCHEMA-DFR.XML, SCHEMA-LMDIRICHLET.XML, XSLT, SCHEMA-SNIPPET-TYPE.XML, SOLRCONFIG-TERMINDEX.XML, SOLRCONFIG-IMPLICITPROPERTIES.XML, CURRENCY.XML, SOLRCONFIG-REPEATER.XML, BAD-SCHEMA-CURRENCY-FT-OER-NORATES.XML, SOLRCONFIG-SUGGESTERCOMPONENT.XML, SCHEMA-REPLICATION2.XML, SOLRCONFIG-SOLR-749.XML, BAD-SCHEMA-SWEETSPOT-PARTIAL-BASELINE.XML, SCHEMA-CUSTOM-FIELD.XML, SCHEMA-ENUMS.XML, BAD-SCHEMA-SIM-GLOBAL-VS-FT-MISMATCH.XML, HUNSPELL-TEST.DIC, SCHEMA-SPELLCHECKER.XML, BAD-SOLRCONFIG-SCHEMA-MUTABLE-BUT-NOT-MANAGED.XML, SCHEMA-DOCVALUES.XML, FRENCHARTICLES.TXT, SCHEMA-COLLATE-DV.XML, SCHEMA-BINARYFIELD.XML, BAD-SCHEMA-EXTERNAL-FILEFIELD.XML, ADDFIELDS.UPDATEPROCESSOR.JS, BAD-SOLRCONFIG-MANAGED-SCHEMA-NAMED-SCHEMA.XML.XML, SOLRCONFIG-MERGEPOLICY-DEFAULTS.XML, SOLRCONFIG-MERGEPOLICY-LEGACY.XML, SCHEMA-ADD-SCHEMA-FIELDS-UPDATE-PROCESSOR.XML, SCHEMA-PHRASESUGGEST.XML, SOLRCONFIG-COMPONENTS-NAME.XML, SOLRCONFIG-SOLCOREPROPERTIES.XML, SOLRCONFIG_PERF.XML, SOLRCONFIG-COLLAPSEQPARSER.XML, SCHEMA-SIMPLEQPPLUGIN.XML, SCHEMA-ID-AND-VERSION-FIELDS-ONLY.XML, STOPWORDS.TXT, SOLRCONFIG-SLAVE1.XML, SOLRCONFIG-TEST-MISC.XML, DA_UTF8.XML, BAD-SCHEMA-CURRENCY-FT-BOGUS-CODE-IN-XML.XML, BAD-SCHEMA-MISPLACED-ASTERISK-COPYFIELD-DEST-SHOULD-FAIL-TEST.XML, THROW.ERROR.ON.ADD.UPDATEPROCESSOR.JS, BAD-SCHEMA-MULTIPLE-ASTERISK-COPYFIELD-DEST-SHOULD-FAIL-TEST.XML, SOLRCONFIG-UPDATE-PROCESSOR-CHAINS.XML, COMPOUNDDICTIONARY.TXT, BAD-SCHEMA-OMIT-TF-BUT-NOT-POS.XML, STOPTYPES-2.TXT, BAD-SCHEMA-UNIQUEKEY-IS-COPYFIELD-DEST.XML, SCHEMA12.XML, SCHEMA-SWEETSPOT.XML, SCHEMA-DISTRIBUTED-MISSING-SORT.XML, SYNONYMS.TXT, TRIVIAL.UPDATEPROCESSOR0.JS, BAD-CURRENCY.XML, SOLRCONFIG-QUERYSENDER-NOQUERY.XML, OLD_SYNONYMS.TXT, STEMDICT.TXT, STOPTYPES-1.TXT, SCHEMA-REST.XML, BAD-SCHEMA-BOGUS-ANALYSIS-PARAMETERS.XML, SCHEMA-DOCVALUESMULTI.XML]
[junit4] 2> 43281 T216 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 43282 T216 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 43283 T216 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=14, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7680765748513475]
[junit4] 2> 43284 T216 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@38ac38ac lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@23302330),segFN=segments_1,generation=1}
[junit4] 2> 43284 T216 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 43285 T216 oass.SolrIndexSearcher.<init> Opening Searcher@338f338f main
[junit4] 2> 43286 T216 oashc.QueryElevationComponent.inform Loading QueryElevation from: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/elevate.xml
[junit4] 2> 43297 T216 oashc.QueryElevationComponent.inform Loading QueryElevation from: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/elevate.xml
[junit4] 2> 43307 T216 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 43307 T217 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@338f338f main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 43308 T170 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0
[junit4] 2> 43309 T170 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> ASYNC NEW_CORE C25 name=collection1 org.apache.solr.core.SolrCore@796c796c
[junit4] 2> 43324 T179 C25 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 43325 T179 C25 oasup.LogUpdateProcessor.finish [collection1] webapp=/g/l path=/update params={version=2&wt=javabin} {deleteByQuery=*:*} 0 4
[junit4] 2> ASYNC NEW_CORE C26 name=collection1 org.apache.solr.core.SolrCore@4ca04ca
[junit4] 2> 43336 T188 C26 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 43337 T188 C26 oasup.LogUpdateProcessor.finish [collection1] webapp=/g/l path=/update params={wt=javabin&version=2} {deleteByQuery=*:*} 0 1
[junit4] 2> ASYNC NEW_CORE C27 name=collection1 org.apache.solr.core.SolrCore@55be55be
[junit4] 2> 43348 T203 C27 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 43349 T203 C27 oasup.LogUpdateProcessor.finish [collection1] webapp=/g/l path=/update params={wt=javabin&version=2} {deleteByQuery=*:*} 0 2
[junit4] 2> ASYNC NEW_CORE C28 name=collection1 org.apache.solr.core.SolrCore@44154415
[junit4] 2> 43361 T215 C28 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 43363 T215 C28 oasup.LogUpdateProcessor.finish [collection1] webapp=/g/l path=/update params={version=2&wt=javabin} {deleteByQuery=*:*} 0 2
[junit4] 2> 43376 T176 C25 oasup.LogUpdateProcessor.finish [collection1] webapp=/g/l path=/update params={version=2&wt=javabin} {add=[1]} 0 8
[junit4] 2> 43384 T191 C26 oasup.LogUpdateProcessor.finish [collection1] webapp=/g/l path=/update params={version=2&wt=javabin} {add=[1]} 0 3
[junit4] 2> 43391 T177 C25 oasup.LogUpdateProcessor.finish [collection1] webapp=/g/l path=/update params={version=2&wt=javabin} {add=[2]} 0 3
[junit4] 2> ASYNC NEW_CORE C29 name=collection1 org.apache.solr.core.SolrCore@55be55be
[junit4] 2> 43407 T201 C29 oasup.LogUpdateProcessor.finish [collection1] webapp=/g/l path=/update params={wt=javabin&version=2} {add=[2]} 0 3
[junit4] 2> ASYNC NEW_CORE C30 name=collection1 org.apache.solr.core.SolrCore@796c796c
[junit4] 2> 43413 T178 C30 oasup.LogUpdateProcessor.finish [collection1] webapp=/g/l path=/update params={version=2&wt=javabin} {add=[3]} 0 2
[junit4] 2> ASYNC NEW_CORE C31 name=collection1 org.apache.solr.core.SolrCore@44154415
[junit4] 2> 43419 T212 C31 oasup.LogUpdateProcessor.finish [collection1] webapp=/g/l path=/update params={version=2&wt=javabin} {add=[3]} 0 2
[junit4] 2> 43424 T179 C30 oasup.LogUpdateProcessor.finish [collection1] webapp=/g/l path=/update params={version=2&wt=javabin} {add=[4]} 0 1
[junit4] 2> ASYNC NEW_CORE C32 name=collection1 org.apache.solr.core.SolrCore@4ca04ca
[junit4] 2> 43429 T190 C32 oasup.LogUpdateProcessor.finish [collection1] webapp=/g/l path=/update params={wt=javabin&version=2} {add=[4]} 0 1
[junit4] 2> 43435 T176 C30 oasup.LogUpdateProcessor.finish [collection1] webapp=/g/l path=/update params={version=2&wt=javabin} {add=[5]} 0 1
[junit4] 2> 43441 T200 C29 oasup.LogUpdateProcessor.finish [collection1] webapp=/g/l path=/update params={version=2&wt=javabin} {add=[5]} 0 2
[junit4] 2> 43446 T177 C30 oasup.LogUpdateProcessor.finish [collection1] webapp=/g/l path=/update params={wt=javabin&version=2} {add=[6]} 0 1
[junit4] 2> 43451 T213 C31 oasup.LogUpdateProcessor.finish [collection1] webapp=/g/l path=/update params={wt=javabin&version=2} {add=[6]} 0 1
[junit4] 2> 43461 T178 C30 oasup.LogUpdateProcessor.finish [collection1] webapp=/g/l path=/update params={version=2&wt=javabin} {add=[7]} 0 1
[junit4] 2> 43467 T214 C31 oasup.LogUpdateProcessor.finish [collection1] webapp=/g/l path=/update params={version=2&wt=javabin} {add=[7]} 0 2
[junit4] 2> 43473 T179 C30 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 43478 T179 C30 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@4d0a4d0a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6d5f6d5f),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@4d0a4d0a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6d5f6d5f),segFN=segments_2,generation=2}
[junit4] 2> 43479 T179 C30 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 43481 T179 C30 oass.SolrIndexSearcher.<init> Opening Searcher@2ac62ac6 main
[junit4] 2> 43482 T179 C30 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 43482 T181 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2ac62ac6 main{StandardDirectoryReader(segments_2:4:nrt _0(4.7):C7)}
[junit4] 2> 43483 T179 C30 oasup.LogUpdateProcessor.finish [collection1] webapp=/g/l path=/update params={version=2&waitSearcher=true&softCommit=false&commit=true&wt=javabin} {commit=} 0 11
[junit4] 2> 43488 T189 C32 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 43492 T189 C32 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@71ec71ec lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b200b2),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@71ec71ec lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b200b2),segFN=segments_2,generation=2}
[junit4] 2> 43493 T189 C32 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 43495 T189 C32 oass.SolrIndexSearcher.<init> Opening Searcher@69df69df main
[junit4] 2> 43496 T189 C32 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 43496 T193 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@69df69df main{StandardDirectoryReader(segments_2:4:nrt _0(4.7):C2)}
[junit4] 2> 43497 T189 C32 oasup.LogUpdateProcessor.finish [collection1] webapp=/g/l path=/update params={version=2&waitSearcher=true&softCommit=false&commit=true&wt=javabin} {commit=} 0 9
[junit4] 2> 43502 T202 C29 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 43508 T202 C29 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@4a4a4a4a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6bff6bff),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@4a4a4a4a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6bff6bff),segFN=segments_2,generation=2}
[junit4] 2> 43509 T202 C29 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 43512 T202 C29 oass.SolrIndexSearcher.<init> Opening Searcher@c500c50 main
[junit4] 2> 43513 T202 C29 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 43513 T205 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@c500c50 main{StandardDirectoryReader(segments_2:4:nrt _0(4.7):C2)}
[junit4] 2> 43515 T202 C29 oasup.LogUpdateProcessor.finish [collection1] webapp=/g/l path=/update params={version=2&waitSearcher=true&commit=true&softCommit=false&wt=javabin} {commit=} 0 13
[junit4] 2> 43520 T215 C31 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 43524 T215 C31 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@38ac38ac lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@23302330),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@38ac38ac lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@23302330),segFN=segments_2,generation=2}
[junit4] 2> 43524 T215 C31 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 43526 T215 C31 oass.SolrIndexSearcher.<init> Opening Searcher@6c356c35 main
[junit4] 2> 43527 T215 C31 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 43527 T217 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6c356c35 main{StandardDirectoryReader(segments_2:4:nrt _0(4.7):C3)}
[junit4] 2> 43528 T215 C31 oasup.LogUpdateProcessor.finish [collection1] webapp=/g/l path=/update params={version=2&waitSearcher=true&wt=javabin&commit=true&softCommit=false} {commit=} 0 8
[junit4] 2> 43557 T176 C30 oasc.SolrCore.execute [collection1] webapp=/g/l path=/elevate params={qt=/elevate&version=2&q=*:*&distrib=false&fl=id,+score,+[elevated]&rows=500&shards.qt=/elevate&wt=javabin&sort=id+desc} hits=7 status=0 QTime=23
[junit4] 2> 43578 T213 C31 oasc.SolrCore.execute [collection1] webapp=/g/l path=/elevate params={fl=id,score&fsv=true&distrib=false&version=2&NOW=1385771799534&qt=/elevate&rows=500&q=*:*&start=0&shard.url=127.0.0.1:34924/g/l&sort=id+desc&isShard=true&wt=javabin&shards.qt=/elevate} hits=3 status=0 QTime=1
[junit4] 2> 43578 T191 C32 oasc.SolrCore.execute [collection1] webapp=/g/l path=/elevate params={sort=id+desc&isShard=true&wt=javabin&shards.qt=/elevate&rows=500&q=*:*&start=0&shard.url=[ff01::083]:33332/g/l|127.0.0.1:47878/g/l&fl=id,score&fsv=true&distrib=false&version=2&NOW=1385771799534&qt=/elevate} hits=2 status=0 QTime=2
[junit4] 2> 43583 T200 C2
[...truncated too long message...]
webapp=null path=null params={} {commit=} 0 8
[junit4] 2> 2297655 T2549 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2297664 T2549 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@7eb87eb8 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6520652)),segFN=segments_13,generation=39}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@7eb87eb8 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6520652)),segFN=segments_14,generation=40}
[junit4] 2> 2297665 T2549 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 40
[junit4] 2> 2297666 T2549 oass.SolrIndexSearcher.<init> Opening Searcher@57e357e3 main
[junit4] 2> 2297668 T2549 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 2297671 T2551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@57e357e3 main{StandardDirectoryReader(segments_14:160:nrt _1c(4.7):c2)}
[junit4] 2> 2297676 T2549 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2297679 T2549 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@7eb87eb8 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6520652)),segFN=segments_14,generation=40}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@7eb87eb8 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6520652)),segFN=segments_15,generation=41}
[junit4] 2> 2297680 T2549 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 41
[junit4] 2> 2297681 T2549 oass.SolrIndexSearcher.<init> Opening Searcher@38983898 main
[junit4] 2> 2297682 T2549 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 2297686 T2551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@38983898 main{StandardDirectoryReader(segments_15:162:nrt _1c(4.7):c2 _1d(4.7):c1)}
[junit4] 2> 2297687 T2549 oas.SolrTestCaseJ4.tearDown ###Ending testDupeDetection
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SignatureUpdateProcessorFactoryTest -Dtests.method=testDupeDetection -Dtests.seed=ADF623EBC61C67E6 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=sl_SI -Dtests.timezone=Asia/Irkutsk -Dtests.file.encoding=ISO-8859-1
[junit4] FAILURE 0.08s J1 | SignatureUpdateProcessorFactoryTest.testDupeDetection <<<
[junit4] > Throwable #1: java.lang.AssertionError: expected:<1> but was:<3>
[junit4] > at __randomizedtesting.SeedInfo.seed([ADF623EBC61C67E6:F6C6D823C55BC49A]:0)
[junit4] > at org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest.checkNumDocs(SignatureUpdateProcessorFactoryTest.java:71)
[junit4] > at org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest.testDupeDetection(SignatureUpdateProcessorFactoryTest.java:119)
[junit4] > at java.lang.Thread.run(Thread.java:738)
[junit4] 2> 2297699 T2549 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 2297700 T2549 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=100074999
[junit4] 2> 2297701 T2549 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@14331433
[junit4] 2> 2297725 T2549 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=42,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=253,cumulative_deletesById=0,cumulative_deletesByQuery=6,cumulative_errors=0}
[junit4] 2> 2297726 T2549 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 2297727 T2549 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 2297728 T2549 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 2297729 T2549 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 2297730 T2549 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 2297731 T2549 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1385774052081/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1385774052081/index;done=false>>]
[junit4] 2> 2297732 T2549 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1385774052081/index
[junit4] 2> 2297732 T2549 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1385774052081 [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1385774052081;done=false>>]
[junit4] 2> 2297733 T2549 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1385774052081
[junit4] 2> NOTE: test params are: codec=Lucene40, sim=RandomSimilarityProvider(queryNorm=true,coord=no): {}, locale=sl_SI, timezone=Asia/Irkutsk
[junit4] 2> NOTE: Linux 3.8.0-33-generic x86/IBM Corporation 1.6.0 (32-bit)/cpus=8,threads=1,free=14120576,total=93481472
[junit4] 2> NOTE: All tests run in this JVM: [TestFastOutputStream, TestAddFieldRealTimeGet, TestDistributedMissingSort, TestShardHandlerFactory, TestFastLRUCache, TestQuerySenderNoQuery, DocValuesMultiTest, MultiTermTest, CurrencyFieldXmlFileTest, HdfsLockFactoryTest, TestFiltering, TestFieldTypeCollectionResource, OpenCloseCoreStressTest, PluginInfoTest, DistributedDebugComponentTest, TestStressReorder, SuggesterTSTTest, HighlighterConfigTest, TestDefaultSearchFieldResource, NotRequiredUniqueKeyTest, TestCollationFieldDocValues, TestNoOpRegenerator, TestIndexingPerformance, AlternateDirectoryTest, HdfsChaosMonkeySafeLeaderTest, ZkNodePropsTest, TestDistributedSearch, AddBlockUpdateTest, RAMDirectoryFactoryTest, RequiredFieldsTest, TestSchemaNameResource, TestStressRecovery, HdfsDirectoryTest, TestNumberUtils, TestXIncludeConfig, DirectSolrSpellCheckerTest, UniqFieldsUpdateProcessorFactoryTest, SpellCheckComponentTest, TestWordDelimiterFilterFactory, SpellingQueryConverterTest, DistributedQueryComponentCustomSortTest, DisMaxRequestHandlerTest, ChaosMonkeySafeLeaderTest, StandardRequestHandlerTest, NumericFieldsTest, TestSolrQueryParserResource, TestBinaryResponseWriter, TestCoreDiscovery, PrimUtilsTest, TestCollationKeyRangeQueries, TestSweetSpotSimilarityFactory, CachingDirectoryFactoryTest, TestDFRSimilarityFactory, DistanceFunctionTest, TestAnalyzedSuggestions, XsltUpdateRequestHandlerTest, ChangedSchemaMergeTest, OutputWriterTest, TestFieldResource, TestCollationField, TestFuzzyAnalyzedSuggestions, TestRTGBase, CustomCollectionTest, DirectUpdateHandlerTest, TestRandomFaceting, EnumFieldTest, TestSolrXml, DefaultValueUpdateProcessorTest, TestIBSimilarityFactory, TestJmxIntegration, TestMultiCoreConfBootstrap, CoreMergeIndexesAdminHandlerTest, SolrCmdDistributorTest, HardAutoCommitTest, TestUpdate, DirectSolrConnectionTest, TimeZoneUtilsTest, TestRecovery, MinimalSchemaTest, SolrIndexConfigTest, PingRequestHandlerTest, ChaosMonkeyNothingIsSafeTest, TestCodecSupport, DeleteInactiveReplicaTest, TestReload, TestRangeQuery, TestCoreContainer, TestSolr4Spatial, ConvertedLegacyTest, BasicFunctionalityTest, OverseerCollectionProcessorTest, TestIndexSearcher, SoftAutoCommitTest, SignatureUpdateProcessorFactoryTest]
[junit4] Completed on J1 in 2.25s, 6 tests, 2 failures <<< FAILURES!
[...truncated 425 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:426: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:419: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:39: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/extra-targets.xml:37: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build.xml:189: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/common-build.xml:491: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:1279: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:912: There were test failures: 349 suites, 1516 tests, 4 failures, 34 ignored (6 assumptions)
Total time: 72 minutes 39 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 32bit/ibm-j9-jdk6 -Xjit:exclude={org/apache/lucene/util/fst/FST.pack(IIF)Lorg/apache/lucene/util/fst/FST;}
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure