Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-MacOSX/1760/ Java: 64bit/jdk1.7.0 -XX:+UseCompressedOops -XX:+UseParallelGC
1 tests failed. FAILED: org.apache.solr.schema.TestCloudSchemaless.testDistribSearch Error Message: Timeout occured while waiting response from server at: https://127.0.0.1:53517/l_g/nz/collection1 Stack Trace: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: https://127.0.0.1:53517/l_g/nz/collection1 at __randomizedtesting.SeedInfo.seed([D92DB885BB946A5D:58CB369DCCCB0A61]:0) at org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:559) at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:210) at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:206) at org.apache.solr.client.solrj.request.AbstractUpdateRequest.process(AbstractUpdateRequest.java:124) at org.apache.solr.client.solrj.SolrServer.add(SolrServer.java:68) at org.apache.solr.client.solrj.SolrServer.add(SolrServer.java:54) at org.apache.solr.schema.TestCloudSchemaless.doTest(TestCloudSchemaless.java:140) at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:865) at sun.reflect.GeneratedMethodAccessor38.invoke(Unknown Source) 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:1618) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877) 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.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:65) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836) at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738) at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783) 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 com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at java.lang.Thread.run(Thread.java:745) Caused by: java.net.SocketTimeoutException: Read timed out at java.net.SocketInputStream.socketRead0(Native Method) at java.net.SocketInputStream.read(SocketInputStream.java:152) at java.net.SocketInputStream.read(SocketInputStream.java:122) at sun.security.ssl.InputRecord.readFully(InputRecord.java:442) at sun.security.ssl.InputRecord.read(InputRecord.java:480) at sun.security.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:927) at sun.security.ssl.SSLSocketImpl.readDataRecord(SSLSocketImpl.java:884) at sun.security.ssl.AppInputStream.read(AppInputStream.java:102) at org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160) at org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84) at org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273) at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140) at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57) at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:260) at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283) at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251) at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197) at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:271) at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:123) at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:682) at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:486) at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:863) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:106) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:57) at org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:449) ... 46 more Build Log: [...truncated 11947 lines...] [junit4] Suite: org.apache.solr.schema.TestCloudSchemaless [junit4] 2> Creating dataDir: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/init-core-data-001 [junit4] 2> 6806756 T16167 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (true) and clientAuth (false) [junit4] 2> 6806757 T16167 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /l_g/nz [junit4] 2> 6806762 T16167 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch [junit4] 2> 6806763 T16167 oasc.ZkTestServer.run STARTING ZK TEST SERVER [junit4] 1> client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 6806765 T16168 oasc.ZkTestServer$ZKServerMain.runFromConfig Starting server [junit4] 2> 6806866 T16167 oasc.ZkTestServer.run start zk server on port:53481 [junit4] 2> 6806867 T16167 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 6806877 T16174 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@70adf125 name:ZooKeeperConnection Watcher:127.0.0.1:53481 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 6806877 T16167 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 6806878 T16167 oascc.SolrZkClient.makePath makePath: /solr [junit4] 2> 6806889 T16167 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 6806892 T16176 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@40b8cb3e name:ZooKeeperConnection Watcher:127.0.0.1:53481/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 6806893 T16167 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 6806893 T16167 oascc.SolrZkClient.makePath makePath: /collections/collection1 [junit4] 2> 6806899 T16167 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards [junit4] 2> 6806906 T16167 oascc.SolrZkClient.makePath makePath: /collections/control_collection [junit4] 2> 6806913 T16167 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards [junit4] 2> 6806922 T16167 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/solrconfig-schemaless.xml to /configs/conf1/solrconfig.xml [junit4] 2> 6806922 T16167 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml [junit4] 2> 6806935 T16167 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/schema-add-schema-fields-update-processor.xml to /configs/conf1/schema.xml [junit4] 2> 6806935 T16167 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml [junit4] 2> 6806944 T16167 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 6806944 T16167 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 6806954 T16167 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt [junit4] 2> 6806954 T16167 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt [junit4] 2> 6806960 T16167 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt [junit4] 2> 6806960 T16167 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt [junit4] 2> 6806968 T16167 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml [junit4] 2> 6806969 T16167 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml [junit4] 2> 6806979 T16167 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml [junit4] 2> 6806980 T16167 oascc.SolrZkClient.makePath makePath: /configs/conf1/enumsConfig.xml [junit4] 2> 6806994 T16167 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json [junit4] 2> 6806996 T16167 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json [junit4] 2> 6807004 T16167 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 6807005 T16167 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 6807015 T16167 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt [junit4] 2> 6807016 T16167 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt [junit4] 2> 6807026 T16167 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt [junit4] 2> 6807026 T16167 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt [junit4] 2> 6807040 T16167 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 6807046 T16178 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@4e4cdbb name:ZooKeeperConnection Watcher:127.0.0.1:53481/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 6807046 T16167 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 6809749 T16167 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 6809759 T16167 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] [junit4] 2> 6809761 T16167 oejs.AbstractConnector.doStart Started SslSelectChannelConnector@127.0.0.1:53485 [junit4] 2> 6809764 T16167 oass.SolrDispatchFilter.init SolrDispatchFilter.init() [junit4] 2> 6809765 T16167 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 6809766 T16167 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-002 [junit4] 2> 6809766 T16167 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-002/' [junit4] 2> 6809819 T16167 oasc.ConfigSolr.fromFile Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-002/solr.xml [junit4] 2> 6809890 T16167 oasc.CoreContainer.<init> New CoreContainer 313433159 [junit4] 2> 6809890 T16167 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-002/] [junit4] 2> 6809891 T16167 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 6809892 T16167 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: [junit4] 2> 6809893 T16167 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 6809893 T16167 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 6809893 T16167 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 6809894 T16167 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 6809894 T16167 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 6809894 T16167 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 6809895 T16167 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 6809899 T16167 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false [junit4] 2> 6809902 T16167 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 6809902 T16167 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 6809902 T16167 oasc.CoreContainer.load Host Name: 127.0.0.1 [junit4] 2> 6809903 T16167 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:53481/solr [junit4] 2> 6809903 T16167 oasc.ZkController.checkChrootPath zkHost includes chroot [junit4] 2> 6809905 T16167 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 6809911 T16189 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1ded21b4 name:ZooKeeperConnection Watcher:127.0.0.1:53481 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 6809913 T16167 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 6809919 T16167 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 6809923 T16191 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@68700bfb name:ZooKeeperConnection Watcher:127.0.0.1:53481/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 6809924 T16167 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 6809928 T16167 oascc.SolrZkClient.makePath makePath: /overseer/queue [junit4] 2> 6809940 T16167 oascc.SolrZkClient.makePath makePath: /overseer/collection-queue-work [junit4] 2> 6809952 T16167 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-running [junit4] 2> 6809963 T16167 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-completed [junit4] 2> 6809974 T16167 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-failure [junit4] 2> 6809988 T16167 oascc.SolrZkClient.makePath makePath: /live_nodes [junit4] 2> 6809994 T16167 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:53485_l_g%2Fnz [junit4] 2> 6809997 T16167 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:53485_l_g%2Fnz [junit4] 2> 6810010 T16167 oascc.SolrZkClient.makePath makePath: /overseer_elect [junit4] 2> 6810020 T16167 oascc.SolrZkClient.makePath makePath: /overseer_elect/election [junit4] 2> 6810035 T16167 oasc.OverseerElectionContext.runLeaderProcess I am going to be the leader 127.0.0.1:53485_l_g%2Fnz [junit4] 2> 6810035 T16167 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader [junit4] 2> 6810045 T16167 oasc.Overseer.start Overseer (id=92249283595993092-127.0.0.1:53485_l_g%2Fnz-n_0000000000) starting [junit4] 2> 6810054 T16167 oascc.SolrZkClient.makePath makePath: /overseer/queue-work [junit4] 2> 6810093 T16193 oasc.OverseerCollectionProcessor.run Process current queue of collection creations [junit4] 2> 6810094 T16167 oascc.SolrZkClient.makePath makePath: /clusterstate.json [junit4] 2> 6810102 T16167 oascc.SolrZkClient.makePath makePath: /aliases.json [junit4] 2> 6810112 T16167 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 6810124 T16192 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue [junit4] 2> 6810138 T16194 oasc.ZkController.publish publishing core=collection1 state=down collection=control_collection [junit4] 2> 6810138 T16194 oasc.ZkController.publish numShards not found on descriptor - reading it from system property [junit4] 2> 6810141 T16194 oasc.ZkController.waitForCoreNodeName look for our core node name [junit4] 2> 6810142 T16195 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6810148 T16192 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... [junit4] 2> 6810150 T16192 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={ [junit4] 2> "operation":"state", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:53485/l_g/nz", [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "node_name":"127.0.0.1:53485_l_g%2Fnz", [junit4] 2> "shard":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "numShards":"1", [junit4] 2> "core_node_name":null} [junit4] 2> 6810150 T16192 oasc.Overseer$ClusterStateUpdater.createCollection Create collection control_collection with shards [shard1] [junit4] 2> 6810151 T16192 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard1 [junit4] 2> 6810160 T16195 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> 6811143 T16194 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1 [junit4] 2> 6811144 T16194 oasc.ZkController.createCollectionZkNode Check for collection zkNode:control_collection [junit4] 2> 6811146 T16194 oasc.ZkController.createCollectionZkNode Collection zkNode exists [junit4] 2> 6811146 T16194 oascc.ZkStateReader.readConfigName Load collection config from:/collections/control_collection [junit4] 2> 6811150 T16194 oascc.ZkStateReader.readConfigName path=/collections/control_collection configName=conf1 specified config exists in ZooKeeper [junit4] 2> 6811150 T16194 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-002/collection1/' [junit4] 2> 6811151 T16194 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-002/collection1/lib/.svn/' to classloader [junit4] 2> 6811152 T16194 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-002/collection1/lib/classes/' to classloader [junit4] 2> 6811152 T16194 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-002/collection1/lib/README' to classloader [junit4] 2> 6811260 T16194 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0 [junit4] 2> 6811338 T16194 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 6811340 T16194 oass.ManagedIndexSchemaFactory.create The schema is configured as managed, but managed schema resource managed-schema not found - loading non-managed schema schema.xml instead [junit4] 2> 6811344 T16194 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml [junit4] 2> 6811356 T16194 oass.IndexSchema.readSchema [collection1] Schema name=add-schema-fields-update-processor [junit4] 2> 6811441 T16194 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 6811448 T16194 oass.ManagedIndexSchema.persistManagedSchemaToZooKeeper Created and persisted managed schema znode at /configs/conf1/managed-schema [junit4] 2> 6811454 T16194 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml.bak [junit4] 2> 6811468 T16194 oass.ManagedIndexSchemaFactory.zkUgradeToManagedSchema After upgrading to managed schema in ZooKeeper, renamed the non-managed schema /configs/conf1/schema.xml to /configs/conf1/schema.xml.bak [junit4] 2> 6811469 T16194 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from collection control_collection [junit4] 2> 6811469 T16194 oasc.SolrCore.initDirectoryFactory solr.NRTCachingDirectoryFactory [junit4] 2> 6811471 T16194 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-002/collection1/, dataDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-002/collection1/data/ [junit4] 2> 6811471 T16194 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1 [junit4] 2> 6811474 T16194 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-002/collection1/data [junit4] 2> 6811478 T16194 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-002/collection1/data/index/ [junit4] 2> 6811479 T16194 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-002/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 6811480 T16194 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-002/collection1/data/index [junit4] 2> 6811481 T16194 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=6, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 6811492 T16194 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-002/collection1/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7b9c319c; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1} [junit4] 2> 6811493 T16194 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 6811500 T16194 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "add-unknown-fields-to-the-schema" [junit4] 2> 6811667 T16194 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 6811669 T16194 oasc.RequestHandlers.initHandlersFromConfig created /update: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 6811670 T16194 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 6811670 T16194 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 6811670 T16194 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 6811671 T16194 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4] 2> 6811671 T16194 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler [junit4] 2> 6811672 T16194 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4] 2> 6811672 T16194 oasc.RequestHandlers.initHandlersFromConfig WARN Multiple requestHandler registered to the same name: /update ignoring: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 6811672 T16194 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler [junit4] 2> 6811672 T16194 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler [junit4] 2> 6811673 T16194 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler [junit4] 2> 6811686 T16194 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 6811689 T16194 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 6811690 T16194 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 6811692 T16194 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 6811694 T16194 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 6811703 T16194 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 6811703 T16194 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 6811704 T16194 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=36, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 6811707 T16194 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-002/collection1/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7b9c319c; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1} [junit4] 2> 6811708 T16194 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 6811709 T16194 oass.SolrIndexSearcher.<init> Opening Searcher@5500ee84[collection1] main [junit4] 2> 6811709 T16194 oascc.ZkStateReader.readConfigName Load collection config from:/collections/control_collection [junit4] 2> 6811713 T16194 oascc.ZkStateReader.readConfigName path=/collections/control_collection configName=conf1 specified config exists in ZooKeeper [junit4] 2> 6811713 T16194 oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1 [junit4] 2> 6811715 T16194 oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 6811715 T16194 oasr.RestManager.init Initializing RestManager with initArgs: {} [junit4] 2> 6811716 T16194 oasr.ManagedResourceStorage.load Reading _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 6811718 T16194 oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found for znode /configs/conf1/_rest_managed.json [junit4] 2> 6811718 T16194 oasr.ManagedResourceStorage.load Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 6811721 T16194 oascc.SolrZkClient.makePath makePath: /configs/conf1/_rest_managed.json [junit4] 2> 6811733 T16194 oasr.ManagedResourceStorage$ZooKeeperStorageIO$1.close Wrote 38 bytes to new znode /configs/conf1/_rest_managed.json [junit4] 2> 6811733 T16194 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 6811734 T16194 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 6811735 T16194 oass.ZkIndexSchemaReader.createSchemaWatcher Creating ZooKeeper watch for the managed schema at /configs/conf1/managed-schema ... [junit4] 2> 6811740 T16194 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 6811741 T16196 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5500ee84[collection1] main{UninvertingDirectoryReader()} [junit4] 2> 6811744 T16199 oasc.ZkController.register Register replica - core:collection1 address:https://127.0.0.1:53485/l_g/nz collection:control_collection shard:shard1 [junit4] 2> 6811745 T16167 oass.SolrDispatchFilter.init user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0 [junit4] 2> 6811746 T16167 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 6811747 T16199 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leader_elect/shard1/election [junit4] 2> 6811759 T16167 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 6811763 T16201 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1744647b name:ZooKeeperConnection Watcher:127.0.0.1:53481/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 6811763 T16167 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 6811767 T16167 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 6811769 T16199 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard1 [junit4] 2> 6811776 T16167 oasc.ChaosMonkey.monkeyLog monkey: init - expire sessions:false cause connection loss:false [junit4] 2> 6811777 T16195 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6811778 T16199 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue. [junit4] 2> 6811779 T16199 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync [junit4] 2> ASYNC NEW_CORE C2819 name=collection1 org.apache.solr.core.SolrCore@22c2fafd url=https://127.0.0.1:53485/l_g/nz/collection1 node=127.0.0.1:53485_l_g%2Fnz C2819_STATE=coll:control_collection core:collection1 props:{state=down, base_url=https://127.0.0.1:53485/l_g/nz, core=collection1, node_name=127.0.0.1:53485_l_g%2Fnz} [junit4] 2> 6811779 T16199 C2819 P53485 oasc.SyncStrategy.sync Sync replicas to https://127.0.0.1:53485/l_g/nz/collection1/ [junit4] 2> 6811780 T16199 C2819 P53485 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me [junit4] 2> 6811780 T16199 C2819 P53485 oasc.SyncStrategy.syncToMe https://127.0.0.1:53485/l_g/nz/collection1/ has no replicas [junit4] 2> 6811781 T16199 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: https://127.0.0.1:53485/l_g/nz/collection1/ shard1 [junit4] 2> 6811781 T16199 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leaders/shard1 [junit4] 2> 6811806 T16192 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... [junit4] 2> 6811830 T16202 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> 6811830 T16195 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> 6811850 T16192 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... [junit4] 2> 6811859 T16195 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6811966 T16195 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> 6811966 T16202 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> 6811980 T16199 oasc.ZkController.register We are https://127.0.0.1:53485/l_g/nz/collection1/ and leader is https://127.0.0.1:53485/l_g/nz/collection1/ [junit4] 2> 6811980 T16199 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=https://127.0.0.1:53485/l_g/nz [junit4] 2> 6811981 T16199 oasc.ZkController.checkRecovery I am the leader, no recovery necessary [junit4] 2> 6811981 T16199 oasc.ZkController.publish publishing core=collection1 state=active collection=control_collection [junit4] 2> 6811981 T16199 oasc.ZkController.publish numShards not found on descriptor - reading it from system property [junit4] 2> 6811985 T16195 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6811987 T16199 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... [junit4] 2> 6811991 T16192 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... [junit4] 2> 6811994 T16192 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={ [junit4] 2> "operation":"state", [junit4] 2> "state":"active", [junit4] 2> "base_url":"https://127.0.0.1:53485/l_g/nz", [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "node_name":"127.0.0.1:53485_l_g%2Fnz", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "numShards":"4", [junit4] 2> "core_node_name":"core_node1"} [junit4] 2> 6812109 T16202 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> 6812110 T16195 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> 6814113 T16167 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 1 [junit4] 2> 6814114 T16167 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 6814122 T16167 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] [junit4] 2> 6814126 T16167 oejs.AbstractConnector.doStart Started SslSelectChannelConnector@127.0.0.1:53489 [junit4] 2> 6814131 T16167 oass.SolrDispatchFilter.init SolrDispatchFilter.init() [junit4] 2> 6814131 T16167 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 6814132 T16167 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-003 [junit4] 2> 6814133 T16167 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-003/' [junit4] 2> 6814217 T16167 oasc.ConfigSolr.fromFile Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-003/solr.xml [junit4] 2> 6814332 T16167 oasc.CoreContainer.<init> New CoreContainer 986350674 [junit4] 2> 6814333 T16167 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-003/] [junit4] 2> 6814335 T16167 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 6814335 T16167 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: [junit4] 2> 6814336 T16167 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 6814336 T16167 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 6814337 T16167 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 6814337 T16167 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 6814338 T16167 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 6814338 T16167 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 6814339 T16167 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 6814344 T16167 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false [junit4] 2> 6814347 T16167 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 6814347 T16167 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 6814348 T16167 oasc.CoreContainer.load Host Name: 127.0.0.1 [junit4] 2> 6814348 T16167 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:53481/solr [junit4] 2> 6814349 T16167 oasc.ZkController.checkChrootPath zkHost includes chroot [junit4] 2> 6814352 T16167 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 6814357 T16213 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@5a723bbf name:ZooKeeperConnection Watcher:127.0.0.1:53481 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 6814359 T16167 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 6814366 T16167 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 6814371 T16215 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@429b4a64 name:ZooKeeperConnection Watcher:127.0.0.1:53481/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 6814372 T16167 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 6814399 T16167 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 6815411 T16167 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:53489_l_g%2Fnz [junit4] 2> 6815413 T16167 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:53489_l_g%2Fnz [junit4] 2> 6815447 T16217 oasc.ZkController.publish publishing core=collection1 state=down collection=collection1 [junit4] 2> 6815447 T16217 oasc.ZkController.publish numShards not found on descriptor - reading it from system property [junit4] 2> 6815450 T16195 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6815450 T16217 oasc.ZkController.waitForCoreNodeName look for our core node name [junit4] 2> 6815454 T16192 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... [junit4] 2> 6815455 T16192 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={ [junit4] 2> "operation":"state", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:53489/l_g/nz", [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "node_name":"127.0.0.1:53489_l_g%2Fnz", [junit4] 2> "shard":null, [junit4] 2> "collection":"collection1", [junit4] 2> "numShards":"4", [junit4] 2> "core_node_name":null} [junit4] 2> 6815456 T16192 oasc.Overseer$ClusterStateUpdater.createCollection Create collection collection1 with shards [shard1, shard2, shard3, shard4] [junit4] 2> 6815456 T16192 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard4 [junit4] 2> 6815463 T16195 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> 6815463 T16216 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> 6815465 T16202 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> 6816453 T16217 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1 [junit4] 2> 6816453 T16217 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1 [junit4] 2> 6816457 T16217 oasc.ZkController.createCollectionZkNode Collection zkNode exists [junit4] 2> 6816457 T16217 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1 [junit4] 2> 6816463 T16217 oascc.ZkStateReader.readConfigName path=/collections/collection1 configName=conf1 specified config exists in ZooKeeper [junit4] 2> 6816464 T16217 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-003/collection1/' [junit4] 2> 6816466 T16217 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-003/collection1/lib/.svn/' to classloader [junit4] 2> 6816467 T16217 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-003/collection1/lib/classes/' to classloader [junit4] 2> 6816469 T16217 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-003/collection1/lib/README' to classloader [junit4] 2> 6816574 T16217 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0 [junit4] 2> 6816622 T16217 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 6816626 T16217 oass.IndexSchema.readSchema Reading Solr Schema from managed-schema [junit4] 2> 6816634 T16217 oass.IndexSchema.readSchema [collection1] Schema name=add-schema-fields-update-processor [junit4] 2> 6816694 T16217 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 6816697 T16217 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from collection collection1 [junit4] 2> 6816697 T16217 oasc.SolrCore.initDirectoryFactory solr.NRTCachingDirectoryFactory [junit4] 2> 6816698 T16217 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-003/collection1/, dataDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-003/collection1/data/ [junit4] 2> 6816698 T16217 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1 [junit4] 2> 6816700 T16217 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-003/collection1/data [junit4] 2> 6816701 T16217 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-003/collection1/data/index/ [junit4] 2> 6816701 T16217 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-003/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 6816703 T16217 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-003/collection1/data/index [junit4] 2> 6816703 T16217 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=6, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 6816709 T16217 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-003/collection1/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@67f0a96b; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1} [junit4] 2> 6816709 T16217 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 6816713 T16217 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "add-unknown-fields-to-the-schema" [junit4] 2> 6816715 T16217 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 6816716 T16217 oasc.RequestHandlers.initHandlersFromConfig created /update: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 6816716 T16217 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 6816717 T16217 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 6816717 T16217 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 6816718 T16217 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4] 2> 6816719 T16217 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler [junit4] 2> 6816719 T16217 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4] 2> 6816719 T16217 oasc.RequestHandlers.initHandlersFromConfig WARN Multiple requestHandler registered to the same name: /update ignoring: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 6816720 T16217 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler [junit4] 2> 6816721 T16217 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler [junit4] 2> 6816721 T16217 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler [junit4] 2> 6816736 T16217 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 6816738 T16217 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 6816741 T16217 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 6816744 T16217 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 6816747 T16217 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 6816756 T16217 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 6816756 T16217 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 6816757 T16217 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=36, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 6816759 T16217 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-003/collection1/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@67f0a96b; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1} [junit4] 2> 6816760 T16217 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 6816760 T16217 oass.SolrIndexSearcher.<init> Opening Searcher@38783d[collection1] main [junit4] 2> 6816760 T16217 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1 [junit4] 2> 6816764 T16217 oascc.ZkStateReader.readConfigName path=/collections/collection1 configName=conf1 specified config exists in ZooKeeper [junit4] 2> 6816764 T16217 oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1 [junit4] 2> 6816766 T16217 oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 6816767 T16217 oasr.RestManager.init Initializing RestManager with initArgs: {} [junit4] 2> 6816767 T16217 oasr.ManagedResourceStorage.load Reading _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 6816770 T16217 oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream Read 38 bytes from znode /configs/conf1/_rest_managed.json [junit4] 2> 6816771 T16217 oasr.ManagedResourceStorage.load Loaded LinkedHashMap at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 6816771 T16217 oasr.ManagedResource.reloadFromStorage Loaded initArgs {} for /rest/managed [junit4] 2> 6816771 T16217 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 6816771 T16217 oass.ZkIndexSchemaReader.createSchemaWatcher Creating ZooKeeper watch for the managed schema at /configs/conf1/managed-schema ... [junit4] 2> 6816780 T16217 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 6816780 T16218 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@38783d[collection1] main{UninvertingDirectoryReader()} [junit4] 2> 6816783 T16221 oasc.ZkController.register Register replica - core:collection1 address:https://127.0.0.1:53489/l_g/nz collection:collection1 shard:shard4 [junit4] 2> 6816784 T16167 oass.SolrDispatchFilter.init user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0 [junit4] 2> 6816785 T16167 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 6816786 T16221 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard4/election [junit4] 2> 6816806 T16221 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard4 [junit4] 2> 6816812 T16195 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6816823 T16221 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue. [junit4] 2> 6816829 T16221 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync [junit4] 2> ASYNC NEW_CORE C2820 name=collection1 org.apache.solr.core.SolrCore@3eba81f7 url=https://127.0.0.1:53489/l_g/nz/collection1 node=127.0.0.1:53489_l_g%2Fnz C2820_STATE=coll:collection1 core:collection1 props:{state=down, base_url=https://127.0.0.1:53489/l_g/nz, core=collection1, node_name=127.0.0.1:53489_l_g%2Fnz} [junit4] 2> 6816829 T16221 C2820 P53489 oasc.SyncStrategy.sync Sync replicas to https://127.0.0.1:53489/l_g/nz/collection1/ [junit4] 2> 6816830 T16221 C2820 P53489 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me [junit4] 2> 6816831 T16221 C2820 P53489 oasc.SyncStrategy.syncToMe https://127.0.0.1:53489/l_g/nz/collection1/ has no replicas [junit4] 2> 6816834 T16221 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: https://127.0.0.1:53489/l_g/nz/collection1/ shard4 [junit4] 2> 6816834 T16221 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard4 [junit4] 2> 6816842 T16192 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... [junit4] 2> 6816886 T16195 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6817010 T16195 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> 6817011 T16216 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> 6817012 T16202 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> 6817047 T16221 oasc.ZkController.register We are https://127.0.0.1:53489/l_g/nz/collection1/ and leader is https://127.0.0.1:53489/l_g/nz/collection1/ [junit4] 2> 6817048 T16221 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=https://127.0.0.1:53489/l_g/nz [junit4] 2> 6817049 T16221 oasc.ZkController.checkRecovery I am the leader, no recovery necessary [junit4] 2> 6817049 T16221 oasc.ZkController.publish publishing core=collection1 state=active collection=collection1 [junit4] 2> 6817051 T16221 oasc.ZkController.publish numShards not found on descriptor - reading it from system property [junit4] 2> 6817059 T16195 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6817061 T16221 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... [junit4] 2> 6817065 T16192 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... [junit4] 2> 6817069 T16192 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={ [junit4] 2> "operation":"state", [junit4] 2> "state":"active", [junit4] 2> "base_url":"https://127.0.0.1:53489/l_g/nz", [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "node_name":"127.0.0.1:53489_l_g%2Fnz", [junit4] 2> "shard":"shard4", [junit4] 2> "collection":"collection1", [junit4] 2> "numShards":"4", [junit4] 2> "core_node_name":"core_node1"} [junit4] 2> 6817183 T16202 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> 6817184 T16216 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> 6817184 T16195 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> 6819048 T16167 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 2 [junit4] 2> 6819049 T16167 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 6819057 T16167 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] [junit4] 2> 6819058 T16167 oejs.AbstractConnector.doStart Started SslSelectChannelConnector@127.0.0.1:53492 [junit4] 2> 6819061 T16167 oass.SolrDispatchFilter.init SolrDispatchFilter.init() [junit4] 2> 6819062 T16167 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 6819062 T16167 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-004 [junit4] 2> 6819063 T16167 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-004/' [junit4] 2> 6819111 T16167 oasc.ConfigSolr.fromFile Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-004/solr.xml [junit4] 2> 6819179 T16167 oasc.CoreContainer.<init> New CoreContainer 1063564414 [junit4] 2> 6819180 T16167 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-004/] [junit4] 2> 6819181 T16167 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 6819181 T16167 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: [junit4] 2> 6819182 T16167 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 6819182 T16167 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 6819182 T16167 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 6819182 T16167 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 6819183 T16167 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 6819183 T16167 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 6819183 T16167 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 6819187 T16167 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false [junit4] 2> 6819189 T16167 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 6819190 T16167 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 6819190 T16167 oasc.CoreContainer.load Host Name: 127.0.0.1 [junit4] 2> 6819190 T16167 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:53481/solr [junit4] 2> 6819191 T16167 oasc.ZkController.checkChrootPath zkHost includes chroot [junit4] 2> 6819192 T16167 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 6819197 T16232 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@540dd94e name:ZooKeeperConnection Watcher:127.0.0.1:53481 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 6819198 T16167 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 6819203 T16167 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 6819207 T16234 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@3ca830be name:ZooKeeperConnection Watcher:127.0.0.1:53481/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 6819208 T16167 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 6819228 T16167 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 6820240 T16167 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:53492_l_g%2Fnz [junit4] 2> 6820242 T16167 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:53492_l_g%2Fnz [junit4] 2> 6820288 T16236 oasc.ZkController.publish publishing core=collection1 state=down collection=collection1 [junit4] 2> 6820289 T16236 oasc.ZkController.publish numShards not found on descriptor - reading it from system property [junit4] 2> 6820291 T16195 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6820291 T16236 oasc.ZkController.waitForCoreNodeName look for our core node name [junit4] 2> 6820299 T16192 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... [junit4] 2> 6820301 T16192 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={ [junit4] 2> "operation":"state", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:53492/l_g/nz", [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "node_name":"127.0.0.1:53492_l_g%2Fnz", [junit4] 2> "shard":null, [junit4] 2> "collection":"collection1", [junit4] 2> "numShards":"4", [junit4] 2> "core_node_name":null} [junit4] 2> 6820301 T16192 oasc.Overseer$ClusterStateUpdater.updateState Collection already exists with numShards=4 [junit4] 2> 6820301 T16192 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard2 [junit4] 2> 6820314 T16235 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> 6820314 T16195 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> 6820315 T16202 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> 6820317 T16216 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> 6821295 T16236 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1 [junit4] 2> 6821296 T16236 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1 [junit4] 2> 6821298 T16236 oasc.ZkController.createCollectionZkNode Collection zkNode exists [junit4] 2> 6821299 T16236 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1 [junit4] 2> 6821303 T16236 oascc.ZkStateReader.readConfigName path=/collections/collection1 configName=conf1 specified config exists in ZooKeeper [junit4] 2> 6821304 T16236 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-004/collection1/' [junit4] 2> 6821305 T16236 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-004/collection1/lib/.svn/' to classloader [junit4] 2> 6821306 T16236 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-004/collection1/lib/classes/' to classloader [junit4] 2> 6821307 T16236 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-004/collection1/lib/README' to classloader [junit4] 2> 6821384 T16236 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0 [junit4] 2> 6821433 T16236 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 6821436 T16236 oass.IndexSchema.readSchema Reading Solr Schema from managed-schema [junit4] 2> 6821443 T16236 oass.IndexSchema.readSchema [collection1] Schema name=add-schema-fields-update-processor [junit4] 2> 6821502 T16236 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 6821503 T16236 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from collection collection1 [junit4] 2> 6821503 T16236 oasc.SolrCore.initDirectoryFactory solr.NRTCachingDirectoryFactory [junit4] 2> 6821504 T16236 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-004/collection1/, dataDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-004/collection1/data/ [junit4] 2> 6821505 T16236 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1 [junit4] 2> 6821506 T16236 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-004/collection1/data [junit4] 2> 6821507 T16236 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-004/collection1/data/index/ [junit4] 2> 6821508 T16236 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-004/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 6821509 T16236 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-004/collection1/data/index [junit4] 2> 6821510 T16236 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=6, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 6821516 T16236 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-004/collection1/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@530f61c7; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1} [junit4] 2> 6821517 T16236 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 6821520 T16236 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "add-unknown-fields-to-the-schema" [junit4] 2> 6821523 T16236 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 6821525 T16236 oasc.RequestHandlers.initHandlersFromConfig created /update: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 6821525 T16236 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 6821525 T16236 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 6821526 T16236 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 6821526 T16236 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4] 2> 6821526 T16236 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler [junit4] 2> 6821527 T16236 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4] 2> 6821527 T16236 oasc.RequestHandlers.initHandlersFromConfig WARN Multiple requestHandler registered to the same name: /update ignoring: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 6821527 T16236 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler [junit4] 2> 6821528 T16236 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler [junit4] 2> 6821528 T16236 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler [junit4] 2> 6821545 T16236 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 6821548 T16236 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 6821552 T16236 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 6821554 T16236 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 6821556 T16236 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 6821569 T16236 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 6821570 T16236 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 6821573 T16236 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=36, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 6821577 T16236 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-004/collection1/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@530f61c7; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1} [junit4] 2> 6821577 T16236 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 6821578 T16236 oass.SolrIndexSearcher.<init> Opening Searcher@6a62abce[collection1] main [junit4] 2> 6821578 T16236 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1 [junit4] 2> 6821581 T16236 oascc.ZkStateReader.readConfigName path=/collections/collection1 configName=conf1 specified config exists in ZooKeeper [junit4] 2> 6821582 T16236 oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1 [junit4] 2> 6821584 T16236 oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 6821584 T16236 oasr.RestManager.init Initializing RestManager with initArgs: {} [junit4] 2> 6821585 T16236 oasr.ManagedResourceStorage.load Reading _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 6821588 T16236 oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream Read 38 bytes from znode /configs/conf1/_rest_managed.json [junit4] 2> 6821589 T16236 oasr.ManagedResourceStorage.load Loaded LinkedHashMap at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 6821589 T16236 oasr.ManagedResource.reloadFromStorage Loaded initArgs {} for /rest/managed [junit4] 2> 6821589 T16236 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 6821590 T16236 oass.ZkIndexSchemaReader.createSchemaWatcher Creating ZooKeeper watch for the managed schema at /configs/conf1/managed-schema ... [junit4] 2> 6821601 T16237 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6a62abce[collection1] main{UninvertingDirectoryReader()} [junit4] 2> 6821601 T16236 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 6821605 T16240 oasc.ZkController.register Register replica - core:collection1 address:https://127.0.0.1:53492/l_g/nz collection:collection1 shard:shard2 [junit4] 2> 6821606 T16167 oass.SolrDispatchFilter.init user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0 [junit4] 2> 6821606 T16167 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 6821608 T16240 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard2/election [junit4] 2> 6821683 T16240 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard2 [junit4] 2> 6821690 T16240 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue. [junit4] 2> 6821691 T16240 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync [junit4] 2> ASYNC NEW_CORE C2821 name=collection1 org.apache.solr.core.SolrCore@2a881f4b url=https://127.0.0.1:53492/l_g/nz/collection1 node=127.0.0.1:53492_l_g%2Fnz C2821_STATE=coll:collection1 core:collection1 props:{state=down, base_url=https://127.0.0.1:53492/l_g/nz, core=collection1, node_name=127.0.0.1:53492_l_g%2Fnz} [junit4] 2> 6821691 T16240 C2821 P53492 oasc.SyncStrategy.sync Sync replicas to https://127.0.0.1:53492/l_g/nz/collection1/ [junit4] 2> 6821692 T16240 C2821 P53492 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me [junit4] 2> 6821692 T16240 C2821 P53492 oasc.SyncStrategy.syncToMe https://127.0.0.1:53492/l_g/nz/collection1/ has no replicas [junit4] 2> 6821693 T16240 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: https://127.0.0.1:53492/l_g/nz/collection1/ shard2 [junit4] 2> 6821693 T16240 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard2 [junit4] 2> 6821694 T16195 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6821739 T16192 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... [junit4] 2> 6821766 T16195 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6821773 T16195 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> 6821775 T16202 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> 6821778 T16216 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> 6821779 T16235 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> 6821813 T16240 oasc.ZkController.register We are https://127.0.0.1:53492/l_g/nz/collection1/ and leader is https://127.0.0.1:53492/l_g/nz/collection1/ [junit4] 2> 6821814 T16240 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=https://127.0.0.1:53492/l_g/nz [junit4] 2> 6821815 T16240 oasc.ZkController.checkRecovery I am the leader, no recovery necessary [junit4] 2> 6821816 T16240 oasc.ZkController.publish publishing core=collection1 state=active collection=collection1 [junit4] 2> 6821816 T16240 oasc.ZkController.publish numShards not found on descriptor - reading it from system property [junit4] 2> 6821821 T16195 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6821822 T16240 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... [junit4] 2> 6821828 T16192 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... [junit4] 2> 6821831 T16192 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={ [junit4] 2> "operation":"state", [junit4] 2> "state":"active", [junit4] 2> "base_url":"https://127.0.0.1:53492/l_g/nz", [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "node_name":"127.0.0.1:53492_l_g%2Fnz", [junit4] 2> "shard":"shard2", [junit4] 2> "collection":"collection1", [junit4] 2> "numShards":"4", [junit4] 2> "core_node_name":"core_node2"} [junit4] 2> 6821945 T16235 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> 6821946 T16216 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> 6821946 T16202 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> 6821945 T16195 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> 6823937 T16167 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 3 [junit4] 2> 6823938 T16167 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 6823945 T16167 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] [junit4] 2> 6823948 T16167 oejs.AbstractConnector.doStart Started SslSelectChannelConnector@127.0.0.1:53495 [junit4] 2> 6823953 T16167 oass.SolrDispatchFilter.init SolrDispatchFilter.init() [junit4] 2> 6823953 T16167 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 6823954 T16167 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-005 [junit4] 2> 6823955 T16167 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-005/' [junit4] 2> 6823999 T16167 oasc.ConfigSolr.fromFile Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-005/solr.xml [junit4] 2> 6824067 T16167 oasc.CoreContainer.<init> New CoreContainer 320258416 [junit4] 2> 6824068 T16167 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./temp/solr.schema.TestCloudSchemaless-D92DB885BB946A5D-001/tempDir-005/] [junit4] 2> 6824069 T16167 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 6824070 T16167 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: [junit4] 2> 6824071 T16167 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 6824071 T16167 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 6824071 T16167 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 6824071 T16167 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 6824072 T16167 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 6824072 T16167 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 6824072 T16167 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 6824075 T16167 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false [junit4] 2> 6824078 T16167 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 6824078 T16167 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 6824078 T16167 oasc.CoreContainer.load Host Name: 127.0.0.1 [junit4] 2> 6824078 T16167 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:53481/solr [junit4] 2> 6824079 T16167 oasc.ZkController.checkChrootPath zkHost includes chroot [junit4] 2> 6824081 T16167 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 6824085 T16251 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@4670cbb7 name:ZooKeeperConnection Watcher:127.0.0.1:53481 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 6824087 T16167 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 6824094 T16167 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 6824099 T16253 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@2d7a86e9 name:ZooKeeperConnection Watcher:127.0.0.1:53481/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 6824100 T16167 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 6824126 T16167 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 6825137 T16167 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:53495_l_g%2Fnz [junit4] 2> 6825140 T16167 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:53495_l_g%2Fnz [...truncated too long message...] ermsComponentTest, TestQuerySenderListener, TestFieldTypeResource, XsltUpdateRequestHandlerTest, UniqFieldsUpdateProcessorFactoryTest, TestFoldingMultitermQuery, TestCollationField, LeaderElectionIntegrationTest, SignatureUpdateProcessorFactoryTest, ZkSolrClientTest, DistributedDebugComponentTest, TestFastWriter, TestBlendedInfixSuggestions, TestFastOutputStream, UpdateParamsTest, UUIDFieldTest, ParsingFieldUpdateProcessorsTest, TestBadConfig, AlternateDirectoryTest, RankQueryTest, DirectSolrConnectionTest, TestOmitPositions, SpellPossibilityIteratorTest, HdfsBasicDistributedZk2Test, FullSolrCloudDistribCmdsTest, SuggesterTest, TestRecovery, HdfsSyncSliceTest, PreAnalyzedUpdateProcessorTest, TestDistribDocBasedVersion, DistributedExpandComponentTest, MoreLikeThisHandlerTest, SolrPluginUtilsTest, PingRequestHandlerTest, SyncSliceTest, CoreMergeIndexesAdminHandlerTest, ChangedSchemaMergeTest, TestCopyFieldCollectionResource, TestSimpleQParserPlugin, HdfsCollectionsAPIDistributedZkTest, CursorPagingTest, BasicDistributedZk2Test, MultiThreadedOCPTest, TestExpandComponent, TestDFRSimilarityFactory, TestSolr4Spatial, EchoParamsTest, TestHashPartitioner, TestAddFieldRealTimeGet, TestClassNameShortening, DocValuesMissingTest, TestCloudManagedSchemaConcurrent, TestSolrCoreProperties, DistributedIntervalFacetingTest, TestSerializedLuceneMatchVersion, TestTrie, TestSchemaNameResource, TestRTGBase, TestIndexingPerformance, JSONWriterTest, TestPHPSerializedResponseWriter, ChaosMonkeySafeLeaderTest, SSLMigrationTest, TestStressVersions, DistributedSpellCheckComponentTest, SuggesterWFSTTest, TestRequestStatusCollectionAPI, AnalyticsMergeStrategyTest, TestFunctionQuery, XmlUpdateRequestHandlerTest, HdfsBasicDistributedZkTest, TestImplicitCoreProperties, TestSolrQueryParser, StatsComponentTest, TestSolrDeletionPolicy2, TestBM25SimilarityFactory, DocValuesTest, ConnectionManagerTest, TestReplicationHandler, TestIndexSearcher, TestCodecSupport, TestFileDictionaryLookup, BinaryUpdateRequestHandlerTest, TestSchemaResource, MergeStrategyTest, TestAnalyzeInfixSuggestions, HdfsChaosMonkeySafeLeaderTest, SolrCmdDistributorTest, SolrXmlInZkTest, TestDistributedSearch, TestCursorMarkWithoutUniqueKey, CoreAdminRequestStatusTest, QueryFacetTest, ExpressionTest, BlockDirectoryTest, TestDistributedMissingSort, InfoHandlerTest, RequiredFieldsTest, FastVectorHighlighterTest, TestJmxMonitoredMap, SOLR749Test, DocExpirationUpdateProcessorFactoryTest, SolrInfoMBeanTest, StandardRequestHandlerTest, TestComplexPhraseQParserPlugin, TestPartialUpdateDeduplication, TestNRTOpen, SpatialFilterTest, TestFieldResource, EnumFieldTest, TestLeaderElectionZkExpiry, TestFieldTypeCollectionResource, TestBinaryResponseWriter, RollingRestartTest, TestDefaultSimilarityFactory, TestWriterPerf, DOMUtilTest, SuggesterFSTTest, MigrateRouteKeyTest, RegexBoostProcessorTest, HdfsRecoveryZkTest, SpellingQueryConverterTest, SystemInfoHandlerTest, FieldAnalysisRequestHandlerTest, FieldFacetExtrasTest, FileBasedSpellCheckerTest, TestDefaultSearchFieldResource, ScriptEngineTest, RequestHandlersTest, TestConfig, SimplePostToolTest, MBeansHandlerTest, LegacyHTMLStripCharFilterTest, StatelessScriptUpdateProcessorFactoryTest, TestInitQParser, TestReRankQParserPlugin, TestPhraseSuggestions, TestCollapseQParserPlugin, SampleTest, TestOrdValues, HighlighterConfigTest, TestPseudoReturnFields, TestRandomDVFaceting, TestFiltering, BlockCacheTest, TestStressReorder, CollectionsAPIAsyncDistributedZkTest, DeleteReplicaTest, TestLMDirichletSimilarityFactory, SuggesterTSTTest, SolrRequestParserTest, OverseerRolesTest, DateFieldTest, RecoveryZkTest, TestFastLRUCache, QueryEqualityTest, BasicFunctionalityTest, TestZkChroot, FileUtilsTest, TestFieldCollectionResource, TestRecoveryHdfs, PreAnalyzedFieldTest, TestJmxIntegration, TestQueryTypes, TestMaxScoreQueryParser, TestStressRecovery, TestManagedResourceStorage, ClusterStateUpdateTest, TestArbitraryIndexDir, AsyncMigrateRouteKeyTest, ModifyConfFileTest, TestSystemIdResolver, TestModifyConfFiles, RemoteQueryErrorTest, AddBlockUpdateTest, AnalysisAfterCoreReloadTest, TestSolrXml, HardAutoCommitTest, TestCustomSort, SuggestComponentTest, PrimUtilsTest, PeerSyncTest, TestCoreContainer, TestIBSimilarityFactory, TestChildDocTransformer, CircularListTest, HdfsDirectoryTest, ChaosMonkeyNothingIsSafeTest, ZkCLITest, TestDocSet, SynonymTokenizerTest, BasicDistributedZkTest, UnloadDistributedZkTest, CollectionsAPIDistributedZkTest, OpenCloseCoreStressTest, OverseerTest, ShardRoutingTest, BasicZkTest, TestRandomFaceting, LeaderElectionTest, ShardRoutingCustomTest, AutoCommitTest, TestDistributedGrouping, TestFaceting, TermVectorComponentDistributedTest, ZkControllerTest, TestRealTimeGet, TestJoin, TestMultiCoreConfBootstrap, TestReload, TestRangeQuery, SimpleFacetsTest, SolrCoreTest, SpellCheckComponentTest, TestGroupingSearch, QueryElevationComponentTest, BadIndexSchemaTest, ConvertedLegacyTest, TestSort, TestLazyCores, DirectUpdateHandlerTest, HighlighterTest, SoftAutoCommitTest, ShowFileRequestHandlerTest, CurrencyFieldOpenExchangeTest, DistributedQueryElevationComponentTest, CurrencyFieldXmlFileTest, SolrIndexSplitterTest, TestCoreDiscovery, TestExtendedDismaxParser, SpellCheckCollatorTest, CoreAdminHandlerTest, TestStressLucene, TestCSVLoader, PolyFieldTest, NoCacheHeaderTest, WordBreakSolrSpellCheckerTest, SchemaVersionSpecificBehaviorTest, SolrCoreCheckLockOnStartupTest, TestUpdate, FieldMutatingUpdateProcessorTest, TestAtomicUpdateErrorCases, TestWordDelimiterFilterFactory, DirectUpdateHandlerOptimizeTest, DefaultValueUpdateProcessorTest, SortByFunctionTest, TestRemoteStreaming, DocValuesMultiTest, DistanceFunctionTest, TestSolrDeletionPolicy1, DebugComponentTest, CacheHeaderTest, IndexBasedSpellCheckerTest, TestSurroundQueryParser, LukeRequestHandlerTest, DisMaxRequestHandlerTest, TestQueryUtils, DirectSolrSpellCheckerTest, TestReversedWildcardFilterFactory, DocumentAnalysisRequestHandlerTest, TermsComponentTest, DocumentBuilderTest, TestValueSourceCache, PathHierarchyTokenizerFactoryTest, TermVectorComponentTest, IndexSchemaRuntimeFieldTest, LoggingHandlerTest, IndexSchemaTest, ReturnFieldsTest, UpdateRequestProcessorFactoryTest, TestCSVResponseWriter, TestAnalyzedSuggestions, JsonLoaderTest, CSVRequestHandlerTest, TestComponentsName, SearchHandlerTest, CoreContainerCoreInitFailuresTest, TestLFUCache, TestSolrIndexConfig, TestQuerySenderNoQuery, CopyFieldTest, ResponseLogComponentTest, SolrIndexConfigTest, BadComponentTest, TestMergePolicyConfig, MultiTermTest, TestBinaryField, TestSearchPerf, NumericFieldsTest, MinimalSchemaTest, OutputWriterTest, TestFuzzyAnalyzedSuggestions, ExternalFileFieldSortTest, TestPostingsSolrHighlighter, NotRequiredUniqueKeyTest, TestLuceneMatchVersion, TestCharFilters, TestXIncludeConfig, TestPerFieldSimilarity, TestLMJelinekMercerSimilarityFactory, TimeZoneUtilsTest, ResourceLoaderTest, OpenExchangeRatesOrgProviderTest, URLClassifyProcessorTest, PluginInfoTest, TestSuggestSpellingConverter, RAMDirectoryFactoryTest, ClusterStateTest, TestSolrJ, TestLRUCache, TestUtils, TestDocumentBuilder, ZkNodePropsTest, SliceStateTest, SolrTestCaseJ4Test, TestHighlightDedupGrouping, TestTolerantSearch, AbstractAnalyticsStatsTest, NoFacetTest, AbstractAnalyticsFacetTest, RangeFacetTest, FunctionTest, AliasIntegrationTest, AssignTest, CustomCollectionTest, DeleteInactiveReplicaTest, DeleteShardTest, DistribCursorPagingTest, DistribDocExpirationUpdateProcessorTest, HttpPartitionTest, OverseerStatusTest, ReplicationFactorTest, ShardSplitTest, TestCloudInspectUtil, TestCollectionAPI, TestMiniSolrCloudCluster, TestShortCircuitedRequests, TriLevelCompositeIdRoutingTest, HdfsUnloadDistributedZkTest, HdfsWriteToMultipleCollectionsTest, StressHdfsTest, CachingDirectoryFactoryTest, QueryResultKeyTest, TestConfigSets, TestInfoStreamLogging, TestNonNRTOpen, TestReloadAndDeleteDocs, TestShardHandlerFactory, TestSolrXmlPersistence, TestSolrXmlPersistor, TestReplicationHandlerBackup, CoreAdminCreateDiscoverTest, DistributedQueryComponentCustomSortTest, DistributedQueryComponentOptimizationTest, DistributedSuggestComponentTest, TestIntervalFaceting, TestManagedResource, TestDynamicFieldCollectionResource, TestDynamicFieldResource, TestManagedSchemaFieldResource, TestSchemaSimilarityResource, TestSolrQueryParserDefaultOperatorResource, TestUniqueKeyFieldResource, TestManagedStopFilterFactory, TestManagedSynonymFilterFactory, BadCopyFieldTest, DateRangeFieldTest, TestCloudManagedSchema, TestCloudSchemaless] [junit4] Completed in 173.74s, 1 test, 1 error <<< FAILURES! [...truncated 78 lines...] BUILD FAILED /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:474: The following error occurred while executing this line: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:454: The following error occurred while executing this line: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:45: The following error occurred while executing this line: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/extra-targets.xml:37: The following error occurred while executing this line: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build.xml:189: The following error occurred while executing this line: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/common-build.xml:496: The following error occurred while executing this line: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:1298: The following error occurred while executing this line: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:922: There were test failures: 421 suites, 1761 tests, 1 error, 44 ignored (17 assumptions) Total time: 164 minutes 21 seconds Build step 'Invoke Ant' marked build as failure [description-setter] Description set: Java: 64bit/jdk1.7.0 -XX:+UseCompressedOops -XX:+UseParallelGC Archiving artifacts Recording test results Email was triggered for: Failure - Any Sending email for trigger: Failure - Any
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org